Jan 12 16:31:12 volumio volumio-remote-updater[783]: [2026-01-12 16:31:12] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Jan 12 16:31:17 volumio volumio-remote-updater[783]: [2026-01-12 16:31:17] [connect] Successful connection Jan 12 16:31:25 volumio volumio[1283]: info: Checking if install.sh is present Jan 12 16:31:25 volumio volumio[1283]: info: Executing install.sh Jan 12 16:31:25 volumio sudo[8158]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/now_playing/install.sh Jan 12 16:31:25 volumio sudo[8158]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 12 16:31:25 volumio volumio[1283]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jan 12 16:31:25 volumio volumio[1283]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jan 12 16:31:25 volumio volumio[1283]: info: Installing geo-tz node dependency Jan 12 16:31:25 volumio su[8161]: (to volumio) root on none Jan 12 16:31:25 volumio su[8161]: pam_unix(su:session): session opened for user volumio(uid=1000) by (uid=0) Jan 12 16:31:25 volumio systemd[1]: Created slice user-1000.slice - User Slice of UID 1000. Jan 12 16:31:25 volumio systemd[1]: Starting user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... Jan 12 16:31:25 volumio systemd[1]: Finished user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. Jan 12 16:31:25 volumio systemd[1]: Starting user@1000.service - User Manager for UID 1000... Jan 12 16:31:25 volumio (systemd)[8163]: pam_unix(systemd-user:session): session opened for user volumio(uid=1000) by (uid=0) Jan 12 16:31:26 volumio volumio[1283]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jan 12 16:31:26 volumio volumio[1283]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jan 12 16:31:26 volumio systemd[8163]: Queued start job for default target default.target. Jan 12 16:31:26 volumio volumio[1283]: verbose: New Socket.io Connection to 192.168.123.142 from 192.168.123.118 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Edg/143.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:26 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:26 volumio systemd[8163]: Created slice app.slice - User Application Slice. Jan 12 16:31:26 volumio systemd[8163]: Reached target paths.target - Paths. Jan 12 16:31:26 volumio systemd[8163]: Reached target timers.target - Timers. Jan 12 16:31:26 volumio systemd[8163]: Starting dbus.socket - D-Bus User Message Bus Socket... Jan 12 16:31:26 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:26 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:26 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:26 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:26 volumio systemd[8163]: Listening on dirmngr.socket - GnuPG network certificate management daemon. Jan 12 16:31:26 volumio systemd[8163]: Listening on gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Jan 12 16:31:26 volumio systemd[8163]: Listening on gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Jan 12 16:31:26 volumio systemd[8163]: Listening on gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Jan 12 16:31:26 volumio systemd[8163]: Listening on gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Jan 12 16:31:26 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:26 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:26 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:26 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::volumioGetVisibleSources Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:26 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:26 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 12 16:31:26 volumio systemd[8163]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jan 12 16:31:26 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:26 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:26 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:26 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:26 volumio systemd[8163]: Reached target sockets.target - Sockets. Jan 12 16:31:26 volumio systemd[8163]: Reached target basic.target - Basic System. Jan 12 16:31:26 volumio systemd[1]: Started user@1000.service - User Manager for UID 1000. Jan 12 16:31:26 volumio systemd[8163]: Started mpris-proxy.service - Bluetooth mpris proxy. Jan 12 16:31:26 volumio volumio[1283]: info: Listing playlists Jan 12 16:31:26 volumio volumio[1283]: info: CoreCommandRouter::volumioGetQueue Jan 12 16:31:26 volumio volumio[1283]: info: CoreStateMachine::getQueue Jan 12 16:31:26 volumio volumio[1283]: info: CorePlayQueue::getQueue Jan 12 16:31:26 volumio systemd[1]: Started session-c1.scope - Session c1 of User volumio. Jan 12 16:31:26 volumio systemd[8163]: Reached target default.target - Main User Target. Jan 12 16:31:26 volumio systemd[8163]: Startup finished in 923ms. Jan 12 16:31:26 volumio systemd[8163]: Created slice session.slice - User Core Session Slice. Jan 12 16:31:26 volumio systemd[8163]: Starting dbus.service - D-Bus User Message Bus... Jan 12 16:31:26 volumio systemd[8163]: Started dbus.service - D-Bus User Message Bus. Jan 12 16:31:27 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:27 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:27 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetVisibleSources Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 12 16:31:27 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:27 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: Listing playlists Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetQueue Jan 12 16:31:27 volumio volumio[1283]: info: CoreStateMachine::getQueue Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getQueue Jan 12 16:31:27 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:27 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:27 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetVisibleSources Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 12 16:31:27 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:27 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: Listing playlists Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetQueue Jan 12 16:31:27 volumio volumio[1283]: info: CoreStateMachine::getQueue Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getQueue Jan 12 16:31:27 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:27 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:27 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetVisibleSources Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 12 16:31:27 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:27 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:27 volumio volumio[1283]: info: Listing playlists Jan 12 16:31:27 volumio volumio[1283]: info: CoreCommandRouter::volumioGetQueue Jan 12 16:31:27 volumio volumio[1283]: info: CoreStateMachine::getQueue Jan 12 16:31:27 volumio volumio[1283]: info: CorePlayQueue::getQueue Jan 12 16:31:28 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:28 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:28 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetVisibleSources Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 12 16:31:28 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:28 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: Listing playlists Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetQueue Jan 12 16:31:28 volumio volumio[1283]: info: CoreStateMachine::getQueue Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getQueue Jan 12 16:31:28 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:28 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:28 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 12 16:31:28 volumio volumio[1283]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jan 12 16:31:28 volumio volumio[1283]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetVisibleSources Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 12 16:31:28 volumio volumio[1283]: info: Received Get System Info Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:31:28 volumio volumio[1283]: info: Discovery: Getting this device information Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:28 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:28 volumio volumio[1283]: info: Listing playlists Jan 12 16:31:28 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 12 16:31:29 volumio volumio-remote-updater[783]: [2026-01-12 16:31:29] [connect] Successful connection Jan 12 16:31:30 volumio volumio-remote-updater[783]: [2026-01-12 16:31:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1768203089 101 Jan 12 16:31:30 volumio volumio[1283]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 8 Jan 12 16:31:42 volumio volumio[1283]: info: Enabling plugin now_playing Jan 12 16:31:42 volumio volumio[1283]: info: Loading plugin "now_playing"... Jan 12 16:31:42 volumio volumio[1283]: error: !!!! WARNING !!!! Jan 12 16:31:42 volumio volumio[1283]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module 'geo-tz' Jan 12 16:31:42 volumio volumio[1283]: Require stack: Jan 12 16:31:42 volumio volumio[1283]: - /data/plugins/user_interface/now_playing/dist/index.js Jan 12 16:31:42 volumio volumio[1283]: - /volumio/app/pluginmanager.js Jan 12 16:31:42 volumio volumio[1283]: - /volumio/app/index.js Jan 12 16:31:42 volumio volumio[1283]: - /volumio/index.js Jan 12 16:31:42 volumio volumio[1283]: error: Stack trace: Error: Cannot find module 'geo-tz' Jan 12 16:31:42 volumio volumio[1283]: Require stack: Jan 12 16:31:42 volumio volumio[1283]: - /data/plugins/user_interface/now_playing/dist/index.js Jan 12 16:31:42 volumio volumio[1283]: - /volumio/app/pluginmanager.js Jan 12 16:31:42 volumio volumio[1283]: - /volumio/app/index.js Jan 12 16:31:42 volumio volumio[1283]: - /volumio/index.js Jan 12 16:31:42 volumio volumio[1283]: at Module._resolveFilename (node:internal/modules/cjs/loader:1048:15) Jan 12 16:31:42 volumio volumio[1283]: at Module._load (node:internal/modules/cjs/loader:901:27) Jan 12 16:31:42 volumio volumio[1283]: at Module.require (node:internal/modules/cjs/loader:1115:19) Jan 12 16:31:42 volumio volumio[1283]: at require (node:internal/modules/helpers:130:18) Jan 12 16:31:42 volumio volumio[1283]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34) Jan 12 16:31:42 volumio volumio[1283]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Jan 12 16:31:42 volumio volumio[1283]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Jan 12 16:31:42 volumio volumio[1283]: at Module.load (node:internal/modules/cjs/loader:1091:32) Jan 12 16:31:42 volumio volumio[1283]: at Module._load (node:internal/modules/cjs/loader:938:12) Jan 12 16:31:42 volumio volumio[1283]: at Module.require (node:internal/modules/cjs/loader:1115:19) Jan 12 16:31:42 volumio volumio[1283]: at require (node:internal/modules/helpers:130:18) Jan 12 16:31:42 volumio volumio[1283]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Jan 12 16:31:42 volumio volumio[1283]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jan 12 16:31:42 volumio volumio[1283]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 12 16:31:42 volumio volumio[1283]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Jan 12 16:31:42 volumio volumio[1283]: error: !!!! WARNING !!!! Jan 12 16:31:42 volumio volumio[1283]: info: Done. Jan 12 16:31:54 volumio volumio[1283]: info: CoreCommandRouter::volumioGetState Jan 12 16:31:54 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:56 volumio volumio[1283]: info: CoreCommandRouter::volumioPlay Jan 12 16:31:56 volumio volumio[1283]: info: CoreStateMachine::play index undefined Jan 12 16:31:56 volumio volumio[1283]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 12 16:31:56 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:56 volumio volumio[1283]: info: CoreStateMachine::startPlaybackTimer Jan 12 16:31:56 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:56 volumio volumio[1283]: info: ControllerMpd::resume Jan 12 16:31:56 volumio volumio[1283]: verbose: ControllerMpd::sendMpdCommand play Jan 12 16:31:56 volumio volumio[1283]: info: sendMpdCommand play took 6 milliseconds Jan 12 16:31:56 volumio volumio[1283]: info: Jan 12 16:31:56 volumio volumio[1283]: ---------------------------- MPD announces state update: player Jan 12 16:31:56 volumio volumio[1283]: info: ControllerMpd::getState Jan 12 16:31:56 volumio volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Jan 12 16:31:56 volumio volumio[1283]: info: Jan 12 16:31:56 volumio volumio[1283]: ---------------------------- MPD announces state update: player Jan 12 16:31:56 volumio volumio[1283]: info: ControllerMpd::getState Jan 12 16:31:56 volumio volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Jan 12 16:31:56 volumio volumio[1283]: info: Jan 12 16:31:56 volumio volumio[1283]: ---------------------------- MPD announces state update: player Jan 12 16:31:56 volumio volumio[1283]: info: ControllerMpd::getState Jan 12 16:31:56 volumio volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Jan 12 16:31:56 volumio volumio[1283]: info: sendMpdCommand status took 3 milliseconds Jan 12 16:31:56 volumio volumio[1283]: info: sendMpdCommand status took 3 milliseconds Jan 12 16:31:56 volumio kernel: bcm2835-i2s fe203000.i2s: I2S SYNC error! Jan 12 16:31:56 volumio volumio[1283]: verbose: ControllerMpd::parseState Jan 12 16:31:56 volumio volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 16:31:56 volumio volumio[1283]: verbose: ControllerMpd::parseState Jan 12 16:31:56 volumio volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 16:31:56 volumio volumio[1283]: info: sendMpdCommand status took 5 milliseconds Jan 12 16:31:56 volumio volumio[1283]: verbose: ControllerMpd::parseState Jan 12 16:31:56 volumio volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 16:31:56 volumio volumio[1283]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 12 16:31:56 volumio volumio[1283]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 12 16:31:56 volumio volumio[1283]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 12 16:31:56 volumio volumio[1283]: verbose: ControllerMpd::parseTrackInfo Jan 12 16:31:56 volumio volumio[1283]: verbose: ControllerMpd::parseTrackInfo Jan 12 16:31:56 volumio volumio[1283]: verbose: ControllerMpd::parseTrackInfo Jan 12 16:31:56 volumio volumio[1283]: info: ControllerMpd::pushState Jan 12 16:31:56 volumio volumio[1283]: info: CoreCommandRouter::servicePushState Jan 12 16:31:56 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:56 volumio volumio[1283]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1765,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"875 Kbps","isStreaming":false,"title":"Don’t you see!","artist":"ZARD","album":"ZARD Forever Best〜25th Anniversary〜","uri":"USB/Transcend/ZARD/ZARD Forever Best〜25th Anniversary〜/1.01. Don’t you see!.flac","trackType":"flac"} Jan 12 16:31:56 volumio volumio[1283]: verbose: CURRENT POSITION 0 Jan 12 16:31:56 volumio volumio[1283]: info: CoreStateMachine::syncState stateService play Jan 12 16:31:56 volumio volumio[1283]: info: CoreStateMachine::syncState currentStatus pause Jan 12 16:31:56 volumio volumio[1283]: info: CoreStateMachine::pushState Jan 12 16:31:56 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:56 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:31:56 volumio volumio[1283]: info: CoreCommandRouter::volumioPushState Jan 12 16:31:56 volumio volumio[1283]: info: ControllerMpd::pushState Jan 12 16:31:56 volumio volumio[1283]: info: CoreCommandRouter::servicePushState Jan 12 16:31:56 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:56 volumio volumio[1283]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1765,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"875 Kbps","isStreaming":false,"title":"Don’t you see!","artist":"ZARD","album":"ZARD Forever Best〜25th Anniversary〜","uri":"USB/Transcend/ZARD/ZARD Forever Best〜25th Anniversary〜/1.01. Don’t you see!.flac","trackType":"flac"} Jan 12 16:31:56 volumio volumio[1283]: verbose: CURRENT POSITION 0 Jan 12 16:31:56 volumio volumio[1283]: info: CoreStateMachine::syncState stateService play Jan 12 16:31:56 volumio volumio[1283]: info: CoreStateMachine::syncState currentStatus play Jan 12 16:31:56 volumio volumio[1283]: info: Received an update from plugin. extracting info from payload Jan 12 16:31:56 volumio volumio[1283]: info: CoreStateMachine::pushState Jan 12 16:31:56 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:56 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:31:56 volumio volumio[1283]: info: CoreCommandRouter::volumioPushState Jan 12 16:31:56 volumio volumio[1283]: info: ControllerMpd::pushState Jan 12 16:31:56 volumio volumio[1283]: info: CoreCommandRouter::servicePushState Jan 12 16:31:56 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:56 volumio volumio[1283]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1765,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"875 Kbps","isStreaming":false,"title":"Don’t you see!","artist":"ZARD","album":"ZARD Forever Best〜25th Anniversary〜","uri":"USB/Transcend/ZARD/ZARD Forever Best〜25th Anniversary〜/1.01. Don’t you see!.flac","trackType":"flac"} Jan 12 16:31:56 volumio volumio[1283]: verbose: CURRENT POSITION 0 Jan 12 16:31:56 volumio volumio[1283]: info: CoreStateMachine::syncState stateService play Jan 12 16:31:56 volumio volumio[1283]: info: CoreStateMachine::syncState currentStatus play Jan 12 16:31:56 volumio volumio[1283]: info: Received an update from plugin. extracting info from payload Jan 12 16:31:56 volumio volumio[1283]: info: CoreStateMachine::pushState Jan 12 16:31:56 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:31:56 volumio volumio[1283]: info: CoreCommandRouter::volumioPushState Jan 12 16:31:56 volumio volumio[1283]: error: ControllerMpd::pushError: TypeError: Cannot read properties of null (reading 'pushState') Jan 12 16:31:56 volumio volumio[1283]: error: ControllerMpd::pushError: TypeError: Cannot read properties of null (reading 'pushState') Jan 12 16:31:56 volumio volumio[1283]: error: ControllerMpd::pushError: TypeError: Cannot read properties of null (reading 'pushState') Jan 12 16:31:56 volumio volumio[1283]: info: ------------------------------ 39ms Jan 12 16:31:56 volumio volumio[1283]: info: ------------------------------ 37ms Jan 12 16:31:56 volumio volumio[1283]: info: ------------------------------ 36ms Jan 12 16:32:12 volumio volumio[1283]: info: CoreCommandRouter::volumioPause Jan 12 16:32:12 volumio volumio[1283]: info: CoreStateMachine::pause Jan 12 16:32:12 volumio volumio[1283]: info: CoreStateMachine::stPlaybackTimer Jan 12 16:32:12 volumio volumio[1283]: info: CoreStateMachine::servicePause Jan 12 16:32:12 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:32:12 volumio volumio[1283]: info: CoreCommandRouter::servicePause Jan 12 16:32:12 volumio volumio[1283]: info: ControllerMpd::pause Jan 12 16:32:12 volumio volumio[1283]: verbose: ControllerMpd::sendMpdCommand pause Jan 12 16:32:12 volumio volumio[1283]: info: Jan 12 16:32:12 volumio volumio[1283]: ---------------------------- MPD announces state update: player Jan 12 16:32:12 volumio volumio[1283]: info: sendMpdCommand pause took 3 milliseconds Jan 12 16:32:12 volumio volumio[1283]: info: ControllerMpd::getState Jan 12 16:32:12 volumio volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Jan 12 16:32:12 volumio volumio[1283]: info: Jan 12 16:32:12 volumio volumio[1283]: ---------------------------- MPD announces state update: player Jan 12 16:32:12 volumio volumio[1283]: info: ControllerMpd::getState Jan 12 16:32:12 volumio volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Jan 12 16:32:12 volumio volumio[1283]: info: Jan 12 16:32:12 volumio volumio[1283]: ---------------------------- MPD announces state update: player Jan 12 16:32:12 volumio volumio[1283]: info: ControllerMpd::getState Jan 12 16:32:12 volumio volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Jan 12 16:32:12 volumio volumio[1283]: info: sendMpdCommand status took 4 milliseconds Jan 12 16:32:12 volumio volumio[1283]: info: sendMpdCommand status took 3 milliseconds Jan 12 16:32:12 volumio volumio[1283]: verbose: ControllerMpd::parseState Jan 12 16:32:12 volumio volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 16:32:12 volumio volumio[1283]: verbose: ControllerMpd::parseState Jan 12 16:32:12 volumio volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 16:32:12 volumio volumio[1283]: info: sendMpdCommand status took 4 milliseconds Jan 12 16:32:12 volumio volumio[1283]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 12 16:32:12 volumio volumio[1283]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 12 16:32:12 volumio volumio[1283]: verbose: ControllerMpd::parseState Jan 12 16:32:12 volumio volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 16:32:12 volumio volumio[1283]: verbose: ControllerMpd::parseTrackInfo Jan 12 16:32:12 volumio volumio[1283]: verbose: ControllerMpd::parseTrackInfo Jan 12 16:32:12 volumio volumio[1283]: info: ControllerMpd::pushState Jan 12 16:32:12 volumio volumio[1283]: info: CoreCommandRouter::servicePushState Jan 12 16:32:12 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:32:12 volumio volumio[1283]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1765,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"875 Kbps","isStreaming":false,"title":"Don’t you see!","artist":"ZARD","album":"ZARD Forever Best〜25th Anniversary〜","uri":"USB/Transcend/ZARD/ZARD Forever Best〜25th Anniversary〜/1.01. Don’t you see!.flac","trackType":"flac"} Jan 12 16:32:12 volumio volumio[1283]: verbose: CURRENT POSITION 0 Jan 12 16:32:12 volumio volumio[1283]: info: CoreStateMachine::syncState stateService pause Jan 12 16:32:12 volumio volumio[1283]: info: CoreStateMachine::syncState currentStatus pause Jan 12 16:32:12 volumio volumio[1283]: info: CoreStateMachine::pushState Jan 12 16:32:12 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:32:12 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:32:12 volumio volumio[1283]: info: CoreCommandRouter::volumioPushState Jan 12 16:32:12 volumio volumio[1283]: info: ControllerMpd::pushState Jan 12 16:32:12 volumio volumio[1283]: info: CoreCommandRouter::servicePushState Jan 12 16:32:12 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:32:12 volumio volumio[1283]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1765,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"875 Kbps","isStreaming":false,"title":"Don’t you see!","artist":"ZARD","album":"ZARD Forever Best〜25th Anniversary〜","uri":"USB/Transcend/ZARD/ZARD Forever Best〜25th Anniversary〜/1.01. Don’t you see!.flac","trackType":"flac"} Jan 12 16:32:12 volumio volumio[1283]: verbose: CURRENT POSITION 0 Jan 12 16:32:12 volumio volumio[1283]: info: CoreStateMachine::syncState stateService pause Jan 12 16:32:12 volumio volumio[1283]: info: CoreStateMachine::syncState currentStatus pause Jan 12 16:32:12 volumio volumio[1283]: info: CoreStateMachine::pushState Jan 12 16:32:12 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:32:12 volumio volumio[1283]: info: CoreCommandRouter::volumioPushState Jan 12 16:32:12 volumio volumio[1283]: error: ControllerMpd::pushError: TypeError: Cannot read properties of null (reading 'pushState') Jan 12 16:32:12 volumio volumio[1283]: error: ControllerMpd::pushError: TypeError: Cannot read properties of null (reading 'pushState') Jan 12 16:32:12 volumio volumio[1283]: info: ------------------------------ 26ms Jan 12 16:32:12 volumio volumio[1283]: info: ------------------------------ 24ms Jan 12 16:32:12 volumio volumio[1283]: info: sendMpdCommand playlistinfo took 18 milliseconds Jan 12 16:32:12 volumio volumio[1283]: verbose: ControllerMpd::parseTrackInfo Jan 12 16:32:12 volumio volumio[1283]: info: ControllerMpd::pushState Jan 12 16:32:12 volumio volumio[1283]: info: CoreCommandRouter::servicePushState Jan 12 16:32:12 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:32:12 volumio volumio[1283]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1765,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"875 Kbps","isStreaming":false,"title":"Don’t you see!","artist":"ZARD","album":"ZARD Forever Best〜25th Anniversary〜","uri":"USB/Transcend/ZARD/ZARD Forever Best〜25th Anniversary〜/1.01. Don’t you see!.flac","trackType":"flac"} Jan 12 16:32:12 volumio volumio[1283]: verbose: CURRENT POSITION 0 Jan 12 16:32:12 volumio volumio[1283]: info: CoreStateMachine::syncState stateService pause Jan 12 16:32:12 volumio volumio[1283]: info: CoreStateMachine::syncState currentStatus pause Jan 12 16:32:12 volumio volumio[1283]: info: CoreStateMachine::pushState Jan 12 16:32:12 volumio volumio[1283]: info: CorePlayQueue::getTrack 0 Jan 12 16:32:12 volumio volumio[1283]: info: CoreCommandRouter::volumioPushState Jan 12 16:32:12 volumio volumio[1283]: error: ControllerMpd::pushError: TypeError: Cannot read properties of null (reading 'pushState') Jan 12 16:32:12 volumio volumio[1283]: info: ------------------------------ 35ms Jan 12 16:32:12 volumio volumio[1283]: info: touch_display: Setting screensaver timeout to 120 seconds. Jan 12 16:32:12 volumio volumio[1283]: info: touch_display: Setting screensaver timeout to 120 seconds. Jan 12 16:32:14 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 12 16:32:14 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 12 16:32:18 volumio volumio[1283]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 16:32:21 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 12 16:32:21 volumio volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 12 16:32:27 volumio volumio[1283]: info: Jan 12 16:32:27 volumio volumio[1283]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 16:32:27 volumio volumio[1283]: TypeError: Cannot read properties of null (reading 'broadcastMessage') Jan 12 16:32:27 volumio volumio[1283]: at /volumio/app/index.js:1534:32 Jan 12 16:32:27 volumio volumio[1283]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Jan 12 16:32:27 volumio volumio[1283]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Jan 12 16:32:27 volumio volumio[1283]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1532:13) Jan 12 16:32:27 volumio volumio[1283]: at PluginManager.pushMessage (/volumio/app/pluginmanager.js:1594:20) Jan 12 16:32:27 volumio volumio[1283]: at Tail. (/volumio/app/pluginmanager.js:860:24) Jan 12 16:32:27 volumio volumio[1283]: at Tail.emit (node:events:514:28) Jan 12 16:32:27 volumio volumio[1283]: at ReadStream. (/volumio/node_modules/tail/lib/tail.js:51:33) Jan 12 16:32:27 volumio volumio[1283]: at ReadStream.emit (node:events:514:28) Jan 12 16:32:27 volumio volumio[1283]: at addChunk (node:internal/streams/readable:343:12) Jan 12 16:32:27 volumio volumio[1283]: at readableAddChunk (node:internal/streams/readable:312:11) Jan 12 16:32:27 volumio volumio[1283]: at Readable.push (node:internal/streams/readable:253:10) Jan 12 16:32:27 volumio volumio[1283]: at node:internal/fs/streams:275:14 Jan 12 16:32:27 volumio volumio[1283]: at FSReqCallback.wrapper [as oncomplete] (node:fs:701:5) Jan 12 16:32:27 volumio volumio[1283]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 16:32:28 volumio sudo[8357]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-12 16:31' Jan 12 16:32:28 volumio sudo[8357]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"