Jun 22 22:52:04 player3b kernel: hwmon hwmon1: Voltage normalised Jun 22 22:52:06 player3b kernel: hwmon hwmon1: Undervoltage detected! Jun 22 22:52:14 player3b volumio[1058]: verbose: New Socket.io Connection to 192.168.29.71 from 192.168.29.109 UA: Mozilla/5.0 (Linux; Android 16; Pixel 7a Build/BP2A.250605.031.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jun 22 22:52:14 player3b volumio[1058]: info: CoreCommandRouter::volumioGetState Jun 22 22:52:14 player3b volumio[1058]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 22 22:52:14 player3b volumio[1058]: info: Listing playlists Jun 22 22:52:15 player3b volumio[1058]: verbose: New Socket.io Connection to 192.168.29.71:3000 from 192.168.29.109 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Jun 22 22:52:16 player3b volumio[1058]: info: CoreCommandRouter::volumioGetVisibleSources Jun 22 22:52:16 player3b volumio[1058]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 22:52:16 player3b volumio[1058]: info: CoreCommandRouter::volumioGetQueue Jun 22 22:52:16 player3b volumio[1058]: info: CoreStateMachine::getQueue Jun 22 22:52:16 player3b volumio[1058]: info: CorePlayQueue::getQueue Jun 22 22:52:18 player3b volumio[1058]: info: CorePlayQueue::getTrack 3 Jun 22 22:52:18 player3b volumio[1058]: info: CorePlayQueue::getTrack 4 Jun 22 22:52:18 player3b volumio[1058]: info: Prefetching next song Jun 22 22:52:19 player3b go-librespot[1348]: time="2025-06-22T22:52:19+05:30" level=trace msg="sent dealer ping" Jun 22 22:52:19 player3b volumio[1058]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-gwpa-jjwe.googlevideo.com/videoplayback?expire=1750634538&ei=yjtYaKvgGvGW4t4Pu_3E2Qg&ip=49.37.234.27&id=o-AIKPN0am8lumsXLTkFr0RUk975XFAWE1-GJlBSbFO64c&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750612938%2C&mh=Eh&mm=31%2C29&mn=sn-gwpa-jjwe%2Csn-gwpa-h55z&ms=au%2Crdu&mv=m&mvi=2&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=in&initcwndbps=392500&hightc=yes&siu=1&bui=AY1jyLNQr5LFRvNRdFGWbNYopx1-jE90e5qQ3OATw1KnXZkkqQciCEVlG9o1h0ZgbseFr3b2-g&spc=l3OVKVbt8oKlgQh4FT57FpqvXpU1VPZ56QfEkwep5885tna-JJ7BY6rumw9s5G0xYdEaEIwb9xAQgkk&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=5HxH10wycSp_lUm2ubbB4wIQ&rqh=1&gir=yes&clen=15354443&dur=417.581&lmt=1714825580583041&mt=1750612398&fvip=7&keepalive=yes&fexp=51466642%2C51466698&c=WEB_REMIX&sefc=1&txp=1318224&n=7bQ32AnTo4CDjA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgDMHDFgiaEzkGU4xPsba-1pt27qNnXaDEcTagg8VXyP0CIAx-OEgkKePgVPq5NWY97j7gnASWc7GX9QUN0UkiKWrk&sig=AJfQdSswRQIhAOSvliZquJUe66PMIMdd8gZCMV99PW0zbMHGTsLhAzINAiBrU7-XG3BPeqyJmmTUZ_3qer7QhYNS6HuzP-z-JN0lUA%3D%3D&pot=Ml9W0CEJCZySLVbs3aOfrbl8LzvHZE4h2jZiqSfbkrGkBG9yI01nLma-m1GoyepwS5mgLAhlKGtqgy5bZCGQyTeWVXZuxM4tCFh78_N_RvNYIqXXnfO7Jj01OlR0vhRsHQ%3D%3D&cver=1.20250219.01.00&t.YouTube" Jun 22 22:52:19 player3b volumio[1058]: info: Jun 22 22:52:19 player3b volumio[1058]: ---------------------------- MPD announces system playlist update Jun 22 22:52:19 player3b volumio[1058]: info: Ignoring MPD Status Update Jun 22 22:52:19 player3b volumio[1058]: info: sendMpdCommand addid "https://rr2---sn-gwpa-jjwe.googlevideo.com/videoplayback?expire=1750634538&ei=yjtYaKvgGvGW4t4Pu_3E2Qg&ip=49.37.234.27&id=o-AIKPN0am8lumsXLTkFr0RUk975XFAWE1-GJlBSbFO64c&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750612938%2C&mh=Eh&mm=31%2C29&mn=sn-gwpa-jjwe%2Csn-gwpa-h55z&ms=au%2Crdu&mv=m&mvi=2&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=in&initcwndbps=392500&hightc=yes&siu=1&bui=AY1jyLNQr5LFRvNRdFGWbNYopx1-jE90e5qQ3OATw1KnXZkkqQciCEVlG9o1h0ZgbseFr3b2-g&spc=l3OVKVbt8oKlgQh4FT57FpqvXpU1VPZ56QfEkwep5885tna-JJ7BY6rumw9s5G0xYdEaEIwb9xAQgkk&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=5HxH10wycSp_lUm2ubbB4wIQ&rqh=1&gir=yes&clen=15354443&dur=417.581&lmt=1714825580583041&mt=1750612398&fvip=7&keepalive=yes&fexp=51466642%2C51466698&c=WEB_REMIX&sefc=1&txp=1318224&n=7bQ32AnTo4CDjA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgDMHDFgiaEzkGU4xPsba-1pt27qNnXaDEcTagg8VXyP0CIAx-OEgkKePgVPq5NWY97j7gnASWc7GX9QUN0UkiKWrk&sig=AJfQdSswRQIhAOSvliZquJUe66PMIMdd8gZCMV99PW0zbMHGTsLhAzINAiBrU7-XG3BPeqyJmmTUZ_3qer7QhYNS6HuzP-z-JN0lUA%3D%3D&pot=Ml9W0CEJCZySLVbs3aOfrbl8LzvHZE4h2jZiqSfbkrGkBG9yI01nLma-m1GoyepwS5mgLAhlKGtqgy5bZCGQyTeWVXZuxM4tCFh78_N_RvNYIqXXnfO7Jj01OlR0vhRsHQ%3D%3D&cver=1.20250219.01.00&t.YouTube" took 15 milliseconds Jun 22 22:52:19 player3b volumio[1058]: verbose: MPD COMMAND [object Object] Jun 22 22:52:19 player3b volumio[1058]: verbose: MPD COMMAND [object Object] Jun 22 22:52:19 player3b volumio[1058]: verbose: MPD COMMAND [object Object] Jun 22 22:52:19 player3b volumio[1058]: info: Jun 22 22:52:19 player3b volumio[1058]: ---------------------------- MPD announces system playlist update Jun 22 22:52:19 player3b volumio[1058]: info: Ignoring MPD Status Update Jun 22 22:52:19 player3b volumio[1058]: info: ------------------------------ 8ms Jun 22 22:52:19 player3b volumio[1058]: info: [ytmusic-play] Prefetched and added track to MPD queue: Zindagi Jaam Se Jun 22 22:52:19 player3b volumio[1058]: verbose: ControllerMpd::sendMpdCommand consume 1 Jun 22 22:52:19 player3b volumio[1058]: info: ------------------------------ 7ms Jun 22 22:52:19 player3b volumio[1058]: info: sendMpdCommand consume 1 took 4 milliseconds Jun 22 22:52:19 player3b go-librespot[1348]: time="2025-06-22T22:52:19+05:30" level=trace msg="received dealer pong" Jun 22 22:52:21 player3b volumio[1058]: info: CoreCommandRouter::volumioPause Jun 22 22:52:21 player3b volumio[1058]: info: CoreStateMachine::pause Jun 22 22:52:21 player3b volumio[1058]: info: CoreStateMachine::stPlaybackTimer Jun 22 22:52:21 player3b volumio[1058]: info: CoreStateMachine::servicePause Jun 22 22:52:21 player3b volumio[1058]: info: CorePlayQueue::getTrack 3 Jun 22 22:52:21 player3b volumio[1058]: info: CoreCommandRouter::servicePause Jun 22 22:52:21 player3b volumio[1058]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 22 22:52:21 player3b volumio[1058]: info: ControllerMpd::pause Jun 22 22:52:21 player3b volumio[1058]: verbose: ControllerMpd::sendMpdCommand pause Jun 22 22:52:21 player3b volumio[1058]: info: ControllerMpd::getState Jun 22 22:52:21 player3b volumio[1058]: verbose: ControllerMpd::sendMpdCommand status Jun 22 22:52:21 player3b volumio[1058]: info: Jun 22 22:52:21 player3b volumio[1058]: ---------------------------- MPD announces state update: player Jun 22 22:52:21 player3b volumio[1058]: info: sendMpdCommand pause took 7 milliseconds Jun 22 22:52:21 player3b volumio[1058]: info: ControllerMpd::getState Jun 22 22:52:21 player3b volumio[1058]: verbose: ControllerMpd::sendMpdCommand status Jun 22 22:52:21 player3b volumio[1058]: info: sendMpdCommand status took 6 milliseconds Jun 22 22:52:21 player3b volumio[1058]: info: sendMpdCommand status took 4 milliseconds Jun 22 22:52:21 player3b volumio[1058]: verbose: ControllerMpd::parseState Jun 22 22:52:21 player3b volumio[1058]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 22 22:52:21 player3b volumio[1058]: verbose: ControllerMpd::parseState Jun 22 22:52:21 player3b volumio[1058]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 22 22:52:21 player3b volumio[1058]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 22 22:52:21 player3b volumio[1058]: info: sendMpdCommand playlistinfo took 8 milliseconds Jun 22 22:52:21 player3b volumio[1058]: verbose: ControllerMpd::parseTrackInfo Jun 22 22:52:21 player3b volumio[1058]: verbose: ControllerMpd::parseTrackInfo Jun 22 22:52:21 player3b volumio[1058]: info: ControllerMpd::pushState Jun 22 22:52:21 player3b volumio[1058]: info: CoreCommandRouter::servicePushState Jun 22 22:52:21 player3b volumio[1058]: info: CorePlayQueue::getTrack 3 Jun 22 22:52:21 player3b volumio[1058]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":364732,"duration":366,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sajdaa (From \"My Name Is Khan\")","artist":"Shankar Ehsaan Loy, Rahat Fateh Ali Khan, Shankar Mahadevan & Richa Sharma","album":"Kajol: Bollywood Darling","uri":"https://rr1---sn-gwpa-jv3l.googlevideo.com/videoplayback?expire=1750633998&ei=rjlYaKr0Ipzd3LUPrqOGuA0&ip=49.37.234.27&id=o-ALRv__WVCvPNyyIZLsisep6hp5swwVOuMaBPgUBQBCF_&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750612398%2C&mh=ND&mm=31%2C29&mn=sn-gwpa-jv3l%2Csn-gwpa-jwce&ms=au%2Crdu&mv=m&mvi=1&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=in&initcwndbps=408750&hightc=yes&siu=1&bui=AY1jyLMp1_hEfW8Sy2JQ5a0QGlUNa-Nq2oFNzK6IUx62jq4Sdx4nL_EfVV2ul3BjmVRzJ2Ku1Q&spc=l3OVKfahhpsXQJ1JS5795Zu7R13MmlBy7DLukYLLSc-oEOkxBOp7yuKh3FyKutPn_ELeLl274tVnZrM&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=jnRcrPizgvNJ5f4I9oVk8fsQ&rqh=1&gir=yes&clen=12514381&dur=365.721&lmt=1714526761140598&mt=1750611920&fvip=2&keepalive=yes&fexp=51466642%2C51466698&c=WEB_REMIX&sefc=1&txp=5532434&n=vh5febOoEo-91g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgav1HVGT0dTIl9LR1DJPhx3vMP17h24mer84-eXXKwWgCIQDFz-s0SIKfUUZq5fQZhdeTwLnRfmzgj6KuJqBoDCgBKA%3D%3D&sig=AJfQdSswRAIgeJ07M5OYUtGHc4-RR32Ie9glOJmAesD44bTaexsSv-YCIBz3kmbjG2h-vXJ9nZB0OkPwdieq8zAizsWlZlZXBANb&pot=Ml9W0CEJCZySLVbs3aOfrbl8LzvHZE4h2jZiqSfbkrGkBG9yI01nLma-m1GoyepwS5mgLAhlKGtqgy5bZCGQyTeWVXZuxM4tCFh78_N_RvNYIqXXnfO7Jj01OlR0vhRsHQ%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 22 22:52:21 player3b volumio[1058]: verbose: CURRENT POSITION 3 Jun 22 22:52:21 player3b volumio[1058]: info: CoreStateMachine::syncState stateService pause Jun 22 22:52:21 player3b volumio[1058]: info: CoreStateMachine::syncState currentStatus pause Jun 22 22:52:21 player3b volumio[1058]: info: CoreStateMachine::pushState Jun 22 22:52:21 player3b volumio[1058]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 22:52:21 player3b volumio[1058]: info: CoreCommandRouter::volumioPushState Jun 22 22:52:21 player3b volumio[1058]: info: CoreStateMachine::stPlaybackTimer Jun 22 22:52:21 player3b volumio[1058]: info: ------------------------------ 48ms Jun 22 22:52:21 player3b volumio[1058]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Jun 22 22:52:35 player3b kernel: hwmon hwmon1: Voltage normalised Jun 22 22:52:37 player3b systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 22 22:52:37 player3b dbus-daemon[510]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.374' (uid=0 pid=24982 comm="timedatectl show --property=NTPSynchronized --valu") Jun 22 22:52:37 player3b systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 22 22:52:37 player3b dbus-daemon[510]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 22 22:52:37 player3b systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 22 22:52:37 player3b setdatetime-helper.sh[24981]: Time is already synchronized. Jun 22 22:52:37 player3b systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 22 22:52:37 player3b systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 22 22:52:37 player3b kernel: hwmon hwmon1: Undervoltage detected! Jun 22 22:52:46 player3b kernel: hwmon hwmon1: Voltage normalised Jun 22 22:52:49 player3b go-librespot[1348]: time="2025-06-22T22:52:49+05:30" level=trace msg="sent dealer ping" Jun 22 22:52:49 player3b go-librespot[1348]: time="2025-06-22T22:52:49+05:30" level=trace msg="received dealer pong" Jun 22 22:52:50 player3b kernel: hwmon hwmon1: Undervoltage detected! Jun 22 22:53:00 player3b volumio[1058]: Searching all installed plugins Jun 22 22:53:00 player3b volumio[1058]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 22:53:00 player3b volumio[1058]: info: CoreCommandRouter::executeOnPlugin: , search Jun 22 22:53:00 player3b volumio[1058]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 22 22:53:00 player3b volumio[1058]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jun 22 22:53:00 player3b volumio[1058]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jun 22 22:53:00 player3b volumio[1058]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jun 22 22:53:00 player3b volumio[1058]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jun 22 22:53:00 player3b volumio[1058]: info: CoreCommandRouter::executeOnPlugin: spop , search Jun 22 22:53:01 player3b volumio[1058]: info: New access token = BQBKNdVVFSs5yOGH7UTp9u9yP0JbvAKps4UmsXY4ZCkrwGwCI5UxwXo1NVoOcUWPUxHhWdE1Q3or4_5ZYqYsv2GtYHD6a8lP-g2j8YAAiAtxnhegQ2GcCg8HCNj1xlz3tUovAFLW8kxZxroIPUews-AciCn38LIz09TxWJxe4OErHM1fNvMYmonbkxcorrpMGyOtlwP_0i-LgC3DNxvoVJRk-g2lhz_zca5Nj9LhwY2TI9SH9KdlS7LQlSPAMkmmmZhBRjE2J7ue-VtOZ7vYPX06vHUqwiHgiFfD62w3YXqv-A0 Jun 22 22:53:01 player3b volumio[1058]: Use XMLElement.setAttribute instead Jun 22 22:53:01 player3b volumio[1058]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 22:53:01 player3b volumio[1058]: TypeError: children[i].attr(...).value is not a function Jun 22 22:53:01 player3b volumio[1058]: at /volumio/app/plugins/music_service/webradio/index.js:956:46 Jun 22 22:53:01 player3b volumio[1058]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jun 22 22:53:01 player3b volumio[1058]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 22:53:02 player3b sudo[25044]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-22 22:52' Jun 22 22:53:02 player3b sudo[25044]: 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="cee9bb5b0ee50e4898478097a64b5c6c77d5a212" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Jun 14 07:24:14 UTC 2025" VOLUMIO_VERSION="4.012" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b365b054264e3ebc2709665da2b5d1ee"