Dec 21 09:33:10 volumio volumio[1391]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 21 09:33:15 volumio volumio[1391]: info: CALLMETHOD: user_interface now_playing configSaveDaemon [object Object] Dec 21 09:33:15 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: now_playing , configSaveDaemon Dec 21 09:33:16 volumio volumio[1391]: info: CoreCommandRouter::volumioGetQueue Dec 21 09:33:16 volumio volumio[1391]: info: CoreStateMachine::getQueue Dec 21 09:33:16 volumio volumio[1391]: info: CorePlayQueue::getQueue Dec 21 09:33:16 volumio volumio[1391]: info: CoreCommandRouter::volumioGetVisibleSources Dec 21 09:33:16 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 21 09:33:23 volumio volumio[1391]: info: CoreCommandRouter::volumioSeek Dec 21 09:33:23 volumio volumio[1391]: info: CoreStateMachine::seek Dec 21 09:33:23 volumio volumio[1391]: info: CorePlayQueue::getTrack 1 Dec 21 09:33:23 volumio volumio[1391]: info: TRACKBLOCK {"service":"personal_radio","type":"track","trackType":"개인 라디오","radioType":"mbc","albumart":"/albumart?sourceicon=music_service/personal_radio/logos/mbc1.png","uri":"webmbc/1","realUri":"https://minimw.imbc.com/dmfm/_definst_/mfm.stream/playlist.m3u8?_lsu_sa_=61A1311D83643A549A4F454635B1674EC5523EA5800B1292305008aA969D357688aD73563DC23C41903C3D515Ab141798B2D510DEBF20E22D9C2DB0C23AD5ECF7BBF427BF75EC4AF8A255DB8885CB4A1836F5FB51D2D2D4CC0077924D43EDE482C073130460D0AE058015ECA1E98E545","name":"MBC FM4U"} Dec 21 09:33:23 volumio volumio[1391]: info: CoreStateMachine::startPlaybackTimer Dec 21 09:33:23 volumio volumio[1391]: info: CorePlayQueue::getTrack 1 Dec 21 09:33:23 volumio volumio[1391]: info: CoreStateMachine::pushState Dec 21 09:33:23 volumio volumio[1391]: info: CorePlayQueue::getTrack 1 Dec 21 09:33:23 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 21 09:33:23 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState Dec 21 09:33:23 volumio volumio[1391]: info: FusionDsp - Volumio is playing Dec 21 09:33:23 volumio volumio[1391]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Dec 21 09:33:23 volumio volumio[1391]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 21 09:33:23 volumio volumio[1391]: info: FusionDsp - Clipping Monitor started Dec 21 09:33:23 volumio sudo[3886]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 21 09:33:23 volumio sudo[3886]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 09:33:23 volumio volumio[1391]: info: touch_display: Setting screensaver timeout to 0 seconds. Dec 21 09:33:23 volumio systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Dec 21 09:33:23 volumio sudo[3886]: pam_unix(sudo:session): session closed for user root Dec 21 09:33:23 volumio volumio[1391]: info: peppymeterbasic Daemon Started Dec 21 09:33:25 volumio systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 21 09:33:25 volumio systemd[1]: peppymeterbasic.service: Consumed 1.039s CPU time. Dec 21 09:33:27 volumio volumio[1391]: info: CoreCommandRouter::volumioSeek Dec 21 09:33:27 volumio volumio[1391]: info: CoreStateMachine::seek Dec 21 09:33:27 volumio volumio[1391]: info: CorePlayQueue::getTrack 1 Dec 21 09:33:27 volumio volumio[1391]: info: TRACKBLOCK {"service":"personal_radio","type":"track","trackType":"개인 라디오","radioType":"mbc","albumart":"/albumart?sourceicon=music_service/personal_radio/logos/mbc1.png","uri":"webmbc/1","realUri":"https://minimw.imbc.com/dmfm/_definst_/mfm.stream/playlist.m3u8?_lsu_sa_=61A1311D83643A549A4F454635B1674EC5523EA5800B1292305008aA969D357688aD73563DC23C41903C3D515Ab141798B2D510DEBF20E22D9C2DB0C23AD5ECF7BBF427BF75EC4AF8A255DB8885CB4A1836F5FB51D2D2D4CC0077924D43EDE482C073130460D0AE058015ECA1E98E545","name":"MBC FM4U"} Dec 21 09:33:27 volumio volumio[1391]: info: CoreStateMachine::startPlaybackTimer Dec 21 09:33:27 volumio volumio[1391]: info: CorePlayQueue::getTrack 1 Dec 21 09:33:27 volumio volumio[1391]: info: CoreStateMachine::pushState Dec 21 09:33:27 volumio volumio[1391]: info: CorePlayQueue::getTrack 1 Dec 21 09:33:27 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState Dec 21 09:33:27 volumio volumio[1391]: info: FusionDsp - Volumio is playing Dec 21 09:33:27 volumio volumio[1391]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 21 09:33:27 volumio sudo[3908]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 21 09:33:27 volumio sudo[3908]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 09:33:27 volumio systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Dec 21 09:33:27 volumio sudo[3908]: pam_unix(sudo:session): session closed for user root Dec 21 09:33:27 volumio volumio[1391]: info: peppymeterbasic Daemon Started Dec 21 09:33:30 volumio systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 21 09:33:30 volumio systemd[1]: peppymeterbasic.service: Consumed 1.096s CPU time. Dec 21 09:33:57 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 21 09:33:57 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 21 09:34:02 volumio volumio[1391]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 21 09:34:02 volumio volumio[1391]: info: touch_display: About to detect HDMI ports... Dec 21 09:34:02 volumio volumio[1391]: info: touch_display: Detected HDMI ports: HDMI 0 (HDMI-1), HDMI 1 (HDMI-2) Dec 21 09:34:11 volumio volumio[1391]: info: CALLMETHOD: user_interface touch_display saveScreensaverConf [object Object] Dec 21 09:34:11 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: touch_display , saveScreensaverConf Dec 21 09:34:11 volumio volumio[1391]: info: CoreCommandRouter::volumioGetState Dec 21 09:34:11 volumio volumio[1391]: info: CorePlayQueue::getTrack 1 Dec 21 09:34:11 volumio volumio[1391]: info: touch_display: Setting screensaver timeout to 0 seconds. Dec 21 09:34:20 volumio volumio[1391]: info: CoreCommandRouter::volumioSeek Dec 21 09:34:20 volumio volumio[1391]: info: CoreStateMachine::seek Dec 21 09:34:20 volumio volumio[1391]: info: CorePlayQueue::getTrack 1 Dec 21 09:34:20 volumio volumio[1391]: info: TRACKBLOCK {"service":"personal_radio","type":"track","trackType":"개인 라디오","radioType":"mbc","albumart":"/albumart?sourceicon=music_service/personal_radio/logos/mbc1.png","uri":"webmbc/1","realUri":"https://minimw.imbc.com/dmfm/_definst_/mfm.stream/playlist.m3u8?_lsu_sa_=61A1311D83643A549A4F454635B1674EC5523EA5800B1292305008aA969D357688aD73563DC23C41903C3D515Ab141798B2D510DEBF20E22D9C2DB0C23AD5ECF7BBF427BF75EC4AF8A255DB8885CB4A1836F5FB51D2D2D4CC0077924D43EDE482C073130460D0AE058015ECA1E98E545","name":"MBC FM4U"} Dec 21 09:34:20 volumio volumio[1391]: info: CoreStateMachine::startPlaybackTimer Dec 21 09:34:20 volumio volumio[1391]: info: CorePlayQueue::getTrack 1 Dec 21 09:34:20 volumio volumio[1391]: info: CoreStateMachine::pushState Dec 21 09:34:20 volumio volumio[1391]: info: CorePlayQueue::getTrack 1 Dec 21 09:34:20 volumio volumio[1391]: info: CoreCommandRouter::volumioPushState Dec 21 09:34:20 volumio volumio[1391]: info: FusionDsp - Volumio is playing Dec 21 09:34:20 volumio volumio[1391]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 21 09:34:20 volumio sudo[4123]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 21 09:34:20 volumio sudo[4123]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 09:34:20 volumio systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Dec 21 09:34:20 volumio sudo[4123]: pam_unix(sudo:session): session closed for user root Dec 21 09:34:20 volumio volumio[1391]: info: peppymeterbasic Daemon Started Dec 21 09:34:24 volumio systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 21 09:34:24 volumio systemd[1]: peppymeterbasic.service: Consumed 1.142s CPU time. Dec 21 09:34:24 volumio kernel: usb usb1-port1: over-current change #64 Dec 21 09:34:24 volumio kernel: usb usb3-port1: over-current change #27 Dec 21 09:34:24 volumio kernel: usb usb4-port1: over-current change #71 Dec 21 09:34:24 volumio kernel: usb usb2-port1: over-current change #72 Dec 21 09:34:24 volumio kernel: usb usb1-port2: over-current change #57 Dec 21 09:34:26 volumio kernel: usb usb3-port1: attempt power cycle Dec 21 09:34:26 volumio kernel: usb 3-2: reset full-speed USB device number 31 using xhci-hcd Dec 21 09:34:28 volumio kernel: usb usb3-port1: unable to enumerate USB device Dec 21 09:34:28 volumio kernel: usb usb3-port2: over-current change #26 Dec 21 09:34:28 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Dec 21 09:34:28 volumio volumio[1391]: info: [youtube2-browse] browseUri: youtube2 Dec 21 09:34:33 volumio volumio[1391]: info: [youtube2] Innertube support service: Deno not installed or otherwise failed to start: Command failed: npx --no-install --yes deno --version Dec 21 09:34:33 volumio volumio[1391]: info: [youtube2] Innertube support service: Start service with Node Dec 21 09:34:33 volumio volumio[1391]: Upnp client error: Error: This socket has been ended by the other party Dec 21 09:34:34 volumio volumio[1391]: info: [youtube2] Innertube support service: result: {"status":"started","server":{"address":"127.0.0.1","port":34981}} Dec 21 09:34:34 volumio volumio[1391]: info: [youtube2] Innertube support service running at http://127.0.0.1:34981 Dec 21 09:34:38 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Dec 21 09:34:38 volumio volumio[1391]: info: Preload queue cleared Dec 21 09:34:39 volumio volumio[1391]: info: [youtube2] Obtained session PO token using datasyncIdToken (expires in 43199 seconds) Dec 21 09:34:41 volumio volumio[1391]: info: [youtube2] Going to refresh session PO token in 43099 seconds Dec 21 09:34:41 volumio volumio[1391]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Dec 21 09:34:41 volumio volumio[1391]: info: Preload queue cleared Dec 21 09:34:41 volumio volumio[1391]: info: Preloading song: webmbc/0 Dec 21 09:34:41 volumio volumio[1391]: info: Preloading song: webmbc/1 Dec 21 09:34:41 volumio volumio[1391]: info: Preloading song: webmbc/2 Dec 21 09:34:41 volumio volumio[1391]: info: Exploding uri webmbc/0 in service personal_radio Dec 21 09:34:41 volumio volumio[1391]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 21 09:34:41 volumio volumio[1391]: TypeError: Cannot read properties of null (reading 'startsWith') Dec 21 09:34:41 volumio volumio[1391]: at /data/plugins/music_service/personal_radio/index.js:675:41 Dec 21 09:34:41 volumio volumio[1391]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Dec 21 09:34:41 volumio volumio[1391]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 21 09:34:41 volumio sudo[4276]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-21 09:33' Dec 21 09:34:41 volumio sudo[4276]: 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"