Feb 26 20:42:03 room volumio[1245]: info: CALLMETHOD: user_interface peppymeterbasic savepeppy [object Object] Feb 26 20:42:03 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , savepeppy Feb 26 20:42:03 room volumio[1245]: aaaaaaaaaaa 1920,480_Gelo5 Spec&Met_520 Feb 26 20:42:03 room volumio[1245]: info: PeppyMeterBasic ---1920480_Gelo5 Spec&Met_520 Feb 26 20:42:03 room volumio[1245]: info: PeppyMeterBasic ---1920480NaN Feb 26 20:42:03 room volumio[1245]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Feb 26 20:42:04 room volumio[1245]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 20:42:04 room volumio[1245]: info: CoreCommandRouter::Close All Modals sent Feb 26 20:42:07 room volumio[1245]: info: CALLMETHOD: user_interface peppymeterbasic savepeppy [object Object] Feb 26 20:42:07 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , savepeppy Feb 26 20:42:07 room volumio[1245]: aaaaaaaaaaa 1920,480_Gelo5 Spec&Met_520 Feb 26 20:42:07 room volumio[1245]: info: PeppyMeterBasic ---1920480_Gelo5 Spec&Met_520 Feb 26 20:42:07 room volumio[1245]: info: PeppyMeterBasic ---1920480NaN Feb 26 20:42:07 room volumio[1245]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Feb 26 20:42:07 room volumio[1245]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 20:42:07 room volumio[1245]: info: CoreCommandRouter::Close All Modals sent Feb 26 20:42:11 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 26 20:42:11 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 26 20:42:15 room volumio[1245]: info: Stopping peppymeterbasic service Feb 26 20:42:15 room volumio[1245]: info: CoreStateMachine::stop Feb 26 20:42:15 room volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 20:42:15 room volumio[1245]: info: CoreStateMachine::stPlaybackTimer Feb 26 20:42:15 room volumio[1245]: info: CoreStateMachine::updateTrackBlock Feb 26 20:42:15 room volumio[1245]: info: CorePlayQueue::getTrackBlock Feb 26 20:42:15 room volumio[1245]: info: CoreStateMachine::pushState Feb 26 20:42:15 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:15 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:42:15 room volumio[1245]: info: CoreCommandRouter::volumioPushState Feb 26 20:42:15 room volumio[1245]: info: CoreStateMachine::serviceStop Feb 26 20:42:15 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:15 room volumio[1245]: info: CoreCommandRouter::serviceStop Feb 26 20:42:15 room volumio[1245]: info: [1772106135086] ControllerWebradio::stop Feb 26 20:42:15 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand stop Feb 26 20:42:15 room volumio5-onboarding[1611]: time=2026-02-26T20:42:15.096+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" state=STATUS_STOPPED positionMs=0 volume=25 Feb 26 20:42:15 room volumio5-onboarding[1611]: time=2026-02-26T20:42:15.099+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:42:15 room volumio[1245]: info: Disabling plugin peppymeterbasic Feb 26 20:42:15 room volumio[1245]: info: Preparing to generate the ALSA configuration file Feb 26 20:42:15 room volumio[1245]: info: PeppyMeterBasic ---peppymeterbasic status stop Feb 26 20:42:15 room sudo[3172]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Feb 26 20:42:15 room sudo[3172]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:15 room volumio[1245]: info: Asound.conf file written Feb 26 20:42:15 room sudo[3179]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 26 20:42:15 room sudo[3179]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:15 room systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Feb 26 20:42:15 room sudo[3179]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:15 room volumio[1245]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Feb 26 20:42:15 room volumio[1245]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Feb 26 20:42:15 room volumio[1245]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Feb 26 20:42:15 room volumio[1245]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 Feb 26 20:42:15 room volumio[1245]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 Feb 26 20:42:15 room volumio[1245]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 Feb 26 20:42:15 room volumio[1245]: Found hardware: "Loopback" "Loopback Mixer" "" "" "" Feb 26 20:42:15 room volumio[1245]: Hardware is initialized using a generic method Feb 26 20:42:15 room volumio[1245]: info: Output device has changed, restarting MPD Feb 26 20:42:15 room volumio[1245]: info: Output device has changed, restarting Shairport Sync Feb 26 20:42:15 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:15 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:42:15 room sudo[3187]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 26 20:42:15 room sudo[3187]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:15 room volumio[1245]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 26 20:42:15 room volumio[1245]: info: Done. Feb 26 20:42:15 room volumio[1245]: info: touch_display: Setting screensaver timeout to 120 seconds. Feb 26 20:42:15 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:15 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:15 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:15 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:15 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:15 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:15 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:15 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:15 room systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 26 20:42:15 room sudo[3185]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 26 20:42:15 room sudo[3185]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:15 room sudo[3185]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:15 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:42:15 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:15 room volumio[1245]: info: MPD Permissions set Feb 26 20:42:15 room volumio[1245]: info: Starting Shairport Sync Feb 26 20:42:15 room sudo[3200]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 26 20:42:15 room sudo[3200]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:15 room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 26 20:42:15 room systemd[1]: shairport-sync.service: Deactivated successfully. Feb 26 20:42:15 room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 26 20:42:15 room systemd[1]: shairport-sync.service: Consumed 3.384s CPU time. Feb 26 20:42:15 room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 26 20:42:15 room sudo[3200]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:15 room volumio[1245]: info: Shairport-Sync Started Feb 26 20:42:16 room volumio[1245]: info: Feb 26 20:42:16 room volumio[1245]: ---------------------------- MPD announces state update: player Feb 26 20:42:16 room volumio[1245]: info: sendMpdCommand stop took 961 milliseconds Feb 26 20:42:16 room volumio[1245]: info: ControllerMpd::getState Feb 26 20:42:16 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:42:16 room sudo[3204]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Feb 26 20:42:16 room sudo[3204]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:16 room volumio[1245]: error: MPD error: Error: read ECONNRESET Feb 26 20:42:16 room systemd[1]: peppymeterbasic.service: State 'final-sigterm' timed out. Killing. Feb 26 20:42:16 room systemd[1]: peppymeterbasic.service: Killing process 2715 (python3) with signal SIGKILL. Feb 26 20:42:16 room systemd[1]: peppymeterbasic.service: Killing process 2733 (python3:disk$0) with signal SIGKILL. Feb 26 20:42:16 room systemd[1]: peppymeterbasic.service: Failed with result 'timeout'. Feb 26 20:42:16 room systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Feb 26 20:42:16 room systemd[1]: peppymeterbasic.service: Consumed 2min 10.818s CPU time. Feb 26 20:42:16 room sudo[3204]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:16 room sudo[3172]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:16 room volumio[1245]: info: peppymeterbasic Daemon Stop Feb 26 20:42:19 room volumio[1245]: info: Enabling plugin peppyspectrum Feb 26 20:42:19 room volumio[1245]: info: Loading plugin "peppyspectrum"... Feb 26 20:42:19 room systemd[1]: mpd.service: Deactivated successfully. Feb 26 20:42:19 room systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 26 20:42:19 room systemd[1]: mpd.service: Consumed 9.616s CPU time. Feb 26 20:42:19 room systemd[1]: mpd.socket: Deactivated successfully. Feb 26 20:42:19 room systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 26 20:42:19 room systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 26 20:42:19 room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 26 20:42:19 room systemd[1]: Starting mpd.service - Music Player Daemon... Feb 26 20:42:19 room sudo[3222]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 26 20:42:19 room sudo[3222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 26 20:42:19 room sudo[3222]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:19 room volumio[1245]: info: Preparing to generate the ALSA configuration file Feb 26 20:42:19 room volumio[1245]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Feb 26 20:42:19 room volumio[1245]: info: Reading ALSA contributions from plugins. Feb 26 20:42:19 room volumio[1245]: info: Asound.conf file written Feb 26 20:42:19 room sudo[3227]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 26 20:42:19 room sudo[3227]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:19 room sudo[3227]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:19 room volumio[1245]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Feb 26 20:42:19 room volumio[1245]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Feb 26 20:42:19 room volumio[1245]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Feb 26 20:42:19 room volumio[1245]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 Feb 26 20:42:19 room volumio[1245]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 Feb 26 20:42:19 room volumio[1245]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 Feb 26 20:42:19 room volumio[1245]: Found hardware: "Loopback" "Loopback Mixer" "" "" "" Feb 26 20:42:19 room volumio[1245]: Hardware is initialized using a generic method Feb 26 20:42:19 room volumio[1245]: info: Output device has changed, restarting MPD Feb 26 20:42:19 room volumio[1245]: info: Output device has changed, restarting Shairport Sync Feb 26 20:42:19 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:19 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:42:19 room sudo[3235]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 26 20:42:19 room sudo[3233]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 26 20:42:19 room sudo[3233]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:19 room sudo[3235]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:19 room volumio[1245]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 26 20:42:19 room volumio[1245]: info: PLUGIN START: peppyspectrum Feb 26 20:42:19 room sudo[3233]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:19 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 26 20:42:19 room volumio[1245]: info: Preparing to generate the ALSA configuration file Feb 26 20:42:19 room systemd[1]: mpd.service: Deactivated successfully. Feb 26 20:42:19 room systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 26 20:42:19 room systemd[1]: mpd.socket: Deactivated successfully. Feb 26 20:42:19 room sudo[3245]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-aloop index=7 pcm_substreams=1 Feb 26 20:42:19 room systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 26 20:42:19 room systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 26 20:42:19 room sudo[3245]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:19 room volumio[1245]: info: Done. Feb 26 20:42:19 room volumio[1245]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Feb 26 20:42:19 room volumio[1245]: info: Reading ALSA contributions from plugins. Feb 26 20:42:19 room volumio[1245]: info: MPD Permissions set Feb 26 20:42:19 room volumio[1245]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 20 Feb 26 20:42:19 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:19 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:19 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:19 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:19 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:19 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:19 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:19 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:19 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:42:19 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:19 room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 26 20:42:19 room systemd[1]: Starting mpd.service - Music Player Daemon... Feb 26 20:42:20 room sudo[3245]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:20 room volumio[1245]: info: snd_dummy loaded Feb 26 20:42:20 room volumio[1245]: info: Starting Shairport Sync Feb 26 20:42:20 room sudo[3253]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 26 20:42:20 room sudo[3253]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 26 20:42:20 room sudo[3253]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:20 room sudo[3256]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 26 20:42:20 room sudo[3256]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:20 room volumio[1245]: info: Asound.conf file unchanged, so no further update is needed Feb 26 20:42:20 room volumio[1245]: info: Output device has changed, restarting MPD Feb 26 20:42:20 room volumio[1245]: info: Output device has changed, restarting Shairport Sync Feb 26 20:42:20 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:20 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:42:20 room sudo[3263]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 26 20:42:20 room sudo[3263]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:20 room sudo[3261]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 26 20:42:20 room sudo[3261]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:20 room volumio[1245]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 26 20:42:20 room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 26 20:42:20 room systemd[1]: shairport-sync.service: Deactivated successfully. Feb 26 20:42:20 room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 26 20:42:20 room systemd[1]: shairport-sync.service: Consumed 1.969s CPU time. Feb 26 20:42:20 room sudo[3261]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:20 room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 26 20:42:20 room sudo[3256]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:20 room volumio[1245]: info: MPD Permissions set Feb 26 20:42:20 room systemd[1]: mpd.service: Deactivated successfully. Feb 26 20:42:20 room systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 26 20:42:20 room systemd[1]: mpd.socket: Deactivated successfully. Feb 26 20:42:20 room systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 26 20:42:20 room systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 26 20:42:20 room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 26 20:42:20 room volumio[1245]: info: Shairport-Sync Started Feb 26 20:42:20 room systemd[1]: Starting mpd.service - Music Player Daemon... Feb 26 20:42:20 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:20 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:20 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:20 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:20 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:20 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:20 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:20 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:20 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:42:20 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:42:20 room volumio[1245]: info: Starting Shairport Sync Feb 26 20:42:20 room volumio[1245]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 20:42:20 room sudo[3274]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 26 20:42:20 room sudo[3274]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 26 20:42:20 room sudo[3295]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 26 20:42:20 room sudo[3274]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:20 room sudo[3295]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:20 room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 26 20:42:20 room systemd[1]: shairport-sync.service: Deactivated successfully. Feb 26 20:42:20 room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 26 20:42:20 room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 26 20:42:20 room sudo[3295]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:20 room volumio[1245]: info: Shairport-Sync Started Feb 26 20:42:22 room mpd[3298]: 2026-02-26T20:42:22 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 26 20:42:22 room systemd[1]: Started mpd.service - Music Player Daemon. Feb 26 20:42:22 room sudo[3187]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:22 room sudo[3235]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:22 room sudo[3263]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:22 room volumio[1245]: error: updateQueue error: null Feb 26 20:42:22 room volumio[1245]: error: MPD error: The expression evaluated to a falsy value: Feb 26 20:42:22 room volumio[1245]: assert.ok(self.idling) Feb 26 20:42:22 room volumio[1245]: error: The expression evaluated to a falsy value: Feb 26 20:42:22 room volumio[1245]: assert.ok(self.idling) Feb 26 20:42:22 room volumio[1245]: error: MPD error: The expression evaluated to a falsy value: Feb 26 20:42:22 room volumio[1245]: assert.ok(self.idling) Feb 26 20:42:22 room volumio[1245]: error: The expression evaluated to a falsy value: Feb 26 20:42:22 room volumio[1245]: assert.ok(self.idling) Feb 26 20:42:22 room volumio[1245]: error: updateQueue error: null Feb 26 20:42:26 room volumio[1245]: info: CALLMETHOD: user_interface peppyspectrum savepeppy [object Object] Feb 26 20:42:26 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , savepeppy Feb 26 20:42:26 room volumio[1245]: aaaaaaaaaaa 1920,480_Gelo5 Spec&Met_520 Feb 26 20:42:26 room volumio[1245]: info: PeppySpectrum ---1920480_Gelo5 Spec&Met_520 Feb 26 20:42:26 room volumio[1245]: info: PeppySpectrum ---1920480NaN Feb 26 20:42:26 room volumio[1245]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Feb 26 20:42:27 room volumio[1245]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 20:42:27 room volumio[1245]: info: CoreCommandRouter::Close All Modals sent Feb 26 20:42:29 room volumio[1245]: info: CALLMETHOD: user_interface peppyspectrum savepeppy [object Object] Feb 26 20:42:29 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , savepeppy Feb 26 20:42:29 room volumio[1245]: aaaaaaaaaaa 1920,480_Gelo5 Spec&Met_520 Feb 26 20:42:29 room volumio[1245]: info: PeppySpectrum ---1920480_Gelo5 Spec&Met_520 Feb 26 20:42:29 room volumio[1245]: info: PeppySpectrum ---1920480NaN Feb 26 20:42:29 room volumio[1245]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Feb 26 20:42:29 room volumio[1245]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 20:42:29 room volumio[1245]: info: CoreCommandRouter::Close All Modals sent Feb 26 20:42:31 room volumio[1245]: info: CALLMETHOD: user_interface peppyspectrum savepeppy [object Object] Feb 26 20:42:31 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , savepeppy Feb 26 20:42:31 room volumio[1245]: aaaaaaaaaaa 1920,480_Gelo5 Spec&Met_520 Feb 26 20:42:31 room volumio[1245]: info: PeppySpectrum ---1920480_Gelo5 Spec&Met_520 Feb 26 20:42:31 room volumio[1245]: info: PeppySpectrum ---1920480NaN Feb 26 20:42:31 room volumio[1245]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Feb 26 20:42:31 room volumio[1245]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 20:42:31 room volumio[1245]: info: CoreCommandRouter::Close All Modals sent Feb 26 20:42:33 room volumio[1245]: info: CoreCommandRouter::volumioPlay Feb 26 20:42:33 room volumio[1245]: info: CoreStateMachine::play index undefined Feb 26 20:42:33 room volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 20:42:33 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:33 room volumio[1245]: info: CoreStateMachine::startPlaybackTimer Feb 26 20:42:33 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:33 room volumio[1245]: info: [1772106153690] ControllerWebradio::clearAddPlayTrack Feb 26 20:42:33 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand stop Feb 26 20:42:33 room volumio[1245]: info: sendMpdCommand stop took 2 milliseconds Feb 26 20:42:33 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand clear Feb 26 20:42:33 room volumio[1245]: info: Feb 26 20:42:33 room volumio[1245]: ---------------------------- MPD announces system playlist update Feb 26 20:42:33 room volumio[1245]: info: Ignoring MPD Status Update Feb 26 20:42:33 room volumio[1245]: info: sendMpdCommand clear took 2 milliseconds Feb 26 20:42:33 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand add "https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8" Feb 26 20:42:33 room volumio[1245]: info: Feb 26 20:42:33 room volumio[1245]: ---------------------------- MPD announces system playlist update Feb 26 20:42:33 room volumio[1245]: info: Ignoring MPD Status Update Feb 26 20:42:33 room volumio[1245]: info: Feb 26 20:42:33 room volumio[1245]: ---------------------------- MPD announces system playlist update Feb 26 20:42:33 room volumio[1245]: info: Ignoring MPD Status Update Feb 26 20:42:33 room volumio[1245]: info: Feb 26 20:42:33 room volumio[1245]: ---------------------------- MPD announces system playlist update Feb 26 20:42:33 room volumio[1245]: info: Ignoring MPD Status Update Feb 26 20:42:33 room volumio[1245]: error: updateQueue error: null Feb 26 20:42:33 room volumio[1245]: info: Feb 26 20:42:33 room volumio[1245]: ---------------------------- MPD announces system playlist update Feb 26 20:42:33 room volumio[1245]: info: Ignoring MPD Status Update Feb 26 20:42:33 room volumio[1245]: info: ------------------------------ 8ms Feb 26 20:42:33 room volumio[1245]: info: sendMpdCommand add "https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8" took 8 milliseconds Feb 26 20:42:33 room volumio[1245]: info: ------------------------------ 9ms Feb 26 20:42:33 room volumio[1245]: info: ------------------------------ 8ms Feb 26 20:42:33 room volumio[1245]: info: ------------------------------ 7ms Feb 26 20:42:33 room volumio[1245]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 26 20:42:33 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand play Feb 26 20:42:33 room volumio[1245]: info: Feb 26 20:42:33 room volumio[1245]: ---------------------------- MPD announces system playlist update Feb 26 20:42:33 room volumio[1245]: info: Ignoring MPD Status Update Feb 26 20:42:33 room volumio[1245]: info: Feb 26 20:42:33 room volumio[1245]: ---------------------------- MPD announces system playlist update Feb 26 20:42:33 room volumio[1245]: info: Ignoring MPD Status Update Feb 26 20:42:33 room volumio[1245]: info: Feb 26 20:42:33 room volumio[1245]: ---------------------------- MPD announces system playlist update Feb 26 20:42:33 room volumio[1245]: info: Ignoring MPD Status Update Feb 26 20:42:33 room volumio[1245]: info: ------------------------------ 13ms Feb 26 20:42:33 room volumio[1245]: info: sendMpdCommand play took 7 milliseconds Feb 26 20:42:33 room volumio[1245]: info: ------------------------------ 7ms Feb 26 20:42:33 room volumio[1245]: info: ------------------------------ 5ms Feb 26 20:42:33 room volumio[1245]: info: ------------------------------ 3ms Feb 26 20:42:34 room volumio[1245]: info: Feb 26 20:42:34 room volumio[1245]: ---------------------------- MPD announces state update: player Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::getState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:42:34 room volumio[1245]: info: Feb 26 20:42:34 room volumio[1245]: ---------------------------- MPD announces state update: player Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::getState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:42:34 room volumio[1245]: info: Feb 26 20:42:34 room volumio[1245]: ---------------------------- MPD announces state update: player Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::getState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:42:34 room volumio[1245]: info: Feb 26 20:42:34 room volumio[1245]: ---------------------------- MPD announces state update: player Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::getState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand status took 96 milliseconds Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:42:34 room volumio[1245]: info: Feb 26 20:42:34 room volumio[1245]: ---------------------------- MPD announces state update: player Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::getState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:42:34 room volumio[1245]: info: Feb 26 20:42:34 room volumio[1245]: ---------------------------- MPD announces state update: player Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::getState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand status took 100 milliseconds Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand status took 99 milliseconds Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand status took 98 milliseconds Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand status took 5 milliseconds Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseTrackInfo Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::pushState Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::servicePushState Feb 26 20:42:34 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:34 room volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"chunklist.m3u8","artist":null,"album":null,"uri":"https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8","trackType":"m3u8"} Feb 26 20:42:34 room volumio[1245]: verbose: CURRENT POSITION 0 Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState stateService play Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState currentStatus stop Feb 26 20:42:34 room volumio[1245]: info: ------------------------------ 116ms Feb 26 20:42:34 room volumio[1245]: info: Feb 26 20:42:34 room volumio[1245]: ---------------------------- MPD announces state update: player Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::getState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:42:34 room volumio[1245]: info: Feb 26 20:42:34 room volumio[1245]: ---------------------------- MPD announces state update: player Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::getState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand status took 14 milliseconds Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand status took 2 milliseconds Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand status took 2 milliseconds Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseTrackInfo Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseTrackInfo Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseTrackInfo Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseTrackInfo Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseState Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::pushState Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::servicePushState Feb 26 20:42:34 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:34 room volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":263,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"chunklist.m3u8","artist":null,"album":null,"uri":"https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8","trackType":"m3u8"} Feb 26 20:42:34 room volumio[1245]: verbose: CURRENT POSITION 0 Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState stateService play Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState currentStatus play Feb 26 20:42:34 room volumio[1245]: info: Received an update from plugin. extracting info from payload Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::pushState Feb 26 20:42:34 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::volumioPushState Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::pushState Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::volumioPushState Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::pushState Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::servicePushState Feb 26 20:42:34 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:34 room volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":320,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"chunklist.m3u8","artist":null,"album":null,"uri":"https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8","trackType":"m3u8"} Feb 26 20:42:34 room volumio[1245]: verbose: CURRENT POSITION 0 Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState stateService play Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState currentStatus play Feb 26 20:42:34 room volumio[1245]: info: Received an update from plugin. extracting info from payload Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::pushState Feb 26 20:42:34 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::volumioPushState Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::pushState Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::volumioPushState Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::pushState Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::servicePushState Feb 26 20:42:34 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:34 room volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":366,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"chunklist.m3u8","artist":null,"album":null,"uri":"https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8","trackType":"m3u8"} Feb 26 20:42:34 room volumio[1245]: verbose: CURRENT POSITION 0 Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState stateService play Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState currentStatus play Feb 26 20:42:34 room volumio[1245]: info: Received an update from plugin. extracting info from payload Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::pushState Feb 26 20:42:34 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::volumioPushState Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::pushState Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::volumioPushState Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::pushState Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::servicePushState Feb 26 20:42:34 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:34 room volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":778,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"chunklist.m3u8","artist":null,"album":null,"uri":"https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8","trackType":"m3u8"} Feb 26 20:42:34 room volumio[1245]: verbose: CURRENT POSITION 0 Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState stateService play Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState currentStatus play Feb 26 20:42:34 room volumio[1245]: info: Received an update from plugin. extracting info from payload Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::pushState Feb 26 20:42:34 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::volumioPushState Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::pushState Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::volumioPushState Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.591+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.592+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.593+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.593+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.594+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.594+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.595+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.595+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.596+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.597+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.598+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.598+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.599+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.600+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.600+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.600+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:42:34 room volumio[1245]: info: ------------------------------ 245ms Feb 26 20:42:34 room volumio[1245]: info: ------------------------------ 245ms Feb 26 20:42:34 room volumio[1245]: info: ------------------------------ 245ms Feb 26 20:42:34 room volumio[1245]: info: ------------------------------ 151ms Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand playlistinfo took 134 milliseconds Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand playlistinfo took 134 milliseconds Feb 26 20:42:34 room volumio[1245]: info: sendMpdCommand playlistinfo took 133 milliseconds Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseTrackInfo Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseTrackInfo Feb 26 20:42:34 room volumio[1245]: verbose: ControllerMpd::parseTrackInfo Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::pushState Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::servicePushState Feb 26 20:42:34 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:34 room volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"chunklist.m3u8","artist":null,"album":null,"uri":"https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8","trackType":"m3u8"} Feb 26 20:42:34 room volumio[1245]: verbose: CURRENT POSITION 0 Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState stateService play Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState currentStatus play Feb 26 20:42:34 room volumio[1245]: info: Received an update from plugin. extracting info from payload Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::pushState Feb 26 20:42:34 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::volumioPushState Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::pushState Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::volumioPushState Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::pushState Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::servicePushState Feb 26 20:42:34 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:34 room volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"chunklist.m3u8","artist":null,"album":null,"uri":"https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8","trackType":"m3u8"} Feb 26 20:42:34 room volumio[1245]: verbose: CURRENT POSITION 0 Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState stateService play Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState currentStatus play Feb 26 20:42:34 room volumio[1245]: info: Received an update from plugin. extracting info from payload Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::pushState Feb 26 20:42:34 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::volumioPushState Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::pushState Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::volumioPushState Feb 26 20:42:34 room volumio[1245]: info: ControllerMpd::pushState Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::servicePushState Feb 26 20:42:34 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:34 room volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"chunklist.m3u8","artist":null,"album":null,"uri":"https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8","trackType":"m3u8"} Feb 26 20:42:34 room volumio[1245]: verbose: CURRENT POSITION 0 Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState stateService play Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::syncState currentStatus play Feb 26 20:42:34 room volumio[1245]: info: Received an update from plugin. extracting info from payload Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::pushState Feb 26 20:42:34 room volumio[1245]: info: CorePlayQueue::getTrack 0 Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::volumioPushState Feb 26 20:42:34 room volumio[1245]: info: CoreStateMachine::pushState Feb 26 20:42:34 room volumio[1245]: info: CoreCommandRouter::volumioPushState Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.740+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.741+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.742+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.743+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.743+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.744+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.745+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.745+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.747+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.747+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.748+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 20:42:34 room volumio5-onboarding[1611]: time=2026-02-26T20:42:34.749+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:54654 @ 0x1c901e0" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:42:34 room volumio[1245]: info: ------------------------------ 272ms Feb 26 20:42:34 room volumio[1245]: info: ------------------------------ 262ms Feb 26 20:42:34 room volumio[1245]: info: ------------------------------ 262ms Feb 26 20:42:34 room volumio[1245]: info: PeppySpectrum ---peppyspectrum status play Feb 26 20:42:34 room volumio[1245]: info: PeppySpectrum ---peppyspectrum status play Feb 26 20:42:34 room volumio[1245]: info: PeppySpectrum ---peppyspectrum status play Feb 26 20:42:34 room sudo[3357]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 20:42:34 room sudo[3357]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:34 room volumio[1245]: info: PeppySpectrum ---peppyspectrum status play Feb 26 20:42:34 room sudo[3359]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 20:42:34 room sudo[3359]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:34 room volumio[1245]: info: PeppySpectrum ---peppyspectrum status play Feb 26 20:42:34 room volumio[1245]: info: PeppySpectrum ---peppyspectrum status play Feb 26 20:42:34 room volumio[1245]: info: PeppySpectrum ---peppyspectrum status play Feb 26 20:42:34 room sudo[3365]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 20:42:34 room sudo[3367]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 20:42:34 room sudo[3365]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:34 room sudo[3367]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:34 room sudo[3363]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 20:42:34 room sudo[3363]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:34 room volumio[1245]: info: PeppySpectrum ---peppyspectrum status play Feb 26 20:42:34 room sudo[3369]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 20:42:34 room sudo[3369]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:34 room volumio[1245]: info: PeppySpectrum ---peppyspectrum status play Feb 26 20:42:35 room sudo[3374]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 20:42:35 room volumio[1245]: info: PeppySpectrum ---peppyspectrum status play Feb 26 20:42:35 room sudo[3374]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:35 room sudo[3378]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 20:42:35 room volumio[1245]: info: PeppySpectrum ---peppyspectrum status play Feb 26 20:42:35 room sudo[3378]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:35 room systemd[1]: Started peppyspectrum.service - peppyspectrum Daemon. Feb 26 20:42:35 room sudo[3357]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:35 room volumio[1245]: info: PeppySpectrum ---peppyspectrum status play Feb 26 20:42:35 room sudo[3381]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 20:42:35 room volumio[1245]: info: PeppySpectrum ---peppyspectrum status play Feb 26 20:42:35 room sudo[3387]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 20:42:35 room sudo[3387]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:35 room sudo[3381]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:35 room sudo[3386]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 20:42:35 room sudo[3386]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:35 room sudo[3389]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 20:42:35 room sudo[3389]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:35 room volumio[1245]: info: PeppySpectrum ---peppyspectrum status play Feb 26 20:42:35 room sudo[3359]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:35 room volumio[1245]: info: peppyspectrum Daemon Started Feb 26 20:42:35 room volumio[1245]: info: peppyspectrum Daemon Started Feb 26 20:42:35 room sudo[3397]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 20:42:35 room sudo[3397]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:35 room sudo[3394]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 20:42:35 room sudo[3394]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:42:35 room volumio[1245]: info: touch_display: Setting screensaver timeout to 0 seconds. Feb 26 20:42:35 room sudo[3389]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:35 room sudo[3369]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:35 room sudo[3381]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:35 room sudo[3387]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:35 room sudo[3397]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:35 room sudo[3386]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:35 room sudo[3365]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:35 room sudo[3394]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:35 room sudo[3367]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:35 room sudo[3374]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:35 room sudo[3378]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:35 room volumio[1245]: info: peppyspectrum Daemon Started Feb 26 20:42:35 room sudo[3363]: pam_unix(sudo:session): session closed for user root Feb 26 20:42:35 room volumio[1245]: info: peppyspectrum Daemon Started Feb 26 20:42:35 room volumio[1245]: info: peppyspectrum Daemon Started Feb 26 20:42:35 room volumio[1245]: info: peppyspectrum Daemon Started Feb 26 20:42:35 room volumio[1245]: info: peppyspectrum Daemon Started Feb 26 20:42:35 room volumio[1245]: info: peppyspectrum Daemon Started Feb 26 20:42:35 room volumio[1245]: info: peppyspectrum Daemon Started Feb 26 20:42:35 room volumio[1245]: info: peppyspectrum Daemon Started Feb 26 20:42:35 room volumio[1245]: info: peppyspectrum Daemon Started Feb 26 20:42:35 room volumio[1245]: info: peppyspectrum Daemon Started Feb 26 20:42:35 room volumio[1245]: info: peppyspectrum Daemon Started Feb 26 20:42:35 room volumio[1245]: info: peppyspectrum Daemon Started Feb 26 20:42:37 room startpeppyspectrum.sh[3385]: libpng warning: iCCP: known incorrect sRGB profile Feb 26 20:42:37 room startpeppyspectrum.sh[3385]: libpng warning: iCCP: known incorrect sRGB profile Feb 26 20:42:37 room startpeppyspectrum.sh[3385]: libpng warning: iCCP: known incorrect sRGB profile Feb 26 20:42:43 room volumio[1245]: info: CALLMETHOD: user_interface peppyspectrum savepeppy [object Object] Feb 26 20:42:43 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , savepeppy Feb 26 20:42:43 room volumio[1245]: aaaaaaaaaaa 1920,480_Gelo5 Spec&Met_520 Feb 26 20:42:43 room volumio[1245]: info: PeppySpectrum ---1920480_Gelo5 Spec&Met_520 Feb 26 20:42:43 room volumio[1245]: info: PeppySpectrum ---1920480NaN Feb 26 20:42:43 room volumio[1245]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Feb 26 20:42:43 room volumio[1245]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 20:42:43 room volumio[1245]: info: CoreCommandRouter::Close All Modals sent Feb 26 20:43:06 room volumio5-onboarding[1611]: time=2026-02-26T20:43:06.721+09:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.0.25:54654 error="websocket: close 1006 (abnormal closure): unexpected EOF" Feb 26 20:43:06 room volumio5-onboarding[1611]: time=2026-02-26T20:43:06.721+09:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.0.25:54654 Feb 26 20:43:06 room volumio5-onboarding[1611]: time=2026-02-26T20:43:06.721+09:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.0.25:54654 Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.134+09:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.25:55854 Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.154+09:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.0.25:55854 @ 0x1801410" latency=-2.79780828s platform=PLATFORM_ANDROID version=5.260120.0 Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.155+09:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.0.25:55854 @ 0x1801410" latency=-2.797908885s timeout=10s Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.155+09:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.0.25:55854 @ 0x1801410" Feb 26 20:43:09 room volumio[1245]: info: Received Get System Info Feb 26 20:43:09 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 26 20:43:09 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 26 20:43:09 room volumio[1245]: info: Discovery: Getting this device information Feb 26 20:43:09 room volumio[1245]: info: CoreCommandRouter::volumioGetState Feb 26 20:43:09 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.158+09:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.0.25:55854 @ 0x1801410" name=ROOM Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.159+09:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.0.25:55854 @ 0x1801410" language=ko Feb 26 20:43:09 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.163+09:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.0.25:55854 @ 0x1801410" timezone=Asia/Seoul Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.164+09:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.0.25:55854 @ 0x1801410" available=true connected=true macAddress=e4:5f:01:b7:93:88 ip4Address=192.168.0.34/24 ip6Address= Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.167+09:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.0.25:55854 @ 0x1801410" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.170+09:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.0.25:55854 @ 0x1801410" setupComplete=true Feb 26 20:43:09 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Feb 26 20:43:09 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 26 20:43:09 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:43:09 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 26 20:43:09 room volumio[1245]: amixer -c 0 info | grep "bcm2835 ALSA" Feb 26 20:43:09 room volumio[1245]: amixer -c 1 info | grep "bcm2835 Headphones" Feb 26 20:43:09 room volumio[1245]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones' Feb 26 20:43:09 room volumio[1245]: amixer -c 2 info | grep "vc4-hdmi-0" Feb 26 20:43:09 room volumio[1245]: Card sysdefault:2 'vc4hdmi0'/'vc4-hdmi-0' Feb 26 20:43:09 room volumio[1245]: amixer -c 3 info | grep "vc4-hdmi-1" Feb 26 20:43:09 room volumio[1245]: Card sysdefault:3 'vc4hdmi1'/'vc4-hdmi-1' Feb 26 20:43:09 room volumio[1245]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5 Feb 26 20:43:09 room volumio[1245]: /bin/sh: 1: /usr/local/bin/alsacap: not found Feb 26 20:43:09 room volumio[1245]: {"cmd":"/usr/local/bin/alsacap -C 5","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 5\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)"} Feb 26 20:43:09 room volumio[1245]: amixer -c 5 info | grep "SA9227 USB Audio" Feb 26 20:43:09 room volumio[1245]: Card sysdefault:5 'Audio'/'SAVIAUDIO SA9227 USB Audio at usb-0000:01:00.0-1.4, high speed' Feb 26 20:43:09 room volumio[1245]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5 Feb 26 20:43:09 room volumio[1245]: /bin/sh: 1: /usr/local/bin/alsacap: not found Feb 26 20:43:09 room volumio[1245]: {"cmd":"/usr/local/bin/alsacap -C 5","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 5\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)"} Feb 26 20:43:09 room volumio[1245]: amixer -c 5 info | grep "SA9227 USB Audio" Feb 26 20:43:09 room volumio[1245]: Card sysdefault:5 'Audio'/'SAVIAUDIO SA9227 USB Audio at usb-0000:01:00.0-1.4, high speed' Feb 26 20:43:09 room volumio[1245]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 7 Feb 26 20:43:09 room volumio[1245]: /bin/sh: 1: /usr/local/bin/alsacap: not found Feb 26 20:43:09 room volumio[1245]: {"cmd":"/usr/local/bin/alsacap -C 7","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 7\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)"} Feb 26 20:43:09 room volumio[1245]: amixer -c 7 info | grep "Loopback" Feb 26 20:43:09 room volumio[1245]: Card sysdefault:7 'Loopback'/'Loopback 1' Feb 26 20:43:09 room volumio[1245]: Mixer name : 'Loopback Mixer' Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.387+09:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.0.25:55854 @ 0x1801410" selectedOutputId=5 Feb 26 20:43:09 room volumio[1245]: info: Received Get System Info Feb 26 20:43:09 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 26 20:43:09 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 26 20:43:09 room volumio[1245]: info: Discovery: Getting this device information Feb 26 20:43:09 room volumio[1245]: info: CoreCommandRouter::volumioGetState Feb 26 20:43:09 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.434+09:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.0.25:55854 @ 0x1801410" currentVersion=4.096 latestVersion=4.096 Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.434+09:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.0.25:55854 @ 0x1801410" status=UPDATE_STATUS_NONE progress=0 Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.434+09:00 level=INFO msg="emitting user changed event" component=server peer="192.168.0.25:55854 @ 0x1801410" userId= Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.435+09:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.0.25:55854 @ 0x1801410" providers=3 Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.435+09:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.0.25:55854 @ 0x1801410" plugins=60 Feb 26 20:43:09 room volumio[1245]: info: CoreCommandRouter::volumioGetState Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.439+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55854 @ 0x1801410" state=STATUS_PLAYING positionMs=34950 volume=25 Feb 26 20:43:09 room volumio5-onboarding[1611]: time=2026-02-26T20:43:09.439+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55854 @ 0x1801410" id=https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/chunklist.m3u8 title=CBS Feb 26 20:43:10 room volumio5-onboarding[1611]: time=2026-02-26T20:43:10.792+09:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.0.25:55854 @ 0x1801410" latency=-2.790412975s timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Feb 26 20:43:11 room sudo[3493]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 26 20:43:11 room sudo[3493]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:43:11 room sudo[3493]: pam_unix(sudo:session): session closed for user root Feb 26 20:43:11 room sudo[3495]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 26 20:43:11 room sudo[3495]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:43:11 room sudo[3495]: pam_unix(sudo:session): session closed for user root Feb 26 20:43:11 room volumio[1245]: verbose: New Socket.io Connection to 192.168.0.34 from 192.168.0.25 UA: Mozilla/5.0 (Linux; Android 12; SM-N976N Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/145.0.7632.79 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Feb 26 20:43:11 room sudo[3499]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 26 20:43:11 room sudo[3499]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:43:11 room sudo[3499]: pam_unix(sudo:session): session closed for user root Feb 26 20:43:11 room sudo[3501]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 26 20:43:11 room sudo[3501]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 20:43:11 room sudo[3501]: pam_unix(sudo:session): session closed for user root Feb 26 20:43:11 room volumio[1245]: verbose: New Socket.io Connection to 192.168.0.34 from 192.168.0.25 UA: Mozilla/5.0 (Linux; Android 12; SM-N976N Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/145.0.7632.79 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Feb 26 20:43:11 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 26 20:43:11 room volumio[1245]: info: CoreCommandRouter::volumioGetVisibleSources Feb 26 20:43:11 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 20:43:11 room volumio[1245]: info: CoreCommandRouter::volumioGetState Feb 26 20:43:11 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 26 20:43:11 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 26 20:43:11 room volumio[1245]: info: Received Get System Info Feb 26 20:43:11 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 26 20:43:11 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 26 20:43:11 room volumio[1245]: info: Discovery: Getting this device information Feb 26 20:43:11 room volumio[1245]: info: CoreCommandRouter::volumioGetState Feb 26 20:43:11 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 26 20:43:11 room volumio[1245]: info: CoreCommandRouter::volumioGetState Feb 26 20:43:11 room volumio[1245]: info: Listing playlists Feb 26 20:43:11 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 26 20:43:11 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 26 20:43:11 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 26 20:43:13 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 26 20:43:13 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 26 20:43:13 room volumio[1245]: info: Received Get System Info Feb 26 20:43:13 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 26 20:43:13 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 26 20:43:13 room volumio[1245]: info: Discovery: Getting this device information Feb 26 20:43:13 room volumio[1245]: info: CoreCommandRouter::volumioGetState Feb 26 20:43:13 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 26 20:43:14 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 26 20:43:14 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 26 20:43:14 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 26 20:43:14 room volumio[1245]: info: Received Get System Info Feb 26 20:43:14 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 26 20:43:14 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 26 20:43:14 room volumio[1245]: info: Discovery: Getting this device information Feb 26 20:43:14 room volumio[1245]: info: CoreCommandRouter::volumioGetState Feb 26 20:43:14 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 26 20:43:17 room volumio[1245]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 20:43:20 room volumio[1245]: info: CALLMETHOD: user_interface peppyspectrum updatelist Feb 26 20:43:20 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , updatelist Feb 26 20:43:20 room volumio[1245]: info: PeppySpectrum --- wget 'https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/spectrumslist.txt' Feb 26 20:43:21 room volumio[1245]: --2026-02-26 20:43:20-- https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/spectrumslist.txt Feb 26 20:43:21 room volumio[1245]: Resolving github.com (github.com)... 20.200.245.247 Feb 26 20:43:21 room volumio[1245]: Connecting to github.com (github.com)|20.200.245.247|:443... connected. Feb 26 20:43:21 room volumio[1245]: HTTP request sent, awaiting response... 302 Found Feb 26 20:43:21 room volumio[1245]: Location: https://raw.githubusercontent.com/balbuze/Spectrum-peppyspectrum/main/spectrumslist.txt [following] Feb 26 20:43:21 room volumio[1245]: --2026-02-26 20:43:20-- https://raw.githubusercontent.com/balbuze/Spectrum-peppyspectrum/main/spectrumslist.txt Feb 26 20:43:21 room volumio[1245]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.108.133, 185.199.109.133, 185.199.111.133, ... Feb 26 20:43:21 room volumio[1245]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.108.133|:443... connected. Feb 26 20:43:21 room volumio[1245]: HTTP request sent, awaiting response... 200 OK Feb 26 20:43:21 room volumio[1245]: Length: 471 [text/plain] Feb 26 20:43:21 room volumio[1245]: Saving to: ‘/data/plugins/user_interface/peppyspectrum/spectrumslist.txt’ Feb 26 20:43:21 room volumio[1245]: 0K 100% 6.66M=0s Feb 26 20:43:21 room volumio[1245]: 2026-02-26 20:43:21 (6.66 MB/s) - ‘/data/plugins/user_interface/peppyspectrum/spectrumslist.txt’ saved [471/471] Feb 26 20:43:21 room volumio[1245]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 20:43:21 room volumio[1245]: info: CoreCommandRouter::Close All Modals sent Feb 26 20:43:21 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 26 20:43:24 room volumio[1245]: info: CALLMETHOD: user_interface peppyspectrum dlspectrum [object Object] Feb 26 20:43:24 room volumio[1245]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , dlspectrum Feb 26 20:43:26 room volumio[1245]: --2026-02-26 20:43:24-- https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/Zipped-folders/Choose Feb 26 20:43:26 room volumio[1245]: Resolving github.com (github.com)... 20.200.245.247 Feb 26 20:43:26 room volumio[1245]: Connecting to github.com (github.com)|20.200.245.247|:443... connected. Feb 26 20:43:26 room volumio[1245]: HTTP request sent, awaiting response... 404 Not Found Feb 26 20:43:26 room volumio[1245]: 2026-02-26 20:43:24 ERROR 404: Not Found. Feb 26 20:43:26 room volumio[1245]: --2026-02-26 20:43:24-- http://a/ Feb 26 20:43:26 room volumio[1245]: Resolving a (a)... failed: Device or resource busy. Feb 26 20:43:26 room volumio[1245]: wget: unable to resolve host address ‘a’ Feb 26 20:43:26 room volumio[1245]: --2026-02-26 20:43:24-- http://packet.zip/ Feb 26 20:43:26 room volumio[1245]: Resolving packet.zip (packet.zip)... 162.255.119.167 Feb 26 20:43:26 room volumio[1245]: Connecting to packet.zip (packet.zip)|162.255.119.167|:80... connected. Feb 26 20:43:26 room volumio[1245]: HTTP request sent, awaiting response... 302 Found Feb 26 20:43:26 room volumio[1245]: Location: http://www.packet.zip/ [following] Feb 26 20:43:26 room volumio[1245]: --2026-02-26 20:43:25-- http://www.packet.zip/ Feb 26 20:43:26 room volumio[1245]: Resolving www.packet.zip (www.packet.zip)... 91.195.240.19 Feb 26 20:43:26 room volumio[1245]: Connecting to www.packet.zip (www.packet.zip)|91.195.240.19|:80... connected. Feb 26 20:43:26 room volumio[1245]: HTTP request sent, awaiting response... 403 Forbidden Feb 26 20:43:26 room volumio[1245]: 2026-02-26 20:43:26 ERROR 403: Forbidden. Feb 26 20:43:26 room volumio[1245]: error: PeppySpectrum --- An error occurs while downloading or installing Spectrums Feb 26 20:43:26 room volumio[1245]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Feb 26 20:43:26 room volumio[1245]: /bin/rm: cannot remove 'a': No such file or directory Feb 26 20:43:26 room volumio[1245]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Feb 26 20:43:26 room volumio[1245]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 20:43:26 room volumio[1245]: Error: Command failed: /bin/rm /tmp/Choose a packet.zip* Feb 26 20:43:26 room volumio[1245]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Feb 26 20:43:26 room volumio[1245]: /bin/rm: cannot remove 'a': No such file or directory Feb 26 20:43:26 room volumio[1245]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Feb 26 20:43:26 room volumio[1245]: at checkExecSyncError (node:child_process:887:11) Feb 26 20:43:26 room volumio[1245]: at execSync (node:child_process:959:15) Feb 26 20:43:26 room volumio[1245]: at /data/plugins/user_interface/peppyspectrum/index.js:770:19 Feb 26 20:43:26 room volumio[1245]: at new Promise () Feb 26 20:43:26 room volumio[1245]: at peppyspectrum.dlspectrum (/data/plugins/user_interface/peppyspectrum/index.js:745:12) Feb 26 20:43:26 room volumio[1245]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Feb 26 20:43:26 room volumio[1245]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:337:42) Feb 26 20:43:26 room volumio[1245]: at Socket.emit (node:events:514:28) Feb 26 20:43:26 room volumio[1245]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Feb 26 20:43:26 room volumio[1245]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Feb 26 20:43:26 room volumio[1245]: status: 1, Feb 26 20:43:26 room volumio[1245]: signal: null, Feb 26 20:43:26 room volumio[1245]: output: [ Feb 26 20:43:26 room volumio[1245]: null, Feb 26 20:43:26 room volumio[1245]: , Feb 26 20:43:26 room volumio[1245]: Feb 26 20:43:26 room volumio[1245]: ], Feb 26 20:43:26 room volumio[1245]: pid: 3543, Feb 26 20:43:26 room volumio[1245]: stdout: , Feb 26 20:43:26 room volumio[1245]: stderr: Feb 26 20:43:26 room volumio[1245]: } Feb 26 20:43:26 room volumio[1245]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 20:43:27 room sudo[3559]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-26 20:42' Feb 26 20:43:27 room sudo[3559]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"