Sep 10 18:48:03 volumio volumio[1282]: info: CoreCommandRouter::volumioMoveQueue Sep 10 18:48:03 volumio volumio[1282]: info: CoreStateMachine::moveQueueItem 10 10 Sep 10 18:48:03 volumio volumio[1282]: info: CorePlayQueue::moveQueueItem 10 --> 10 Sep 10 18:48:03 volumio volumio[1282]: info: CoreCommandRouter::volumioPushQueue Sep 10 18:48:30 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Sep 10 18:48:30 volumio dbus-daemon[621]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.97' (uid=0 pid=16719 comm="timedatectl show --property=NTPSynchronized --valu") Sep 10 18:48:30 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Sep 10 18:48:30 volumio dbus-daemon[621]: [system] Successfully activated service 'org.freedesktop.timedate1' Sep 10 18:48:30 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Sep 10 18:48:30 volumio setdatetime-helper.sh[16718]: Time is already synchronized. Sep 10 18:48:30 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Sep 10 18:48:30 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Sep 10 18:49:00 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Sep 10 18:49:06 volumio volumio[1282]: verbose: New Socket.io Connection to 192.168.23.118 from 192.168.23.188 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Sep 10 18:49:06 volumio volumio[1282]: verbose: New Socket.io Connection to 192.168.23.110 from 192.168.23.188 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Sep 10 18:49:06 volumio volumio[1282]: info: CoreCommandRouter::volumioGetVisibleSources Sep 10 18:49:06 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 10 18:49:06 volumio volumio[1282]: info: CoreCommandRouter::volumioGetState Sep 10 18:49:06 volumio volumio[1282]: info: CoreCommandRouter::volumioGetQueue Sep 10 18:49:06 volumio volumio[1282]: info: CoreStateMachine::getQueue Sep 10 18:49:06 volumio volumio[1282]: info: CorePlayQueue::getQueue Sep 10 18:49:06 volumio volumio[1282]: info: Listing playlists Sep 10 18:49:06 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 10 18:49:09 volumio volumio[1282]: info: CoreCommandRouter::volumioNext Sep 10 18:49:09 volumio volumio[1282]: info: CoreStateMachine::next Sep 10 18:49:09 volumio volumio[1282]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 10 18:49:09 volumio volumio[1282]: info: ControllerMpd::next Sep 10 18:49:09 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand next Sep 10 18:49:09 volumio volumio[1282]: info: sendMpdCommand next took 14 milliseconds Sep 10 18:49:09 volumio volumio[1282]: info: Sep 10 18:49:09 volumio volumio[1282]: ---------------------------- MPD announces state update: player Sep 10 18:49:09 volumio volumio[1282]: info: ControllerMpd::getState Sep 10 18:49:09 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand status Sep 10 18:49:09 volumio volumio[1282]: info: ControllerMpd::getState Sep 10 18:49:09 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand status Sep 10 18:49:09 volumio volumio[1282]: info: Sep 10 18:49:09 volumio volumio[1282]: ---------------------------- MPD announces state update: player Sep 10 18:49:09 volumio volumio[1282]: info: ControllerMpd::getState Sep 10 18:49:09 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand status Sep 10 18:49:09 volumio volumio[1282]: info: sendMpdCommand status took 2 milliseconds Sep 10 18:49:09 volumio volumio[1282]: verbose: ControllerMpd::parseState Sep 10 18:49:09 volumio volumio[1282]: info: ControllerMpd::pushState Sep 10 18:49:09 volumio volumio[1282]: info: CoreCommandRouter::servicePushState Sep 10 18:49:09 volumio volumio[1282]: info: CoreStateMachine::pushState Sep 10 18:49:09 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 18:49:09 volumio volumio[1282]: info: CoreCommandRouter::volumioPushState Sep 10 18:49:09 volumio volumio[1282]: info: CorePlayQueue::getTrack 0 Sep 10 18:49:09 volumio volumio[1282]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 10 18:49:09 volumio volumio[1282]: verbose: CURRENT POSITION 0 Sep 10 18:49:09 volumio volumio[1282]: info: CoreStateMachine::syncState stateService stop Sep 10 18:49:09 volumio volumio[1282]: info: CoreStateMachine::syncState currentStatus play Sep 10 18:49:09 volumio volumio[1282]: info: CoreStateMachine::play index undefined Sep 10 18:49:09 volumio volumio[1282]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 18:49:09 volumio volumio[1282]: info: CoreStateMachine::pushState Sep 10 18:49:09 volumio volumio[1282]: info: CorePlayQueue::getTrack 1 Sep 10 18:49:09 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 18:49:09 volumio volumio[1282]: info: CoreCommandRouter::volumioPushState Sep 10 18:49:09 volumio volumio[1282]: info: CorePlayQueue::getTrack 1 Sep 10 18:49:09 volumio volumio[1282]: info: CoreStateMachine::startPlaybackTimer Sep 10 18:49:09 volumio volumio[1282]: info: CorePlayQueue::getTrack 1 Sep 10 18:49:09 volumio volumio[1282]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22N4sjeKvCFts%22%2C%22playlistId%22%3A%22RD1OXeGXM-Qgs%22%2C%22params%22%3A%22OAG4BQE%253D%22%2C%22index%22%3A2%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22N%C3%8AN%20CH%E1%BB%9C%20HAY%20N%C3%8AN%20QU%C3%8AN%20-%20CHU%20TH%C3%9AY%20QU%E1%BB%B2NH%20%7C%20Replay%20M%E1%BB%8Fi%20Tay%20V%E1%BB%9Bi%2010%20Top%20Hit%20G%C3%A2y%20B%C3%A3o%20MXH%202024%20%7C%20Live%20Stage%22%2C%22artist%22%3A%22%C4%90%C3%AAm%20Nh%E1%BA%A1c%20%C4%90%E1%BA%B7c%20Bi%E1%BB%87t%20%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FN4sjeKvCFts%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLC6wy6DsiKXkbggdEoB9ezDEfJ_Fg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22N4sjeKvCFts%22%2C%22playlistId%22%3A%22RD1OXeGXM-Qgs%22%2C%22params%22%3A%22OAG4BQE%253D%22%2C%22index%22%3A2%7D%7D%7D Sep 10 18:49:09 volumio volumio[1282]: info: ------------------------------ 25ms Sep 10 18:49:09 volumio volumio[1282]: info: CoreStateMachine::pushState Sep 10 18:49:09 volumio volumio[1282]: info: CorePlayQueue::getTrack 1 Sep 10 18:49:09 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 18:49:09 volumio volumio[1282]: info: CoreCommandRouter::volumioPushState Sep 10 18:49:09 volumio volumio[1282]: info: sendMpdCommand status took 46 milliseconds Sep 10 18:49:09 volumio volumio[1282]: info: sendMpdCommand status took 45 milliseconds Sep 10 18:49:09 volumio volumio[1282]: verbose: ControllerMpd::parseState Sep 10 18:49:09 volumio volumio[1282]: verbose: ControllerMpd::parseState Sep 10 18:49:09 volumio volumio[1282]: info: CoreStateMachine::getQueue Sep 10 18:49:09 volumio volumio[1282]: info: CorePlayQueue::getQueue Sep 10 18:49:09 volumio volumio[1282]: info: CorePlayQueue::getTrack 1 Sep 10 18:49:09 volumio volumio[1282]: info: CoreStateMachine::getQueue Sep 10 18:49:09 volumio volumio[1282]: info: CorePlayQueue::getQueue Sep 10 18:49:09 volumio volumio[1282]: info: ControllerMpd::pushState Sep 10 18:49:09 volumio volumio[1282]: info: CoreCommandRouter::servicePushState Sep 10 18:49:09 volumio volumio[1282]: info: CoreStateMachine::pushState Sep 10 18:49:09 volumio volumio[1282]: info: CorePlayQueue::getTrack 1 Sep 10 18:49:09 volumio volumio[1282]: info: CoreCommandRouter::volumioPushState Sep 10 18:49:09 volumio volumio[1282]: info: CorePlayQueue::getTrack 1 Sep 10 18:49:09 volumio volumio[1282]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Sep 10 18:49:09 volumio volumio[1282]: info: ------------------------------ 62ms Sep 10 18:49:09 volumio volumio[1282]: info: FusionDsp - Volumio is playing Sep 10 18:49:09 volumio volumio[1282]: info: FusionDsp - Volumio is not playing Sep 10 18:49:09 volumio volumio[1282]: info: FusionDsp - Clipped samples monitor stopped Sep 10 18:49:09 volumio volumio[1282]: info: FusionDsp - Volumio is not playing Sep 10 18:49:09 volumio volumio[1282]: info: FusionDsp - Clipped samples monitor stopped Sep 10 18:49:10 volumio volumio[1282]: info: FusionDsp - Volumio is not playing Sep 10 18:49:10 volumio volumio[1282]: info: FusionDsp - Clipped samples monitor stopped Sep 10 18:49:10 volumio volumio[1282]: warn: [youtube2] Error getting stream with default client in VideoModel.getInfo(N4sjeKvCFts): No valid URL to decipher - retry with 'WEB_EMBEDDED' client. Sep 10 18:49:11 volumio volumio[1282]: info: CorePlayQueue::getTrack 1 Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand stop took 1 milliseconds Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand clear Sep 10 18:49:11 volumio volumio[1282]: info: Sep 10 18:49:11 volumio volumio[1282]: ---------------------------- MPD announces system playlist update Sep 10 18:49:11 volumio volumio[1282]: info: Ignoring MPD Status Update Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand clear took 0 milliseconds Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand addid "https://rr8---sn-42u-nbozz.googlevideo.com/videoplayback?expire=1757526545&ei=sWXBaJf1EfO29fwPlYqL8AU&ip=58.186.193.147&id=o-AGS0LmIUsZXomfnyqkArPquNpmOiNXzaUjJWlkvKj9RJ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757504945%2C&mh=0m&mm=31%2C26&mn=sn-42u-nbozz%2Csn-oguesn6r&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&initcwndbps=3497500&bui=ATw7iSXFlyrxYZtzI1nMFjqoBF1jpyWQMOe5ba7EmSL7mYup0AsjAzxfW5nREVzTIPpGlkp0BNd4_zm8&spc=hcYD5YBe-j8YCCAlIrOUsxRc2ECxcMFKYUf44cNXCJ5IE5eS23f4MQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=QXLXMfOIvgLqV2kDh7TuNs4Q&rqh=1&gir=yes&clen=58415347&dur=3379.201&lmt=1730821415489549&mt=1757504540&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=AOo3lLqlETEsvw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANhh5fvTbCZAvUyV0drWNCRUqlIldojyA3FNmidOfp67AiEA3o26NmHnSQT3bkJP0V2AA74PcP4q8-EiPTF7kRaLwmM%3D&sig=AJfQdSswRAIgQnJSRHngxqoWXSO8HMccG_AgOGN6f1StOl9UD4T-zv4CICCtQEjFn2rn2A2Up0g5H6kLTUvzsvua9zvPoaGO_4en&pot=Mnrs3Aermkxaj-zicBs-kl_fwq-Mp-dE6ycPBAQn_-ZYfjTx9l7b8ej2zcjbxi6Y7N_MnzYHnBy53LNRXNDakOUBdsI3svOVGYnfTo7TyFEIKbyzZWeLDTX3cxXH8xVTlvwEC52Nw-H3Q3yrJBcNeKKJFqJQ_UgQZaOYjg%3D%3D&cver=1.20250219.01.00&t.YouTube" Sep 10 18:49:11 volumio volumio[1282]: info: Sep 10 18:49:11 volumio volumio[1282]: ---------------------------- MPD announces system playlist update Sep 10 18:49:11 volumio volumio[1282]: info: Ignoring MPD Status Update Sep 10 18:49:11 volumio volumio[1282]: error: updateQueue error: null Sep 10 18:49:11 volumio volumio[1282]: info: Sep 10 18:49:11 volumio volumio[1282]: ---------------------------- MPD announces system playlist update Sep 10 18:49:11 volumio volumio[1282]: info: Ignoring MPD Status Update Sep 10 18:49:11 volumio volumio[1282]: info: ------------------------------ 3ms Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand addid "https://rr8---sn-42u-nbozz.googlevideo.com/videoplayback?expire=1757526545&ei=sWXBaJf1EfO29fwPlYqL8AU&ip=58.186.193.147&id=o-AGS0LmIUsZXomfnyqkArPquNpmOiNXzaUjJWlkvKj9RJ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757504945%2C&mh=0m&mm=31%2C26&mn=sn-42u-nbozz%2Csn-oguesn6r&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&initcwndbps=3497500&bui=ATw7iSXFlyrxYZtzI1nMFjqoBF1jpyWQMOe5ba7EmSL7mYup0AsjAzxfW5nREVzTIPpGlkp0BNd4_zm8&spc=hcYD5YBe-j8YCCAlIrOUsxRc2ECxcMFKYUf44cNXCJ5IE5eS23f4MQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=QXLXMfOIvgLqV2kDh7TuNs4Q&rqh=1&gir=yes&clen=58415347&dur=3379.201&lmt=1730821415489549&mt=1757504540&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=AOo3lLqlETEsvw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANhh5fvTbCZAvUyV0drWNCRUqlIldojyA3FNmidOfp67AiEA3o26NmHnSQT3bkJP0V2AA74PcP4q8-EiPTF7kRaLwmM%3D&sig=AJfQdSswRAIgQnJSRHngxqoWXSO8HMccG_AgOGN6f1StOl9UD4T-zv4CICCtQEjFn2rn2A2Up0g5H6kLTUvzsvua9zvPoaGO_4en&pot=Mnrs3Aermkxaj-zicBs-kl_fwq-Mp-dE6ycPBAQn_-ZYfjTx9l7b8ej2zcjbxi6Y7N_MnzYHnBy53LNRXNDakOUBdsI3svOVGYnfTo7TyFEIKbyzZWeLDTX3cxXH8xVTlvwEC52Nw-H3Q3yrJBcNeKKJFqJQ_UgQZaOYjg%3D%3D&cver=1.20250219.01.00&t.YouTube" took 2 milliseconds Sep 10 18:49:11 volumio volumio[1282]: info: ------------------------------ 3ms Sep 10 18:49:11 volumio volumio[1282]: verbose: MPD COMMAND [object Object] Sep 10 18:49:11 volumio volumio[1282]: verbose: MPD COMMAND [object Object] Sep 10 18:49:11 volumio volumio[1282]: verbose: MPD COMMAND [object Object] Sep 10 18:49:11 volumio volumio[1282]: info: Sep 10 18:49:11 volumio volumio[1282]: ---------------------------- MPD announces system playlist update Sep 10 18:49:11 volumio volumio[1282]: info: Ignoring MPD Status Update Sep 10 18:49:11 volumio volumio[1282]: info: Sep 10 18:49:11 volumio volumio[1282]: ---------------------------- MPD announces system playlist update Sep 10 18:49:11 volumio volumio[1282]: info: Ignoring MPD Status Update Sep 10 18:49:11 volumio volumio[1282]: info: ------------------------------ 3ms Sep 10 18:49:11 volumio volumio[1282]: info: ------------------------------ 2ms Sep 10 18:49:11 volumio volumio[1282]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand play Sep 10 18:49:11 volumio volumio[1282]: info: Sep 10 18:49:11 volumio volumio[1282]: ---------------------------- MPD announces system playlist update Sep 10 18:49:11 volumio volumio[1282]: info: Ignoring MPD Status Update Sep 10 18:49:11 volumio volumio[1282]: info: ------------------------------ 3ms Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand play took 2 milliseconds Sep 10 18:49:11 volumio volumio[1282]: info: ------------------------------ 2ms Sep 10 18:49:11 volumio volumio[1282]: info: Sep 10 18:49:11 volumio volumio[1282]: ---------------------------- MPD announces state update: player Sep 10 18:49:11 volumio volumio[1282]: info: ControllerMpd::getState Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand status Sep 10 18:49:11 volumio volumio[1282]: info: ControllerMpd::getState Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand status Sep 10 18:49:11 volumio volumio[1282]: info: Sep 10 18:49:11 volumio volumio[1282]: ---------------------------- MPD announces state update: player Sep 10 18:49:11 volumio volumio[1282]: info: ControllerMpd::getState Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand status Sep 10 18:49:11 volumio volumio[1282]: info: Sep 10 18:49:11 volumio volumio[1282]: ---------------------------- MPD announces state update: player Sep 10 18:49:11 volumio volumio[1282]: info: ControllerMpd::getState Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand status Sep 10 18:49:11 volumio volumio[1282]: info: ControllerMpd::getState Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand status Sep 10 18:49:11 volumio volumio[1282]: info: Sep 10 18:49:11 volumio volumio[1282]: ---------------------------- MPD announces state update: player Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand status took 14 milliseconds Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand status took 14 milliseconds Sep 10 18:49:11 volumio volumio[1282]: info: ControllerMpd::getState Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand status Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand status took 15 milliseconds Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand status took 8 milliseconds Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::parseState Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::parseState Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::parseState Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::parseState Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 18:49:11 volumio volumio[1282]: info: FusionDsp - ---- read samplerate, raw: 384000,S32_LE,2,32 Sep 10 18:49:11 volumio volumio[1282]: info: FusionDsp - ---- read samplerate from file: 384000 Sep 10 18:49:11 volumio volumio[1282]: info: FusionDsp - If filter freq >samplerate/2 then disable it Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand status took 10 milliseconds Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand status took 8 milliseconds Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::parseState Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::parseState Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::parseTrackInfo Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::parseTrackInfo Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::parseTrackInfo Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::parseTrackInfo Sep 10 18:49:11 volumio volumio[1282]: info: ControllerMpd::pushState Sep 10 18:49:11 volumio volumio[1282]: info: CoreCommandRouter::servicePushState Sep 10 18:49:11 volumio volumio[1282]: info: CorePlayQueue::getTrack 1 Sep 10 18:49:11 volumio volumio[1282]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3379,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"NÊN CHỜ HAY NÊN QUÊN - CHU THÚY QUỲNH | Replay Mỏi Tay Với 10 Top Hit Gây Bão MXH 2024 | Live Stage","artist":"Đêm Nhạc Đặc Biệt","album":"YouTube","uri":"https://rr8---sn-42u-nbozz.googlevideo.com/videoplayback?expire=1757526545&ei=sWXBaJf1EfO29fwPlYqL8AU&ip=58.186.193.147&id=o-AGS0LmIUsZXomfnyqkArPquNpmOiNXzaUjJWlkvKj9RJ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757504945%2C&mh=0m&mm=31%2C26&mn=sn-42u-nbozz%2Csn-oguesn6r&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&initcwndbps=3497500&bui=ATw7iSXFlyrxYZtzI1nMFjqoBF1jpyWQMOe5ba7EmSL7mYup0AsjAzxfW5nREVzTIPpGlkp0BNd4_zm8&spc=hcYD5YBe-j8YCCAlIrOUsxRc2ECxcMFKYUf44cNXCJ5IE5eS23f4MQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=QXLXMfOIvgLqV2kDh7TuNs4Q&rqh=1&gir=yes&clen=58415347&dur=3379.201&lmt=1730821415489549&mt=1757504540&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=AOo3lLqlETEsvw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANhh5fvTbCZAvUyV0drWNCRUqlIldojyA3FNmidOfp67AiEA3o26NmHnSQT3bkJP0V2AA74PcP4q8-EiPTF7kRaLwmM%3D&sig=AJfQdSswRAIgQnJSRHngxqoWXSO8HMccG_AgOGN6f1StOl9UD4T-zv4CICCtQEjFn2rn2A2Up0g5H6kLTUvzsvua9zvPoaGO_4en&pot=Mnrs3Aermkxaj-zicBs-kl_fwq-Mp-dE6ycPBAQn_-ZYfjTx9l7b8ej2zcjbxi6Y7N_MnzYHnBy53LNRXNDakOUBdsI3svOVGYnfTo7TyFEIKbyzZWeLDTX3cxXH8xVTlvwEC52Nw-H3Q3yrJBcNeKKJFqJQ_UgQZaOYjg%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Sep 10 18:49:11 volumio volumio[1282]: verbose: CURRENT POSITION 1 Sep 10 18:49:11 volumio volumio[1282]: info: CoreStateMachine::syncState stateService play Sep 10 18:49:11 volumio volumio[1282]: info: CoreStateMachine::syncState currentStatus stop Sep 10 18:49:11 volumio volumio[1282]: info: ControllerMpd::pushState Sep 10 18:49:11 volumio volumio[1282]: info: CoreCommandRouter::servicePushState Sep 10 18:49:11 volumio volumio[1282]: info: CorePlayQueue::getTrack 1 Sep 10 18:49:11 volumio volumio[1282]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3379,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"NÊN CHỜ HAY NÊN QUÊN - CHU THÚY QUỲNH | Replay Mỏi Tay Với 10 Top Hit Gây Bão MXH 2024 | Live Stage","artist":"Đêm Nhạc Đặc Biệt","album":"YouTube","uri":"https://rr8---sn-42u-nbozz.googlevideo.com/videoplayback?expire=1757526545&ei=sWXBaJf1EfO29fwPlYqL8AU&ip=58.186.193.147&id=o-AGS0LmIUsZXomfnyqkArPquNpmOiNXzaUjJWlkvKj9RJ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757504945%2C&mh=0m&mm=31%2C26&mn=sn-42u-nbozz%2Csn-oguesn6r&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&initcwndbps=3497500&bui=ATw7iSXFlyrxYZtzI1nMFjqoBF1jpyWQMOe5ba7EmSL7mYup0AsjAzxfW5nREVzTIPpGlkp0BNd4_zm8&spc=hcYD5YBe-j8YCCAlIrOUsxRc2ECxcMFKYUf44cNXCJ5IE5eS23f4MQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=QXLXMfOIvgLqV2kDh7TuNs4Q&rqh=1&gir=yes&clen=58415347&dur=3379.201&lmt=1730821415489549&mt=1757504540&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=AOo3lLqlETEsvw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANhh5fvTbCZAvUyV0drWNCRUqlIldojyA3FNmidOfp67AiEA3o26NmHnSQT3bkJP0V2AA74PcP4q8-EiPTF7kRaLwmM%3D&sig=AJfQdSswRAIgQnJSRHngxqoWXSO8HMccG_AgOGN6f1StOl9UD4T-zv4CICCtQEjFn2rn2A2Up0g5H6kLTUvzsvua9zvPoaGO_4en&pot=Mnrs3Aermkxaj-zicBs-kl_fwq-Mp-dE6ycPBAQn_-ZYfjTx9l7b8ej2zcjbxi6Y7N_MnzYHnBy53LNRXNDakOUBdsI3svOVGYnfTo7TyFEIKbyzZWeLDTX3cxXH8xVTlvwEC52Nw-H3Q3yrJBcNeKKJFqJQ_UgQZaOYjg%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Sep 10 18:49:11 volumio volumio[1282]: verbose: CURRENT POSITION 1 Sep 10 18:49:11 volumio volumio[1282]: info: CoreStateMachine::syncState stateService play Sep 10 18:49:11 volumio volumio[1282]: info: CoreStateMachine::syncState currentStatus play Sep 10 18:49:11 volumio volumio[1282]: info: Received an update from plugin. extracting info from payload Sep 10 18:49:11 volumio volumio[1282]: info: CoreStateMachine::pushState Sep 10 18:49:11 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 18:49:11 volumio volumio[1282]: info: CoreCommandRouter::volumioPushState Sep 10 18:49:11 volumio volumio[1282]: info: CoreStateMachine::pushState Sep 10 18:49:11 volumio volumio[1282]: info: CoreCommandRouter::volumioPushState Sep 10 18:49:11 volumio volumio[1282]: info: ControllerMpd::pushState Sep 10 18:49:11 volumio volumio[1282]: info: CoreCommandRouter::servicePushState Sep 10 18:49:11 volumio volumio[1282]: info: CorePlayQueue::getTrack 1 Sep 10 18:49:11 volumio volumio[1282]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3379,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"NÊN CHỜ HAY NÊN QUÊN - CHU THÚY QUỲNH | Replay Mỏi Tay Với 10 Top Hit Gây Bão MXH 2024 | Live Stage","artist":"Đêm Nhạc Đặc Biệt","album":"YouTube","uri":"https://rr8---sn-42u-nbozz.googlevideo.com/videoplayback?expire=1757526545&ei=sWXBaJf1EfO29fwPlYqL8AU&ip=58.186.193.147&id=o-AGS0LmIUsZXomfnyqkArPquNpmOiNXzaUjJWlkvKj9RJ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757504945%2C&mh=0m&mm=31%2C26&mn=sn-42u-nbozz%2Csn-oguesn6r&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&initcwndbps=3497500&bui=ATw7iSXFlyrxYZtzI1nMFjqoBF1jpyWQMOe5ba7EmSL7mYup0AsjAzxfW5nREVzTIPpGlkp0BNd4_zm8&spc=hcYD5YBe-j8YCCAlIrOUsxRc2ECxcMFKYUf44cNXCJ5IE5eS23f4MQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=QXLXMfOIvgLqV2kDh7TuNs4Q&rqh=1&gir=yes&clen=58415347&dur=3379.201&lmt=1730821415489549&mt=1757504540&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=AOo3lLqlETEsvw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANhh5fvTbCZAvUyV0drWNCRUqlIldojyA3FNmidOfp67AiEA3o26NmHnSQT3bkJP0V2AA74PcP4q8-EiPTF7kRaLwmM%3D&sig=AJfQdSswRAIgQnJSRHngxqoWXSO8HMccG_AgOGN6f1StOl9UD4T-zv4CICCtQEjFn2rn2A2Up0g5H6kLTUvzsvua9zvPoaGO_4en&pot=Mnrs3Aermkxaj-zicBs-kl_fwq-Mp-dE6ycPBAQn_-ZYfjTx9l7b8ej2zcjbxi6Y7N_MnzYHnBy53LNRXNDakOUBdsI3svOVGYnfTo7TyFEIKbyzZWeLDTX3cxXH8xVTlvwEC52Nw-H3Q3yrJBcNeKKJFqJQ_UgQZaOYjg%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Sep 10 18:49:11 volumio volumio[1282]: verbose: CURRENT POSITION 1 Sep 10 18:49:11 volumio volumio[1282]: info: CoreStateMachine::syncState stateService play Sep 10 18:49:11 volumio volumio[1282]: info: CoreStateMachine::syncState currentStatus play Sep 10 18:49:11 volumio volumio[1282]: info: Received an update from plugin. extracting info from payload Sep 10 18:49:11 volumio volumio[1282]: info: CoreStateMachine::pushState Sep 10 18:49:11 volumio volumio[1282]: info: CoreCommandRouter::volumioPushState Sep 10 18:49:11 volumio volumio[1282]: info: CoreStateMachine::pushState Sep 10 18:49:11 volumio volumio[1282]: info: CoreCommandRouter::volumioPushState Sep 10 18:49:11 volumio volumio[1282]: info: ------------------------------ 41ms Sep 10 18:49:11 volumio volumio[1282]: info: ------------------------------ 61ms Sep 10 18:49:11 volumio volumio[1282]: info: ------------------------------ 55ms Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand playlistinfo took 39 milliseconds Sep 10 18:49:11 volumio volumio[1282]: info: sendMpdCommand playlistinfo took 38 milliseconds Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::parseTrackInfo Sep 10 18:49:11 volumio volumio[1282]: verbose: ControllerMpd::parseTrackInfo Sep 10 18:49:11 volumio volumio[1282]: info: ControllerMpd::pushState Sep 10 18:49:11 volumio volumio[1282]: info: CoreCommandRouter::servicePushState Sep 10 18:49:11 volumio volumio[1282]: info: CorePlayQueue::getTrack 1 Sep 10 18:49:11 volumio volumio[1282]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3379,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"NÊN CHỜ HAY NÊN QUÊN - CHU THÚY QUỲNH | Replay Mỏi Tay Với 10 Top Hit Gây Bão MXH 2024 | Live Stage","artist":"Đêm Nhạc Đặc Biệt","album":"YouTube","uri":"https://rr8---sn-42u-nbozz.googlevideo.com/videoplayback?expire=1757526545&ei=sWXBaJf1EfO29fwPlYqL8AU&ip=58.186.193.147&id=o-AGS0LmIUsZXomfnyqkArPquNpmOiNXzaUjJWlkvKj9RJ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757504945%2C&mh=0m&mm=31%2C26&mn=sn-42u-nbozz%2Csn-oguesn6r&ms=au%2Conr&mv=m&mvi=8&pl=24&rms=au%2Cau&initcwndbps=3497500&bui=ATw7iSXFlyrxYZtzI1nMFjqoBF1jpyWQMOe5ba7EmSL7mYup0AsjAzxfW5nREVzTIPpGlkp0BNd4_zm8&spc=hcYD5YBe-j8YCCAlIrOUsxRc2ECxcMFKYUf44cNXCJ5IE5eS23f4MQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=QXLXMfOIvgLqV2kDh7TuNs4Q&rqh=1&gir=yes&clen=58415347&dur=3379.201&lmt=1730821415489549&mt=1757504540&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=AOo3lLqlETEsvw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANhh5fvTbCZAvUyV0drWNCRUqlIldojyA3FNmidOfp67AiEA3o26NmHnSQT3bkJP0V2AA74PcP4q8-EiPTF7kRaLwmM%3D&sig=AJfQdSswRAIgQnJSRHngxqoWXSO8HMccG_AgOGN6f1StOl9UD4T-zv4CICCtQEjFn2rn2A2Up0g5H6kLTUvzsvua9zvPoaGO_4en&pot=Mnrs3Aermkxaj-zicBs-kl_fwq-Mp-dE6ycPBAQn_-ZYfjTx9l7b8ej2zcjbxi6Y7N_MnzYHnBy53LNRXNDakOUBdsI3svOVGYnfTo7TyFEIKbyzZWeLDTX3cxXH8xVTlvwEC52Nw-H3Q3yrJBcNeKKJFqJQ_UgQZaOYjg%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Sep 10 18:49:11 volumio volumio[1282]: verbose: CURRENT POSITION 1 Sep 10 18:49:11 volumio volumio[1282]: info: CoreStateMachine::syncState stateService play Sep 10 18:49:11 volumio volumio[1282]: info: CoreStateMachine::syncState currentStatus play Sep 10 18:49:11 volumio volumio[1282]: info: Received an update from plugin. extracting info from payload Sep 10 18:49:11 volumio volumio[1282]: info: CoreStateMachine::pushState Sep 10 18:49:11 volumio volumio[1282]: info: CoreCommandRouter::volumioPushState Sep 10 18:49:11 volumio volumio[1282]: info: CoreStateMachine::pushState Sep 10 18:49:11 volumio volumio[1282]: info: CoreCommandRouter::volumioPushState Sep 10 18:49:11 volumio volumio[1282]: info: ------------------------------ 91ms Sep 10 18:49:11 volumio volumio[1282]: info: FusionDsp - Volumio is playing Sep 10 18:49:11 volumio volumio[1282]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Sep 10 18:49:11 volumio volumio[1282]: info: FusionDsp - Volumio is playing Sep 10 18:49:11 volumio volumio[1282]: info: FusionDsp - Volumio is playing Sep 10 18:49:11 volumio volumio[1282]: info: FusionDsp - Volumio is playing Sep 10 18:49:11 volumio volumio[1282]: info: FusionDsp - Volumio is playing Sep 10 18:49:11 volumio volumio[1282]: info: FusionDsp - Volumio is playing Sep 10 18:49:11 volumio volumio[1282]: info: FusionDsp - Clipping Monitor started Sep 10 18:49:11 volumio volumio[1282]: info: FusionDsp - Clipping Monitor started Sep 10 18:49:11 volumio volumio[1282]: info: FusionDsp - Clipping Monitor started Sep 10 18:49:11 volumio volumio[1282]: info: FusionDsp - Clipping Monitor started Sep 10 18:49:11 volumio volumio[1282]: info: FusionDsp - Clipping Monitor started Sep 10 18:49:11 volumio volumio[1282]: info: FusionDsp - Clipping Monitor started Sep 10 18:49:35 volumio ntpd[960]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Sep 10 18:49:35 volumio ntpd[960]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Sep 10 18:49:35 volumio ntpd[960]: DNS: Pool skipping: 115.165.161.155 Sep 10 18:49:35 volumio ntpd[960]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Sep 10 18:49:36 volumio ntpd[960]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Sep 10 18:49:36 volumio ntpd[960]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Sep 10 18:49:36 volumio ntpd[960]: DNS: Pool skipping: 115.165.161.155 Sep 10 18:49:36 volumio ntpd[960]: DNS: Pool skipping: 2400:e920:0:5::14 Sep 10 18:49:36 volumio ntpd[960]: DNS: Pool skipping: 2401:5b60:0:1::52 Sep 10 18:49:36 volumio ntpd[960]: DNS: Pool skipping: 2401:5b60:0:2::21 Sep 10 18:49:36 volumio ntpd[960]: DNS: Pool skipping: 2400:6760:0:200::254 Sep 10 18:49:36 volumio ntpd[960]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Sep 10 18:49:37 volumio ntpd[960]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Sep 10 18:49:37 volumio ntpd[960]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Sep 10 18:49:37 volumio ntpd[960]: DNS: Pool skipping: 115.165.161.155 Sep 10 18:49:37 volumio ntpd[960]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Sep 10 18:49:38 volumio ntpd[960]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Sep 10 18:49:38 volumio ntpd[960]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Sep 10 18:49:38 volumio ntpd[960]: DNS: Pool skipping: 115.165.161.155 Sep 10 18:49:38 volumio ntpd[960]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Sep 10 18:49:42 volumio volumio[1282]: verbose: New Socket.io Connection to 192.168.23.110 from 192.168.23.188 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Sep 10 18:49:42 volumio volumio[1282]: info: CoreCommandRouter::volumioGetVisibleSources Sep 10 18:49:42 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 10 18:49:42 volumio volumio[1282]: info: CoreCommandRouter::volumioGetState Sep 10 18:49:42 volumio volumio[1282]: info: CoreCommandRouter::volumioGetQueue Sep 10 18:49:42 volumio volumio[1282]: info: CoreStateMachine::getQueue Sep 10 18:49:42 volumio volumio[1282]: info: CorePlayQueue::getQueue Sep 10 18:49:42 volumio volumio[1282]: info: Listing playlists Sep 10 18:49:43 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 10 18:49:43 volumio volumio[1282]: verbose: New Socket.io Connection to 192.168.23.118 from 192.168.23.188 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Sep 10 18:49:45 volumio volumio[1282]: info: CoreCommandRouter::volumioRandom Sep 10 18:49:45 volumio volumio[1282]: info: CoreCommandRouter::writePlayerControls Sep 10 18:49:45 volumio volumio[1282]: info: CoreStateMachine::setRepeat true single false Sep 10 18:49:45 volumio volumio[1282]: info: CoreStateMachine::pushState Sep 10 18:49:45 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 18:49:45 volumio volumio[1282]: info: CoreCommandRouter::volumioPushState Sep 10 18:49:45 volumio volumio[1282]: info: FusionDsp - Volumio is playing Sep 10 18:49:47 volumio volumio[1282]: info: CoreCommandRouter::volumioRandom Sep 10 18:49:47 volumio volumio[1282]: info: CoreCommandRouter::writePlayerControls Sep 10 18:49:47 volumio volumio[1282]: info: CoreStateMachine::setRepeat true single true Sep 10 18:49:47 volumio volumio[1282]: info: CoreStateMachine::pushState Sep 10 18:49:47 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 18:49:47 volumio volumio[1282]: info: CoreCommandRouter::volumioPushState Sep 10 18:49:47 volumio volumio[1282]: info: FusionDsp - Volumio is playing Sep 10 18:49:47 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Sep 10 18:49:47 volumio dbus-daemon[621]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.99' (uid=0 pid=16940 comm="timedatectl show --property=NTPSynchronized --valu") Sep 10 18:49:47 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Sep 10 18:49:47 volumio dbus-daemon[621]: [system] Successfully activated service 'org.freedesktop.timedate1' Sep 10 18:49:47 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Sep 10 18:49:47 volumio setdatetime-helper.sh[16939]: Time is already synchronized. Sep 10 18:49:47 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Sep 10 18:49:47 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Sep 10 18:49:48 volumio volumio[1282]: info: CoreCommandRouter::volumioRandom Sep 10 18:49:48 volumio volumio[1282]: info: CoreCommandRouter::writePlayerControls Sep 10 18:49:48 volumio volumio[1282]: info: CoreStateMachine::setRepeat false single false Sep 10 18:49:48 volumio volumio[1282]: info: CoreStateMachine::pushState Sep 10 18:49:48 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 18:49:48 volumio volumio[1282]: info: CoreCommandRouter::volumioPushState Sep 10 18:49:48 volumio volumio[1282]: info: FusionDsp - Volumio is playing Sep 10 18:49:58 volumio volumio[1282]: Searching all installed plugins Sep 10 18:49:58 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 10 18:49:58 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: , search Sep 10 18:49:58 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 10 18:49:58 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 10 18:49:58 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 10 18:49:58 volumio volumio[1282]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 10 18:49:58 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 10 18:49:58 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Sep 10 18:49:58 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Sep 10 18:49:58 volumio volumio[1282]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Sep 10 18:49:58 volumio volumio[1282]: info: [ytmusic] InnertubeLoader: creating Innertube instance... Sep 10 18:49:59 volumio volumio[1282]: Use XMLElement.setAttribute instead Sep 10 18:49:59 volumio volumio[1282]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 10 18:49:59 volumio volumio[1282]: TypeError: children[i].attr(...).value is not a function Sep 10 18:49:59 volumio volumio[1282]: at /volumio/app/plugins/music_service/webradio/index.js:956:46 Sep 10 18:49:59 volumio volumio[1282]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Sep 10 18:49:59 volumio volumio[1282]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 10 18:49:59 volumio sudo[16984]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-09-10 18:48' Sep 10 18:49:59 volumio sudo[16984]: 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="4a70cb031e64a8e498efc3e29470650871ff7d54" 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 May 31 04:47:19 UTC 2025" VOLUMIO_VERSION="4.005" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="f0f6a90610a0a39b2758a5b3958219e6"