Jun 21 23:08:00 volumio-sala-rp2 volumio[18793]: info: CoreCommandRouter::volumioGetState
Jun 21 23:08:00 volumio-sala-rp2 volumio[18793]: info: CorePlayQueue::getTrack 45
Jun 21 23:08:00 volumio-sala-rp2 volumio[18793]: info: Listing playlists
Jun 21 23:08:00 volumio-sala-rp2 volumio[18793]: info: Listing playlists
Jun 21 23:08:11 volumio-sala-rp2 volumio[18793]: info: CoreCommandRouter::volumioGetState
Jun 21 23:08:11 volumio-sala-rp2 volumio[18793]: info: CorePlayQueue::getTrack 45
Jun 21 23:08:11 volumio-sala-rp2 systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service...
Jun 21 23:08:11 volumio-sala-rp2 dbus-daemon[460]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.4265' (uid=0 pid=21052 comm="timedatectl show --property=NTPSynchronized --valu")
Jun 21 23:08:11 volumio-sala-rp2 systemd[1]: Starting systemd-timedated.service - Time & Date Service...
Jun 21 23:08:12 volumio-sala-rp2 dbus-daemon[460]: [system] Successfully activated service 'org.freedesktop.timedate1'
Jun 21 23:08:12 volumio-sala-rp2 systemd[1]: Started systemd-timedated.service - Time & Date Service.
Jun 21 23:08:12 volumio-sala-rp2 setdatetime-helper.sh[21051]: Time is already synchronized.
Jun 21 23:08:12 volumio-sala-rp2 systemd[1]: setdatetime-helper.timer.service: Deactivated successfully.
Jun 21 23:08:12 volumio-sala-rp2 systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service.
Jun 21 23:08:21 volumio-sala-rp2 volumio[18793]: info: CoreCommandRouter::volumioGetState
Jun 21 23:08:21 volumio-sala-rp2 volumio[18793]: info: CorePlayQueue::getTrack 45
Jun 21 23:08:21 volumio-sala-rp2 volumio[18793]: info: Listing playlists
Jun 21 23:08:21 volumio-sala-rp2 volumio[18793]: info: Listing playlists
Jun 21 23:08:31 volumio-sala-rp2 volumio[18793]: info: CoreCommandRouter::volumioGetState
Jun 21 23:08:31 volumio-sala-rp2 volumio[18793]: info: CorePlayQueue::getTrack 45
Jun 21 23:08:41 volumio-sala-rp2 volumio[18793]: info: CoreCommandRouter::volumioGetState
Jun 21 23:08:41 volumio-sala-rp2 volumio[18793]: info: CorePlayQueue::getTrack 45
Jun 21 23:08:41 volumio-sala-rp2 volumio[18793]: info: Listing playlists
Jun 21 23:08:41 volumio-sala-rp2 volumio[18793]: info: Listing playlists
Jun 21 23:08:42 volumio-sala-rp2 systemd[1]: systemd-timedated.service: Deactivated successfully.
Jun 21 23:08:51 volumio-sala-rp2 volumio[18793]: info: CoreCommandRouter::volumioGetState
Jun 21 23:08:51 volumio-sala-rp2 volumio[18793]: info: CorePlayQueue::getTrack 45
Jun 21 23:08:52 volumio-sala-rp2 volumio[18793]: info: CorePlayQueue::getTrack 45
Jun 21 23:08:52 volumio-sala-rp2 volumio[18793]: info: CorePlayQueue::getTrack 58
Jun 21 23:08:52 volumio-sala-rp2 volumio[18793]: info: Prefetching next song
Jun 21 23:08:53 volumio-sala-rp2 volumio[18793]: warn: [youtube2] Error getting stream with default client in VideoModel.getInfo(ko_EIHinv-o): No valid URL to decipher - retry with 'WEB_EMBEDDED' client.
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-1vo-apn6.googlevideo.com/videoplayback?expire=1750565333&ei=dS1XaPq0B6Xbp-oPx-i3gQM&ip=95.95.180.164&id=o-AH92HtF8ppxuK0I_6mnUiLca26SreV357EP1HnXQVY-P&itag=140&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750543733%2C&mh=qU&mm=31%2C26&mn=sn-1vo-apn6%2Csn-h5q7knez&ms=au%2Conr&mv=m&mvi=2&pl=20&rms=au%2Cau&initcwndbps=1690000&bui=AY1jyLODmjYlGqpDt1F0mwPxX7C-v4-Bh5oco06qDy7e4feR4X9CyYKqA_eWPP1W__VdFPHSlrWCnjdd&spc=l3OVKWOce54odoQ0-lbIIHXPFC6J3-kyLDGQleeQBfhihgUkOrMTZA&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=vmQRA2pD7lR2kCfeVzbV2sUQ&rqh=1&gir=yes&clen=5757564&dur=355.706&lmt=1739474398576288&mt=1750543510&fvip=1&keepalive=yes&fexp=51466643%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=8208224&n=6Iq0s6S6ztCq2g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhAPgQB4xXDvV4q1geRoasFZ9KUKQxtwoCMk9huvZ4FBmcAiB2EyFaOdIVbhgZWdCFOg2MCJ6eeSyXvWmeJUXA2umuOA%3D%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAPfDNCGM8HOYGLBraGv36_3sqTmSlZq0dHc3TOCoJVPWAiEAr98HdORLLggIJ0ESbWC_R_A0--m_Nwt0pN0eO0bQW7Y%3D&pot=MpgB2ZWndv5KAKfZqeX1m7sgQTfz51c_wZcyCrhIFiWZKa82fw6GbULB3du2w3AWtti7iA359bDiaD8eVt_V7h4IaGrdM32RaWFydPAT7hZzl9Dp6zwIoAeG4kneKAEoYhHQPOpZ-19KtnXPvhy75b2L3HHxPhse2sJ7kaXzT48rYCrGDeTNDrDUXJmpJCElBfvJh6bp46s_sfw%3D&cver=1.20250219.01.00&t.YouTube"
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info:
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: ---------------------------- MPD announces system playlist update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: Ignoring MPD Status Update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: sendMpdCommand addid "https://rr2---sn-1vo-apn6.googlevideo.com/videoplayback?expire=1750565333&ei=dS1XaPq0B6Xbp-oPx-i3gQM&ip=95.95.180.164&id=o-AH92HtF8ppxuK0I_6mnUiLca26SreV357EP1HnXQVY-P&itag=140&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750543733%2C&mh=qU&mm=31%2C26&mn=sn-1vo-apn6%2Csn-h5q7knez&ms=au%2Conr&mv=m&mvi=2&pl=20&rms=au%2Cau&initcwndbps=1690000&bui=AY1jyLODmjYlGqpDt1F0mwPxX7C-v4-Bh5oco06qDy7e4feR4X9CyYKqA_eWPP1W__VdFPHSlrWCnjdd&spc=l3OVKWOce54odoQ0-lbIIHXPFC6J3-kyLDGQleeQBfhihgUkOrMTZA&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=vmQRA2pD7lR2kCfeVzbV2sUQ&rqh=1&gir=yes&clen=5757564&dur=355.706&lmt=1739474398576288&mt=1750543510&fvip=1&keepalive=yes&fexp=51466643%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=8208224&n=6Iq0s6S6ztCq2g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhAPgQB4xXDvV4q1geRoasFZ9KUKQxtwoCMk9huvZ4FBmcAiB2EyFaOdIVbhgZWdCFOg2MCJ6eeSyXvWmeJUXA2umuOA%3D%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAPfDNCGM8HOYGLBraGv36_3sqTmSlZq0dHc3TOCoJVPWAiEAr98HdORLLggIJ0ESbWC_R_A0--m_Nwt0pN0eO0bQW7Y%3D&pot=MpgB2ZWndv5KAKfZqeX1m7sgQTfz51c_wZcyCrhIFiWZKa82fw6GbULB3du2w3AWtti7iA359bDiaD8eVt_V7h4IaGrdM32RaWFydPAT7hZzl9Dp6zwIoAeG4kneKAEoYhHQPOpZ-19KtnXPvhy75b2L3HHxPhse2sJ7kaXzT48rYCrGDeTNDrDUXJmpJCElBfvJh6bp46s_sfw%3D&cver=1.20250219.01.00&t.YouTube" took 5 milliseconds
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: verbose: MPD COMMAND [object Object]
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: verbose: MPD COMMAND [object Object]
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: verbose: MPD COMMAND [object Object]
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info:
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: ---------------------------- MPD announces system playlist update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: Ignoring MPD Status Update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info:
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: ---------------------------- MPD announces system playlist update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: Ignoring MPD Status Update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info:
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: ---------------------------- MPD announces system playlist update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: Ignoring MPD Status Update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info:
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: ---------------------------- MPD announces system playlist update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: Ignoring MPD Status Update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: ------------------------------ 45ms
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: [youtube2-play] Prefetched and added track to MPD queue: How to record heavy guitar 2 - Dialing in your amp | Spectresoundstudios TUTORIAL
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: verbose: ControllerMpd::sendMpdCommand consume 1
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info:
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: ---------------------------- MPD announces system playlist update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: Ignoring MPD Status Update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: ------------------------------ 74ms
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info:
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: ---------------------------- MPD announces system playlist update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: Ignoring MPD Status Update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info:
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: ---------------------------- MPD announces system playlist update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: Ignoring MPD Status Update
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: ------------------------------ 105ms
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: ------------------------------ 125ms
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: ------------------------------ 119ms
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: sendMpdCommand consume 1 took 117 milliseconds
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: ------------------------------ 138ms
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: ------------------------------ 130ms
Jun 21 23:08:54 volumio-sala-rp2 volumio[18793]: info: ------------------------------ 154ms
Jun 21 23:08:56 volumio-sala-rp2 volumio[18793]: info: CoreStateMachine::startPlaybackTimer
Jun 21 23:08:56 volumio-sala-rp2 volumio[18793]: info: CorePlayQueue::getTrack 58
Jun 21 23:08:57 volumio-sala-rp2 volumio[18793]: info: CoreStateMachine::pushState
Jun 21 23:08:57 volumio-sala-rp2 volumio[18793]: info: CorePlayQueue::getTrack 58
Jun 21 23:08:57 volumio-sala-rp2 volumio[18793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 21 23:08:57 volumio-sala-rp2 volumio[18793]: info: CoreCommandRouter::volumioPushState
Jun 21 23:08:57 volumio-sala-rp2 volumio[18793]: info: CorePlayQueue::getTrack 58
Jun 21 23:08:57 volumio-sala-rp2 volumio[18793]: info: CorePlayQueue::getTrack 58
Jun 21 23:09:01 volumio-sala-rp2 volumio[18793]: info: CoreCommandRouter::volumioGetState
Jun 21 23:09:01 volumio-sala-rp2 volumio[18793]: info: CorePlayQueue::getTrack 58
Jun 21 23:09:01 volumio-sala-rp2 volumio[18793]: info: Listing playlists
Jun 21 23:09:01 volumio-sala-rp2 volumio[18793]: info: Listing playlists
Jun 21 23:09:11 volumio-sala-rp2 volumio[18793]: info: CoreCommandRouter::volumioGetState
Jun 21 23:09:11 volumio-sala-rp2 volumio[18793]: info: CorePlayQueue::getTrack 58
Jun 21 23:09:21 volumio-sala-rp2 volumio[18793]: info: CoreCommandRouter::volumioGetState
Jun 21 23:09:21 volumio-sala-rp2 volumio[18793]: info: CorePlayQueue::getTrack 58
Jun 21 23:09:21 volumio-sala-rp2 volumio[18793]: info: Listing playlists
Jun 21 23:09:21 volumio-sala-rp2 volumio[18793]: info: Listing playlists
Jun 21 23:09:24 volumio-sala-rp2 volumio[18793]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jun 21 23:09:24 volumio-sala-rp2 volumio[18793]: info: Preload queue cleared
Jun 21 23:09:25 volumio-sala-rp2 volumio[18793]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jun 21 23:09:26 volumio-sala-rp2 volumio[18793]: info: READ
Jun 21 23:09:26 volumio-sala-rp2 volumio[18793]: Use XMLElement.setAttribute instead
Jun 21 23:09:26 volumio-sala-rp2 volumio[18793]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 21 23:09:26 volumio-sala-rp2 volumio[18793]: TypeError: children[i].attr(...).value is not a function
Jun 21 23:09:26 volumio-sala-rp2 volumio[18793]: at /volumio/app/plugins/music_service/webradio/index.js:286:47
Jun 21 23:09:26 volumio-sala-rp2 volumio[18793]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
Jun 21 23:09:26 volumio-sala-rp2 volumio[18793]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 21 23:09:27 volumio-sala-rp2 sudo[21176]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-21 23:08'
Jun 21 23:09:27 volumio-sala-rp2 sudo[21176]: 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"