Jun 19 18:49:36 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 19 18:49:36 volumio dbus-daemon[565]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.23' (uid=0 pid=1952 comm="timedatectl show --property=NTPSynchronized --valu") Jun 19 18:49:36 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 19 18:49:36 volumio dbus-daemon[565]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 19 18:49:36 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 19 18:49:36 volumio setdatetime-helper.sh[1951]: Time is not synchronized. Attempting to sync... Jun 19 18:49:36 volumio sudo[1960]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Thu, 19 Jun 2025 16:49:37 GMT#015' Jun 19 18:49:36 volumio sudo[1960]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 19 18:49:37 volumio setdatetime-helper.sh[1961]: Thu Jun 19 18:49:37 CEST 2025 Jun 19 18:49:37 volumio sudo[1960]: pam_unix(sudo:session): session closed for user root Jun 19 18:49:37 volumio setdatetime-helper.sh[1951]: Time synchronized successfully. Jun 19 18:49:37 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 19 18:49:37 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 19 18:49:55 volumio volumio[974]: verbose: New Socket.io Connection to 192.168.178.15 from 192.168.178.20 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jun 19 18:49:55 volumio volumio[974]: verbose: New Socket.io Connection to 192.168.178.15 from 192.168.178.20 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jun 19 18:49:55 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 19 18:49:55 volumio volumio[974]: info: CoreCommandRouter::volumioGetVisibleSources Jun 19 18:49:55 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 19 18:49:55 volumio volumio[974]: info: CoreCommandRouter::volumioGetState Jun 19 18:49:55 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Jun 19 18:49:55 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 19 18:49:55 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 19 18:49:55 volumio volumio[974]: info: Received Get System Info Jun 19 18:49:55 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 19 18:49:55 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 19 18:49:55 volumio volumio[974]: info: Discovery: Getting this device information Jun 19 18:49:55 volumio volumio[974]: info: CoreCommandRouter::volumioGetState Jun 19 18:49:55 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Jun 19 18:49:55 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 19 18:49:55 volumio volumio[974]: info: CoreCommandRouter::volumioGetState Jun 19 18:49:55 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Jun 19 18:49:55 volumio volumio[974]: info: Listing playlists Jun 19 18:49:55 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 19 18:49:59 volumio volumio[974]: info: CoreCommandRouter::volumioPlay Jun 19 18:49:59 volumio volumio[974]: info: CoreStateMachine::play index undefined Jun 19 18:49:59 volumio volumio[974]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 19 18:49:59 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Jun 19 18:49:59 volumio volumio[974]: info: CoreStateMachine::startPlaybackTimer Jun 19 18:49:59 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Jun 19 18:49:59 volumio volumio[974]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Ibiza%20Lounge%20Bar%20Luxury%20Lounge%20%26%20Chillout%20Mix%20(Continuous%20DJ%20Mix)%22%2C%22artist%22%3A%22DJ%20Mix%22%2C%22album%22%3A%22Ibiza%20Lounge%20Bar%20Luxury%20Lounge%20%26%20Chillout%20Tunes%20(The%20Best%20of%20Extraordinary%20Chillout%20Lounge%20%26%20Downbeat)%20%26%20DJ%20Mix%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2Fn3KroVCxLOOJQVPA9vpLLpBZQBOmm5QXCD1KOdNoZ6VbuFMiIukKjQYg5Za8LKkrXgYEJsYIqOt6jQ7I%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22W0dYuyF_jF8%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22W0dYuyF_jF8%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D Jun 19 18:49:59 volumio volumio[974]: info: [ytmusic] InnertubeLoader: creating Innertube instance... Jun 19 18:50:02 volumio volumio[974]: info: [ytmusic] InnertubeLoader: obtaining po_token by datasyncIdToken... Jun 19 18:50:02 volumio volumio[974]: info: [ytmusic] InnertubeLoader: obtained po_token (expires in 43200 seconds) Jun 19 18:50:02 volumio volumio[974]: info: [ytmusic] InnertubeLoader: re-create Innertube instance with po_token Jun 19 18:50:02 volumio volumio[974]: info: [ytmusic] InnertubeLoader: creating Innertube instance with po_token... Jun 19 18:50:03 volumio volumio[974]: info: [ytmusic] InnertubeLoader: going to refresh po_token in 43100 seconds Jun 19 18:50:04 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Jun 19 18:50:04 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand stop Jun 19 18:50:04 volumio volumio[974]: info: sendMpdCommand stop took 1 milliseconds Jun 19 18:50:04 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand clear Jun 19 18:50:04 volumio volumio[974]: info: Jun 19 18:50:04 volumio volumio[974]: ---------------------------- MPD announces system playlist update Jun 19 18:50:04 volumio volumio[974]: info: Ignoring MPD Status Update Jun 19 18:50:04 volumio volumio[974]: info: sendMpdCommand clear took 0 milliseconds Jun 19 18:50:04 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-8xgn5uxa-4g5s.googlevideo.com/videoplayback?expire=1750373404&ei=vD9UaO3PIfqIzPsP7tri6Ac&ip=87.122.121.127&id=o-AH-KIcOCjBm8KTDEWVuq0iyb785pZY3H0epo2VHz8vTB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750351804%2C&mh=zu&mm=31%2C29&mn=sn-8xgn5uxa-4g5s%2Csn-4g5lznle&ms=au%2Crdu&mv=m&mvi=2&pl=19&rms=au%2Cau&gcr=de&initcwndbps=2928750&siu=1&bui=AY1jyLNpgeDrWCoGotfEoROswKfR6bv5G_oAvK-zubJhBJmmq_i-sbqbuRkj6Uwuk24uykrO0A&spc=l3OVKU37ooNhna_SebIvMGERTHoFc1N3C_L1-fhi9WFjlCeoTwgj9AKgyQO7ySO7liNlaSdElDTc7sIV6V8&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=A29suCL7dXxdq_ZziUPM1dIQ&rqh=1&gir=yes&clen=92189079&dur=5407.781&lmt=1714672627448312&mt=1750351163&fvip=4&keepalive=yes&fexp=51466642%2C51466697&c=WEB_REMIX&sefc=1&txp=1318224&n=_MjaWHp1-8GZ6Q&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAPzUwVBTpGGtK6qM2gpQr4KZi510O2kZdKOEfp9FpY5YAiBPLfhKks58RLidB5j_1CePDvtNFyesWdGWKh9GDyF5mA%3D%3D&sig=AJfQdSswRQIgPAFnZSReqC-wRRWEYjTQcvy1ablzkNfYHwVPPPSmE2sCIQCK-dq8gDJ3XgmqlxqkUUarpckydJVvOFceVqma6kntXQ%3D%3D&pot=Ml_Ovk4jp1Tlus6CdoKagXGTpl1VYm0e_pePeJW3pBHp0M-zT7cmKqxluG5l1m6ANd7J9hZe7fELNScs-OFpapD96aV3fMSIVmClHpEKvxEKmid7HCnfN08qE0MotWez4w%3D%3D&cver=1.20250219.01.00&t.YouTube" Jun 19 18:50:04 volumio volumio[974]: info: Jun 19 18:50:04 volumio volumio[974]: ---------------------------- MPD announces system playlist update Jun 19 18:50:04 volumio volumio[974]: info: Ignoring MPD Status Update Jun 19 18:50:04 volumio volumio[974]: info: Jun 19 18:50:04 volumio volumio[974]: ---------------------------- MPD announces system playlist update Jun 19 18:50:04 volumio volumio[974]: info: Ignoring MPD Status Update Jun 19 18:50:04 volumio volumio[974]: error: updateQueue error: null Jun 19 18:50:04 volumio volumio[974]: info: Jun 19 18:50:04 volumio volumio[974]: ---------------------------- MPD announces system playlist update Jun 19 18:50:04 volumio volumio[974]: info: Ignoring MPD Status Update Jun 19 18:50:04 volumio volumio[974]: info: ------------------------------ 3ms Jun 19 18:50:04 volumio volumio[974]: info: sendMpdCommand addid "https://rr2---sn-8xgn5uxa-4g5s.googlevideo.com/videoplayback?expire=1750373404&ei=vD9UaO3PIfqIzPsP7tri6Ac&ip=87.122.121.127&id=o-AH-KIcOCjBm8KTDEWVuq0iyb785pZY3H0epo2VHz8vTB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750351804%2C&mh=zu&mm=31%2C29&mn=sn-8xgn5uxa-4g5s%2Csn-4g5lznle&ms=au%2Crdu&mv=m&mvi=2&pl=19&rms=au%2Cau&gcr=de&initcwndbps=2928750&siu=1&bui=AY1jyLNpgeDrWCoGotfEoROswKfR6bv5G_oAvK-zubJhBJmmq_i-sbqbuRkj6Uwuk24uykrO0A&spc=l3OVKU37ooNhna_SebIvMGERTHoFc1N3C_L1-fhi9WFjlCeoTwgj9AKgyQO7ySO7liNlaSdElDTc7sIV6V8&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=A29suCL7dXxdq_ZziUPM1dIQ&rqh=1&gir=yes&clen=92189079&dur=5407.781&lmt=1714672627448312&mt=1750351163&fvip=4&keepalive=yes&fexp=51466642%2C51466697&c=WEB_REMIX&sefc=1&txp=1318224&n=_MjaWHp1-8GZ6Q&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAPzUwVBTpGGtK6qM2gpQr4KZi510O2kZdKOEfp9FpY5YAiBPLfhKks58RLidB5j_1CePDvtNFyesWdGWKh9GDyF5mA%3D%3D&sig=AJfQdSswRQIgPAFnZSReqC-wRRWEYjTQcvy1ablzkNfYHwVPPPSmE2sCIQCK-dq8gDJ3XgmqlxqkUUarpckydJVvOFceVqma6kntXQ%3D%3D&pot=Ml_Ovk4jp1Tlus6CdoKagXGTpl1VYm0e_pePeJW3pBHp0M-zT7cmKqxluG5l1m6ANd7J9hZe7fELNScs-OFpapD96aV3fMSIVmClHpEKvxEKmid7HCnfN08qE0MotWez4w%3D%3D&cver=1.20250219.01.00&t.YouTube" took 3 milliseconds Jun 19 18:50:04 volumio volumio[974]: info: ------------------------------ 3ms Jun 19 18:50:04 volumio volumio[974]: info: ------------------------------ 2ms Jun 19 18:50:04 volumio volumio[974]: verbose: MPD COMMAND [object Object] Jun 19 18:50:04 volumio volumio[974]: verbose: MPD COMMAND [object Object] Jun 19 18:50:04 volumio volumio[974]: verbose: MPD COMMAND [object Object] Jun 19 18:50:04 volumio volumio[974]: info: Jun 19 18:50:04 volumio volumio[974]: ---------------------------- MPD announces system playlist update Jun 19 18:50:04 volumio volumio[974]: info: Ignoring MPD Status Update Jun 19 18:50:04 volumio volumio[974]: info: Jun 19 18:50:04 volumio volumio[974]: ---------------------------- MPD announces system playlist update Jun 19 18:50:04 volumio volumio[974]: info: Ignoring MPD Status Update Jun 19 18:50:04 volumio volumio[974]: info: Jun 19 18:50:04 volumio volumio[974]: ---------------------------- MPD announces system playlist update Jun 19 18:50:04 volumio volumio[974]: info: Ignoring MPD Status Update Jun 19 18:50:04 volumio volumio[974]: info: ------------------------------ 3ms Jun 19 18:50:04 volumio volumio[974]: info: ------------------------------ 2ms Jun 19 18:50:04 volumio volumio[974]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 19 18:50:04 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand play Jun 19 18:50:04 volumio volumio[974]: info: Jun 19 18:50:04 volumio volumio[974]: ---------------------------- MPD announces system playlist update Jun 19 18:50:04 volumio volumio[974]: info: Ignoring MPD Status Update Jun 19 18:50:04 volumio volumio[974]: info: Jun 19 18:50:04 volumio volumio[974]: ---------------------------- MPD announces system playlist update Jun 19 18:50:04 volumio volumio[974]: info: Ignoring MPD Status Update Jun 19 18:50:04 volumio volumio[974]: info: ------------------------------ 4ms Jun 19 18:50:04 volumio volumio[974]: info: ------------------------------ 3ms Jun 19 18:50:04 volumio volumio[974]: info: sendMpdCommand play took 2 milliseconds Jun 19 18:50:04 volumio volumio[974]: info: ------------------------------ 2ms Jun 19 18:50:04 volumio volumio[974]: info: ------------------------------ 1ms Jun 19 18:50:05 volumio volumio[974]: info: Jun 19 18:50:05 volumio volumio[974]: ---------------------------- MPD announces state update: player Jun 19 18:50:05 volumio volumio[974]: info: ControllerMpd::getState Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Jun 19 18:50:05 volumio volumio[974]: info: Jun 19 18:50:05 volumio volumio[974]: ---------------------------- MPD announces state update: player Jun 19 18:50:05 volumio volumio[974]: info: ControllerMpd::getState Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Jun 19 18:50:05 volumio volumio[974]: info: Jun 19 18:50:05 volumio volumio[974]: ---------------------------- MPD announces state update: player Jun 19 18:50:05 volumio volumio[974]: info: ControllerMpd::getState Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Jun 19 18:50:05 volumio volumio[974]: info: sendMpdCommand status took 3 milliseconds Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::parseState Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 19 18:50:05 volumio volumio[974]: info: Jun 19 18:50:05 volumio volumio[974]: ---------------------------- MPD announces state update: player Jun 19 18:50:05 volumio volumio[974]: info: ControllerMpd::getState Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Jun 19 18:50:05 volumio volumio[974]: info: Jun 19 18:50:05 volumio volumio[974]: ---------------------------- MPD announces state update: player Jun 19 18:50:05 volumio volumio[974]: info: ControllerMpd::getState Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Jun 19 18:50:05 volumio volumio[974]: info: sendMpdCommand status took 3 milliseconds Jun 19 18:50:05 volumio volumio[974]: info: sendMpdCommand status took 3 milliseconds Jun 19 18:50:05 volumio volumio[974]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 19 18:50:05 volumio volumio[974]: info: sendMpdCommand status took 2 milliseconds Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::parseState Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::parseState Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::parseState Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 19 18:50:05 volumio volumio[974]: info: ControllerMpd::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::servicePushState Jun 19 18:50:05 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Jun 19 18:50:05 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5408,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ibiza Lounge Bar Luxury Lounge & Chillout Mix (Continuous DJ Mix)","artist":"DJ Mix","album":"Ibiza Lounge Bar Luxury Lounge & Chillout Tunes (The Best of Extraordinary Chillout Lounge & Downbeat) & DJ Mix","uri":"https://rr2---sn-8xgn5uxa-4g5s.googlevideo.com/videoplayback?expire=1750373404&ei=vD9UaO3PIfqIzPsP7tri6Ac&ip=87.122.121.127&id=o-AH-KIcOCjBm8KTDEWVuq0iyb785pZY3H0epo2VHz8vTB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750351804%2C&mh=zu&mm=31%2C29&mn=sn-8xgn5uxa-4g5s%2Csn-4g5lznle&ms=au%2Crdu&mv=m&mvi=2&pl=19&rms=au%2Cau&gcr=de&initcwndbps=2928750&siu=1&bui=AY1jyLNpgeDrWCoGotfEoROswKfR6bv5G_oAvK-zubJhBJmmq_i-sbqbuRkj6Uwuk24uykrO0A&spc=l3OVKU37ooNhna_SebIvMGERTHoFc1N3C_L1-fhi9WFjlCeoTwgj9AKgyQO7ySO7liNlaSdElDTc7sIV6V8&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=A29suCL7dXxdq_ZziUPM1dIQ&rqh=1&gir=yes&clen=92189079&dur=5407.781&lmt=1714672627448312&mt=1750351163&fvip=4&keepalive=yes&fexp=51466642%2C51466697&c=WEB_REMIX&sefc=1&txp=1318224&n=_MjaWHp1-8GZ6Q&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAPzUwVBTpGGtK6qM2gpQr4KZi510O2kZdKOEfp9FpY5YAiBPLfhKks58RLidB5j_1CePDvtNFyesWdGWKh9GDyF5mA%3D%3D&sig=AJfQdSswRQIgPAFnZSReqC-wRRWEYjTQcvy1ablzkNfYHwVPPPSmE2sCIQCK-dq8gDJ3XgmqlxqkUUarpckydJVvOFceVqma6kntXQ%3D%3D&pot=Ml_Ovk4jp1Tlus6CdoKagXGTpl1VYm0e_pePeJW3pBHp0M-zT7cmKqxluG5l1m6ANd7J9hZe7fELNScs-OFpapD96aV3fMSIVmClHpEKvxEKmid7HCnfN08qE0MotWez4w%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 19 18:50:05 volumio volumio[974]: verbose: CURRENT POSITION 0 Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus stop Jun 19 18:50:05 volumio volumio[974]: info: ------------------------------ 9ms Jun 19 18:50:05 volumio volumio[974]: info: Jun 19 18:50:05 volumio volumio[974]: ---------------------------- MPD announces state update: player Jun 19 18:50:05 volumio volumio[974]: info: ControllerMpd::getState Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Jun 19 18:50:05 volumio volumio[974]: info: sendMpdCommand status took 5 milliseconds Jun 19 18:50:05 volumio volumio[974]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 19 18:50:05 volumio volumio[974]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 19 18:50:05 volumio volumio[974]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 19 18:50:05 volumio volumio[974]: info: sendMpdCommand status took 1 milliseconds Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::parseState Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::parseState Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 19 18:50:05 volumio volumio[974]: info: ControllerMpd::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::servicePushState Jun 19 18:50:05 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Jun 19 18:50:05 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5408,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ibiza Lounge Bar Luxury Lounge & Chillout Mix (Continuous DJ Mix)","artist":"DJ Mix","album":"Ibiza Lounge Bar Luxury Lounge & Chillout Tunes (The Best of Extraordinary Chillout Lounge & Downbeat) & DJ Mix","uri":"https://rr2---sn-8xgn5uxa-4g5s.googlevideo.com/videoplayback?expire=1750373404&ei=vD9UaO3PIfqIzPsP7tri6Ac&ip=87.122.121.127&id=o-AH-KIcOCjBm8KTDEWVuq0iyb785pZY3H0epo2VHz8vTB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750351804%2C&mh=zu&mm=31%2C29&mn=sn-8xgn5uxa-4g5s%2Csn-4g5lznle&ms=au%2Crdu&mv=m&mvi=2&pl=19&rms=au%2Cau&gcr=de&initcwndbps=2928750&siu=1&bui=AY1jyLNpgeDrWCoGotfEoROswKfR6bv5G_oAvK-zubJhBJmmq_i-sbqbuRkj6Uwuk24uykrO0A&spc=l3OVKU37ooNhna_SebIvMGERTHoFc1N3C_L1-fhi9WFjlCeoTwgj9AKgyQO7ySO7liNlaSdElDTc7sIV6V8&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=A29suCL7dXxdq_ZziUPM1dIQ&rqh=1&gir=yes&clen=92189079&dur=5407.781&lmt=1714672627448312&mt=1750351163&fvip=4&keepalive=yes&fexp=51466642%2C51466697&c=WEB_REMIX&sefc=1&txp=1318224&n=_MjaWHp1-8GZ6Q&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAPzUwVBTpGGtK6qM2gpQr4KZi510O2kZdKOEfp9FpY5YAiBPLfhKks58RLidB5j_1CePDvtNFyesWdGWKh9GDyF5mA%3D%3D&sig=AJfQdSswRQIgPAFnZSReqC-wRRWEYjTQcvy1ablzkNfYHwVPPPSmE2sCIQCK-dq8gDJ3XgmqlxqkUUarpckydJVvOFceVqma6kntXQ%3D%3D&pot=Ml_Ovk4jp1Tlus6CdoKagXGTpl1VYm0e_pePeJW3pBHp0M-zT7cmKqxluG5l1m6ANd7J9hZe7fELNScs-OFpapD96aV3fMSIVmClHpEKvxEKmid7HCnfN08qE0MotWez4w%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 19 18:50:05 volumio volumio[974]: verbose: CURRENT POSITION 0 Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Jun 19 18:50:05 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:05 volumio volumio[974]: info: ControllerMpd::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::servicePushState Jun 19 18:50:05 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Jun 19 18:50:05 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5408,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ibiza Lounge Bar Luxury Lounge & Chillout Mix (Continuous DJ Mix)","artist":"DJ Mix","album":"Ibiza Lounge Bar Luxury Lounge & Chillout Tunes (The Best of Extraordinary Chillout Lounge & Downbeat) & DJ Mix","uri":"https://rr2---sn-8xgn5uxa-4g5s.googlevideo.com/videoplayback?expire=1750373404&ei=vD9UaO3PIfqIzPsP7tri6Ac&ip=87.122.121.127&id=o-AH-KIcOCjBm8KTDEWVuq0iyb785pZY3H0epo2VHz8vTB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750351804%2C&mh=zu&mm=31%2C29&mn=sn-8xgn5uxa-4g5s%2Csn-4g5lznle&ms=au%2Crdu&mv=m&mvi=2&pl=19&rms=au%2Cau&gcr=de&initcwndbps=2928750&siu=1&bui=AY1jyLNpgeDrWCoGotfEoROswKfR6bv5G_oAvK-zubJhBJmmq_i-sbqbuRkj6Uwuk24uykrO0A&spc=l3OVKU37ooNhna_SebIvMGERTHoFc1N3C_L1-fhi9WFjlCeoTwgj9AKgyQO7ySO7liNlaSdElDTc7sIV6V8&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=A29suCL7dXxdq_ZziUPM1dIQ&rqh=1&gir=yes&clen=92189079&dur=5407.781&lmt=1714672627448312&mt=1750351163&fvip=4&keepalive=yes&fexp=51466642%2C51466697&c=WEB_REMIX&sefc=1&txp=1318224&n=_MjaWHp1-8GZ6Q&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAPzUwVBTpGGtK6qM2gpQr4KZi510O2kZdKOEfp9FpY5YAiBPLfhKks58RLidB5j_1CePDvtNFyesWdGWKh9GDyF5mA%3D%3D&sig=AJfQdSswRQIgPAFnZSReqC-wRRWEYjTQcvy1ablzkNfYHwVPPPSmE2sCIQCK-dq8gDJ3XgmqlxqkUUarpckydJVvOFceVqma6kntXQ%3D%3D&pot=Ml_Ovk4jp1Tlus6CdoKagXGTpl1VYm0e_pePeJW3pBHp0M-zT7cmKqxluG5l1m6ANd7J9hZe7fELNScs-OFpapD96aV3fMSIVmClHpEKvxEKmid7HCnfN08qE0MotWez4w%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 19 18:50:05 volumio volumio[974]: verbose: CURRENT POSITION 0 Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Jun 19 18:50:05 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:05 volumio volumio[974]: info: ControllerMpd::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::servicePushState Jun 19 18:50:05 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Jun 19 18:50:05 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5408,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ibiza Lounge Bar Luxury Lounge & Chillout Mix (Continuous DJ Mix)","artist":"DJ Mix","album":"Ibiza Lounge Bar Luxury Lounge & Chillout Tunes (The Best of Extraordinary Chillout Lounge & Downbeat) & DJ Mix","uri":"https://rr2---sn-8xgn5uxa-4g5s.googlevideo.com/videoplayback?expire=1750373404&ei=vD9UaO3PIfqIzPsP7tri6Ac&ip=87.122.121.127&id=o-AH-KIcOCjBm8KTDEWVuq0iyb785pZY3H0epo2VHz8vTB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750351804%2C&mh=zu&mm=31%2C29&mn=sn-8xgn5uxa-4g5s%2Csn-4g5lznle&ms=au%2Crdu&mv=m&mvi=2&pl=19&rms=au%2Cau&gcr=de&initcwndbps=2928750&siu=1&bui=AY1jyLNpgeDrWCoGotfEoROswKfR6bv5G_oAvK-zubJhBJmmq_i-sbqbuRkj6Uwuk24uykrO0A&spc=l3OVKU37ooNhna_SebIvMGERTHoFc1N3C_L1-fhi9WFjlCeoTwgj9AKgyQO7ySO7liNlaSdElDTc7sIV6V8&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=A29suCL7dXxdq_ZziUPM1dIQ&rqh=1&gir=yes&clen=92189079&dur=5407.781&lmt=1714672627448312&mt=1750351163&fvip=4&keepalive=yes&fexp=51466642%2C51466697&c=WEB_REMIX&sefc=1&txp=1318224&n=_MjaWHp1-8GZ6Q&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAPzUwVBTpGGtK6qM2gpQr4KZi510O2kZdKOEfp9FpY5YAiBPLfhKks58RLidB5j_1CePDvtNFyesWdGWKh9GDyF5mA%3D%3D&sig=AJfQdSswRQIgPAFnZSReqC-wRRWEYjTQcvy1ablzkNfYHwVPPPSmE2sCIQCK-dq8gDJ3XgmqlxqkUUarpckydJVvOFceVqma6kntXQ%3D%3D&pot=Ml_Ovk4jp1Tlus6CdoKagXGTpl1VYm0e_pePeJW3pBHp0M-zT7cmKqxluG5l1m6ANd7J9hZe7fELNScs-OFpapD96aV3fMSIVmClHpEKvxEKmid7HCnfN08qE0MotWez4w%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 19 18:50:05 volumio volumio[974]: verbose: CURRENT POSITION 0 Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Jun 19 18:50:05 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:05 volumio volumio[974]: info: ------------------------------ 26ms Jun 19 18:50:05 volumio volumio[974]: info: ------------------------------ 28ms Jun 19 18:50:05 volumio volumio[974]: info: ------------------------------ 26ms Jun 19 18:50:05 volumio volumio[974]: info: sendMpdCommand playlistinfo took 20 milliseconds Jun 19 18:50:05 volumio volumio[974]: info: sendMpdCommand playlistinfo took 20 milliseconds Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Jun 19 18:50:05 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Jun 19 18:50:05 volumio volumio[974]: info: ControllerMpd::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::servicePushState Jun 19 18:50:05 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Jun 19 18:50:05 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5408,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ibiza Lounge Bar Luxury Lounge & Chillout Mix (Continuous DJ Mix)","artist":"DJ Mix","album":"Ibiza Lounge Bar Luxury Lounge & Chillout Tunes (The Best of Extraordinary Chillout Lounge & Downbeat) & DJ Mix","uri":"https://rr2---sn-8xgn5uxa-4g5s.googlevideo.com/videoplayback?expire=1750373404&ei=vD9UaO3PIfqIzPsP7tri6Ac&ip=87.122.121.127&id=o-AH-KIcOCjBm8KTDEWVuq0iyb785pZY3H0epo2VHz8vTB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750351804%2C&mh=zu&mm=31%2C29&mn=sn-8xgn5uxa-4g5s%2Csn-4g5lznle&ms=au%2Crdu&mv=m&mvi=2&pl=19&rms=au%2Cau&gcr=de&initcwndbps=2928750&siu=1&bui=AY1jyLNpgeDrWCoGotfEoROswKfR6bv5G_oAvK-zubJhBJmmq_i-sbqbuRkj6Uwuk24uykrO0A&spc=l3OVKU37ooNhna_SebIvMGERTHoFc1N3C_L1-fhi9WFjlCeoTwgj9AKgyQO7ySO7liNlaSdElDTc7sIV6V8&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=A29suCL7dXxdq_ZziUPM1dIQ&rqh=1&gir=yes&clen=92189079&dur=5407.781&lmt=1714672627448312&mt=1750351163&fvip=4&keepalive=yes&fexp=51466642%2C51466697&c=WEB_REMIX&sefc=1&txp=1318224&n=_MjaWHp1-8GZ6Q&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAPzUwVBTpGGtK6qM2gpQr4KZi510O2kZdKOEfp9FpY5YAiBPLfhKks58RLidB5j_1CePDvtNFyesWdGWKh9GDyF5mA%3D%3D&sig=AJfQdSswRQIgPAFnZSReqC-wRRWEYjTQcvy1ablzkNfYHwVPPPSmE2sCIQCK-dq8gDJ3XgmqlxqkUUarpckydJVvOFceVqma6kntXQ%3D%3D&pot=Ml_Ovk4jp1Tlus6CdoKagXGTpl1VYm0e_pePeJW3pBHp0M-zT7cmKqxluG5l1m6ANd7J9hZe7fELNScs-OFpapD96aV3fMSIVmClHpEKvxEKmid7HCnfN08qE0MotWez4w%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 19 18:50:05 volumio volumio[974]: verbose: CURRENT POSITION 0 Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Jun 19 18:50:05 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:05 volumio volumio[974]: info: ControllerMpd::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::servicePushState Jun 19 18:50:05 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Jun 19 18:50:05 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5408,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ibiza Lounge Bar Luxury Lounge & Chillout Mix (Continuous DJ Mix)","artist":"DJ Mix","album":"Ibiza Lounge Bar Luxury Lounge & Chillout Tunes (The Best of Extraordinary Chillout Lounge & Downbeat) & DJ Mix","uri":"https://rr2---sn-8xgn5uxa-4g5s.googlevideo.com/videoplayback?expire=1750373404&ei=vD9UaO3PIfqIzPsP7tri6Ac&ip=87.122.121.127&id=o-AH-KIcOCjBm8KTDEWVuq0iyb785pZY3H0epo2VHz8vTB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750351804%2C&mh=zu&mm=31%2C29&mn=sn-8xgn5uxa-4g5s%2Csn-4g5lznle&ms=au%2Crdu&mv=m&mvi=2&pl=19&rms=au%2Cau&gcr=de&initcwndbps=2928750&siu=1&bui=AY1jyLNpgeDrWCoGotfEoROswKfR6bv5G_oAvK-zubJhBJmmq_i-sbqbuRkj6Uwuk24uykrO0A&spc=l3OVKU37ooNhna_SebIvMGERTHoFc1N3C_L1-fhi9WFjlCeoTwgj9AKgyQO7ySO7liNlaSdElDTc7sIV6V8&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=A29suCL7dXxdq_ZziUPM1dIQ&rqh=1&gir=yes&clen=92189079&dur=5407.781&lmt=1714672627448312&mt=1750351163&fvip=4&keepalive=yes&fexp=51466642%2C51466697&c=WEB_REMIX&sefc=1&txp=1318224&n=_MjaWHp1-8GZ6Q&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAPzUwVBTpGGtK6qM2gpQr4KZi510O2kZdKOEfp9FpY5YAiBPLfhKks58RLidB5j_1CePDvtNFyesWdGWKh9GDyF5mA%3D%3D&sig=AJfQdSswRQIgPAFnZSReqC-wRRWEYjTQcvy1ablzkNfYHwVPPPSmE2sCIQCK-dq8gDJ3XgmqlxqkUUarpckydJVvOFceVqma6kntXQ%3D%3D&pot=Ml_Ovk4jp1Tlus6CdoKagXGTpl1VYm0e_pePeJW3pBHp0M-zT7cmKqxluG5l1m6ANd7J9hZe7fELNScs-OFpapD96aV3fMSIVmClHpEKvxEKmid7HCnfN08qE0MotWez4w%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 19 18:50:05 volumio volumio[974]: verbose: CURRENT POSITION 0 Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Jun 19 18:50:05 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:05 volumio volumio[974]: info: ------------------------------ 44ms Jun 19 18:50:05 volumio volumio[974]: info: ------------------------------ 40ms Jun 19 18:50:05 volumio volumio[974]: info: VolumeController::SetAlsaVolume46 Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:05 volumio volumio[974]: info: VolumeController::SetAlsaVolume67 Jun 19 18:50:05 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:05 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:06 volumio volumio[974]: info: VolumeController::SetAlsaVolume68 Jun 19 18:50:06 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:06 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:06 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:06 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Jun 19 18:50:07 volumio volumio[974]: info: VolumeController::SetAlsaVolume89 Jun 19 18:50:07 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:07 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:07 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:11 volumio volumio[974]: info: VolumeController::SetAlsaVolume85 Jun 19 18:50:11 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:11 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:11 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:12 volumio volumio[974]: info: VolumeController::SetAlsaVolume60 Jun 19 18:50:12 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:12 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:12 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:14 volumio volumio[974]: info: VolumeController::SetAlsaVolume37 Jun 19 18:50:14 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:14 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:14 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:15 volumio volumio[974]: info: VolumeController::SetAlsaVolume86 Jun 19 18:50:15 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:15 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:16 volumio volumio[974]: info: VolumeController::SetAlsaVolume100 Jun 19 18:50:16 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:16 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:18 volumio volumio[974]: info: VolumeController::SetAlsaVolume59 Jun 19 18:50:18 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:18 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:18 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:23 volumio volumio[974]: info: VolumeController::SetAlsaVolume51 Jun 19 18:50:23 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:23 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:23 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:23 volumio volumio[974]: info: VolumeController::SetAlsaVolume45 Jun 19 18:50:23 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:23 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:23 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:24 volumio volumio[974]: info: VolumeController::SetAlsaVolume43 Jun 19 18:50:24 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:24 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:24 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:24 volumio volumio[974]: info: VolumeController::SetAlsaVolume41 Jun 19 18:50:24 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:24 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:24 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:25 volumio volumio[974]: info: VolumeController::SetAlsaVolume69 Jun 19 18:50:25 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:25 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:25 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:26 volumio volumio[974]: info: VolumeController::SetAlsaVolume65 Jun 19 18:50:26 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:26 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:26 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:27 volumio volumio[974]: info: VolumeController::SetAlsaVolume51 Jun 19 18:50:27 volumio volumio[974]: info: CoreStateMachine::pushState Jun 19 18:50:27 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 19 18:50:27 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Jun 19 18:50:32 volumio volumio[974]: info: CoreCommandRouter::volumioGetQueue Jun 19 18:50:32 volumio volumio[974]: info: CoreStateMachine::getQueue Jun 19 18:50:32 volumio volumio[974]: info: CorePlayQueue::getQueue Jun 19 18:50:42 volumio volumio[974]: Searching all installed plugins Jun 19 18:50:42 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 19 18:50:42 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: , search Jun 19 18:50:42 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 19 18:50:42 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Jun 19 18:50:42 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jun 19 18:50:42 volumio volumio[974]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jun 19 18:50:42 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jun 19 18:50:42 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jun 19 18:50:43 volumio volumio[974]: Use XMLElement.setAttribute instead Jun 19 18:50:43 volumio volumio[974]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 19 18:50:43 volumio volumio[974]: TypeError: children[i].attr(...).value is not a function Jun 19 18:50:43 volumio volumio[974]: at /volumio/app/plugins/music_service/webradio/index.js:956:46 Jun 19 18:50:43 volumio volumio[974]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jun 19 18:50:43 volumio volumio[974]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 19 18:50:43 volumio sudo[2245]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-19 18:49' Jun 19 18:50:43 volumio sudo[2245]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="9c17cc34697ef689c9c9b64ea62ec0a8e386d7ce" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Jun 7 03:41:32 UTC 2025" VOLUMIO_VERSION="4.011" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="3d7d070df9925b1237bac9fe8beec51e"