-- Logs begin at Wed 2025-05-21 17:11:56 UTC, end at Wed 2025-05-21 17:53:21 UTC. --
May 21 17:52:00 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:00 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand stop
May 21 17:52:00 volumio-acer volumio[921]: info: sendMpdCommand stop took 0 milliseconds
May 21 17:52:00 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clear
May 21 17:52:00 volumio-acer volumio[921]: info:
May 21 17:52:00 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:00 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:00 volumio-acer volumio[921]: info: sendMpdCommand clear took 3 milliseconds
May 21 17:52:00 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-3tp8nu5g-3fbe.googlevideo.com/videoplayback?expire=1747871519&ei=vxIuaLiCKJer6dsPj_uBgA0&ip=109.162.37.151&id=o-AN_waX3psny0OOj4C2zl2fyfQJFS325rBM2issCbd9Vv&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849919%2C&mh=zo&mm=31%2C29&mn=sn-3tp8nu5g-3fbe%2Csn-3tp8nu5g-3c2d&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=2296250&bui=AecWEAbmaroVhc2r9SGDEZXZ0WupGz7dfb_Uy5UVG3Hu-wqYnZsLcCQSqxtcwtzRLAKmpDjqxIXIjcGp&spc=wk1kZoaRKA7ZG4iPN7-HuEN1JVrryEBBLehI2Q2Ef-eSOlX3X3BQ4wco99k0gWrMM_w&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ERgYGandb6LKYQ6tpiaD9U4Q&rqh=1&gir=yes&clen=4082267&dur=249.441&lmt=1742333571166542&mt=1747849507&fvip=6&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532534&n=vjbd0dbW7eQg54B_OH-_w8_X8bTR3AzeJIovrIqj4b&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhAKc_enhi422jd6F0Sv6vtk4Ot2Y7V63bicDtD0u99YiGAiBosiRR7-4PNmJyG0mephUolAmoIOMujUSF-Ve1-j4t1A%3D%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube"
May 21 17:52:00 volumio-acer volumio[921]: error: updateQueue error: null
May 21 17:52:00 volumio-acer volumio[921]: info:
May 21 17:52:00 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:00 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:00 volumio-acer volumio[921]: info: ------------------------------ 9ms
May 21 17:52:00 volumio-acer volumio[921]: info: sendMpdCommand addid "https://rr1---sn-3tp8nu5g-3fbe.googlevideo.com/videoplayback?expire=1747871519&ei=vxIuaLiCKJer6dsPj_uBgA0&ip=109.162.37.151&id=o-AN_waX3psny0OOj4C2zl2fyfQJFS325rBM2issCbd9Vv&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849919%2C&mh=zo&mm=31%2C29&mn=sn-3tp8nu5g-3fbe%2Csn-3tp8nu5g-3c2d&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=2296250&bui=AecWEAbmaroVhc2r9SGDEZXZ0WupGz7dfb_Uy5UVG3Hu-wqYnZsLcCQSqxtcwtzRLAKmpDjqxIXIjcGp&spc=wk1kZoaRKA7ZG4iPN7-HuEN1JVrryEBBLehI2Q2Ef-eSOlX3X3BQ4wco99k0gWrMM_w&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ERgYGandb6LKYQ6tpiaD9U4Q&rqh=1&gir=yes&clen=4082267&dur=249.441&lmt=1742333571166542&mt=1747849507&fvip=6&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532534&n=vjbd0dbW7eQg54B_OH-_w8_X8bTR3AzeJIovrIqj4b&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhAKc_enhi422jd6F0Sv6vtk4Ot2Y7V63bicDtD0u99YiGAiBosiRR7-4PNmJyG0mephUolAmoIOMujUSF-Ve1-j4t1A%3D%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube" took 4 milliseconds
May 21 17:52:00 volumio-acer volumio[921]: verbose: MPD COMMAND [object Object]
May 21 17:52:00 volumio-acer volumio[921]: verbose: MPD COMMAND [object Object]
May 21 17:52:00 volumio-acer volumio[921]: verbose: MPD COMMAND [object Object]
May 21 17:52:00 volumio-acer volumio[921]: info:
May 21 17:52:00 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:00 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:00 volumio-acer volumio[921]: info: ------------------------------ 8ms
May 21 17:52:00 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService mpd
May 21 17:52:00 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand play
May 21 17:52:00 volumio-acer volumio[921]: info: ------------------------------ 3ms
May 21 17:52:00 volumio-acer volumio[921]: info: sendMpdCommand play took 1 milliseconds
May 21 17:52:01 volumio-acer volumio[921]: info: Preload queue cleared
May 21 17:52:01 volumio-acer volumio[921]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 21 17:52:01 volumio-acer volumio[921]: info: CoreStateMachine::ClearQueue
May 21 17:52:01 volumio-acer volumio[921]: info: CoreStateMachine::stop
May 21 17:52:01 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:01 volumio-acer volumio[921]: info: CorePlayQueue::clearPlayQueue
May 21 17:52:01 volumio-acer volumio[921]: info: CorePlayQueue::saveQueue
May 21 17:52:01 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushQueue
May 21 17:52:01 volumio-acer volumio[921]: info: CoreStateMachine::addQueueItems
May 21 17:52:01 volumio-acer volumio[921]: info: CorePlayQueue::addQueueItems
May 21 17:52:01 volumio-acer volumio[921]: info: Preload queue cleared
May 21 17:52:01 volumio-acer volumio[921]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D
May 21 17:52:01 volumio-acer volumio[921]: info: Using cached record of: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D
May 21 17:52:01 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushQueue
May 21 17:52:01 volumio-acer volumio[921]: info: CorePlayQueue::saveQueue
May 21 17:52:01 volumio-acer volumio[921]: info: CoreStateMachine::updateTrackBlock
May 21 17:52:01 volumio-acer volumio[921]: info: CorePlayQueue::getTrackBlock
May 21 17:52:01 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPlay
May 21 17:52:01 volumio-acer volumio[921]: info: CoreStateMachine::play index 0
May 21 17:52:01 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:01 volumio-acer volumio[921]: info: CoreStateMachine::stop
May 21 17:52:01 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:01 volumio-acer volumio[921]: info: CoreStateMachine::play index undefined
May 21 17:52:01 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:01 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:01 volumio-acer volumio[921]: info: CoreStateMachine::startPlaybackTimer
May 21 17:52:01 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:01 volumio-acer volumio[921]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22egemoVK0IKY%22%2C%22playlistId%22%3A%22RDCLAK5uy_kmPRjHDECIcuVwnKsx2Ng7fyNgFKWNJFs%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Doechii%20-%20Anxiety%20(Visualizer)%22%2C%22artist%22%3A%22Doechii%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FegemoVK0IKY%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLDdpo1FYTdKq6BWSmidBD4DctUB8w%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22egemoVK0IKY%22%2C%22playlistId%22%3A%22RDCLAK5uy_kmPRjHDECIcuVwnKsx2Ng7fyNgFKWNJFs%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D
May 21 17:52:01 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:01 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:01 volumio-acer volumio[921]: info:
May 21 17:52:01 volumio-acer volumio[921]: ---------------------------- MPD announces state update: player
May 21 17:52:01 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:01 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:01 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:01 volumio-acer volumio[921]: info: sendMpdCommand status took 10 milliseconds
May 21 17:52:01 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:01 volumio-acer volumio[921]: info: sendMpdCommand status took 13 milliseconds
May 21 17:52:01 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:01 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:01 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:01 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:01 volumio-acer volumio[921]: info: sendMpdCommand clearerror took 11 milliseconds
May 21 17:52:01 volumio-acer volumio[921]: info: sendMpdCommand clearerror took 9 milliseconds
May 21 17:52:01 volumio-acer volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 21 17:52:01 volumio-acer volumio[921]: verbose: ControllerMpd::parseTrackInfo
May 21 17:52:01 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:01 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:01 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:01 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:01 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:01 volumio-acer volumio[921]: info: ControllerMpd::pushState
May 21 17:52:01 volumio-acer volumio[921]: info: CoreCommandRouter::servicePushState
May 21 17:52:01 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:01 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:01 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 17:52:01 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:01 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:01 volumio-acer volumio[921]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd
May 21 17:52:01 volumio-acer volumio[921]: info: ------------------------------ 41ms
May 21 17:52:01 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status stop
May 21 17:52:01 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status stop
May 21 17:52:01 volumio-acer sudo[8461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service
May 21 17:52:01 volumio-acer sudo[8461]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 17:52:01 volumio-acer sudo[8461]: pam_unix(sudo:session): session closed for user root
May 21 17:52:01 volumio-acer sudo[8464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
May 21 17:52:01 volumio-acer sudo[8464]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 17:52:01 volumio-acer volumio[921]: info: peppyspectrum Daemon Stop
May 21 17:52:01 volumio-acer sudo[8464]: pam_unix(sudo:session): session closed for user root
May 21 17:52:01 volumio-acer volumio[921]: info: peppymeterbasic Daemon Stop
May 21 17:52:02 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:02 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand stop
May 21 17:52:02 volumio-acer volumio[921]: info: sendMpdCommand stop took 1 milliseconds
May 21 17:52:02 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clear
May 21 17:52:02 volumio-acer volumio[921]: info:
May 21 17:52:02 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:02 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:02 volumio-acer volumio[921]: info: sendMpdCommand clear took 5 milliseconds
May 21 17:52:02 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-3tp8nu5g-3fbe.googlevideo.com/videoplayback?expire=1747871521&ei=wRIuaPz1Gfzx6dsPppuWoAk&ip=109.162.37.151&id=o-ALnZ6LS59nI9afqODWx3B2rImNoH1QMN9x07a7ZJSFTD&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849921%2C&mh=zo&mm=31%2C29&mn=sn-3tp8nu5g-3fbe%2Csn-3tp8nu5g-3c2d&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=2296250&bui=AecWEAZJuAsyPfHuuOiDD6BY2v7bJqyk-5egxUF9PD-BhS_sm1bufRGQO0-jZWLXUQBM5207k-GtMAKO&spc=wk1kZtvqG4K1SwQ2Nw_u7HGInkaxjcB8N--5GsEbkHOaKpEernFTxxGyv3bckVe2piU&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=KwJLRdR22Pk3juuU6Y0ZnF8Q&rqh=1&gir=yes&clen=4082267&dur=249.441&lmt=1742333571166542&mt=1747849507&fvip=6&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532534&n=vjbd0dbW7eQg54B_OH-_w8_ZvXcvhqyJu20uEBB_YU&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIgXWOIf5auhMXUxJWTyapC7Ja7WHbAG2GPcCespIuNpt8CIQDpZXrT-ltcKsk6XXEAq2IsG_RAc7RXVGTMXyeRWFmKUg%3D%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube"
May 21 17:52:02 volumio-acer volumio[921]: error: updateQueue error: null
May 21 17:52:02 volumio-acer volumio[921]: info:
May 21 17:52:02 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:02 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:02 volumio-acer volumio[921]: info: ------------------------------ 5ms
May 21 17:52:02 volumio-acer volumio[921]: info: sendMpdCommand addid "https://rr1---sn-3tp8nu5g-3fbe.googlevideo.com/videoplayback?expire=1747871521&ei=wRIuaPz1Gfzx6dsPppuWoAk&ip=109.162.37.151&id=o-ALnZ6LS59nI9afqODWx3B2rImNoH1QMN9x07a7ZJSFTD&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849921%2C&mh=zo&mm=31%2C29&mn=sn-3tp8nu5g-3fbe%2Csn-3tp8nu5g-3c2d&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=2296250&bui=AecWEAZJuAsyPfHuuOiDD6BY2v7bJqyk-5egxUF9PD-BhS_sm1bufRGQO0-jZWLXUQBM5207k-GtMAKO&spc=wk1kZtvqG4K1SwQ2Nw_u7HGInkaxjcB8N--5GsEbkHOaKpEernFTxxGyv3bckVe2piU&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=KwJLRdR22Pk3juuU6Y0ZnF8Q&rqh=1&gir=yes&clen=4082267&dur=249.441&lmt=1742333571166542&mt=1747849507&fvip=6&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532534&n=vjbd0dbW7eQg54B_OH-_w8_ZvXcvhqyJu20uEBB_YU&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIgXWOIf5auhMXUxJWTyapC7Ja7WHbAG2GPcCespIuNpt8CIQDpZXrT-ltcKsk6XXEAq2IsG_RAc7RXVGTMXyeRWFmKUg%3D%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube" took 2 milliseconds
May 21 17:52:02 volumio-acer volumio[921]: verbose: MPD COMMAND [object Object]
May 21 17:52:02 volumio-acer volumio[921]: info:
May 21 17:52:02 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:02 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:02 volumio-acer volumio[921]: info: ------------------------------ 5ms
May 21 17:52:02 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService mpd
May 21 17:52:02 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand play
May 21 17:52:02 volumio-acer volumio[921]: info: ------------------------------ 4ms
May 21 17:52:02 volumio-acer volumio[921]: info: sendMpdCommand play took 1 milliseconds
May 21 17:52:02 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:02 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:02 volumio-acer volumio[921]: info:
May 21 17:52:02 volumio-acer volumio[921]: ---------------------------- MPD announces state update: player
May 21 17:52:02 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:02 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:02 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:02 volumio-acer volumio[921]: info: sendMpdCommand status took 8 milliseconds
May 21 17:52:02 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:02 volumio-acer volumio[921]: info: sendMpdCommand status took 11 milliseconds
May 21 17:52:02 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:02 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:02 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:02 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:02 volumio-acer volumio[921]: info: sendMpdCommand clearerror took 10 milliseconds
May 21 17:52:02 volumio-acer volumio[921]: info: sendMpdCommand clearerror took 6 milliseconds
May 21 17:52:02 volumio-acer volumio[921]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 21 17:52:02 volumio-acer volumio[921]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 21 17:52:02 volumio-acer volumio[921]: verbose: ControllerMpd::parseTrackInfo
May 21 17:52:02 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:02 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:02 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:02 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:02 volumio-acer volumio[921]: info: ControllerMpd::pushState
May 21 17:52:02 volumio-acer volumio[921]: info: CoreCommandRouter::servicePushState
May 21 17:52:02 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:02 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 17:52:02 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:02 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:02 volumio-acer volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Doechii - Anxiety (Visualizer)","artist":"IamdoechiiVEVO","album":"YouTube","uri":"https://rr1---sn-3tp8nu5g-3fbe.googlevideo.com/videoplayback?expire=1747871521&ei=wRIuaPz1Gfzx6dsPppuWoAk&ip=109.162.37.151&id=o-ALnZ6LS59nI9afqODWx3B2rImNoH1QMN9x07a7ZJSFTD&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849921%2C&mh=zo&mm=31%2C29&mn=sn-3tp8nu5g-3fbe%2Csn-3tp8nu5g-3c2d&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=2296250&bui=AecWEAZJuAsyPfHuuOiDD6BY2v7bJqyk-5egxUF9PD-BhS_sm1bufRGQO0-jZWLXUQBM5207k-GtMAKO&spc=wk1kZtvqG4K1SwQ2Nw_u7HGInkaxjcB8N--5GsEbkHOaKpEernFTxxGyv3bckVe2piU&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=KwJLRdR22Pk3juuU6Y0ZnF8Q&rqh=1&gir=yes&clen=4082267&dur=249.441&lmt=1742333571166542&mt=1747849507&fvip=6&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532534&n=vjbd0dbW7eQg54B_OH-_w8_ZvXcvhqyJu20uEBB_YU&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIgXWOIf5auhMXUxJWTyapC7Ja7WHbAG2GPcCespIuNpt8CIQDpZXrT-ltcKsk6XXEAq2IsG_RAc7RXVGTMXyeRWFmKUg%3D%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"}
May 21 17:52:02 volumio-acer volumio[921]: verbose: CURRENT POSITION 0
May 21 17:52:02 volumio-acer volumio[921]: info: CoreStateMachine::syncState stateService stop
May 21 17:52:02 volumio-acer volumio[921]: info: CoreStateMachine::syncState currentStatus stop
May 21 17:52:02 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:02 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:02 volumio-acer volumio[921]: info: No code
May 21 17:52:02 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:02 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:02 volumio-acer volumio[921]: info: ------------------------------ 49ms
May 21 17:52:02 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status
May 21 17:52:02 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status undefined
May 21 17:52:02 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status undefined
May 21 17:52:02 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status
May 21 17:52:02 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 21 17:52:04 volumio-acer volumio[921]: info: Preload queue cleared
May 21 17:52:04 volumio-acer volumio[921]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 21 17:52:04 volumio-acer volumio[921]: info: CoreStateMachine::ClearQueue
May 21 17:52:04 volumio-acer volumio[921]: info: CoreStateMachine::stop
May 21 17:52:04 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:04 volumio-acer volumio[921]: info: CorePlayQueue::clearPlayQueue
May 21 17:52:04 volumio-acer volumio[921]: info: CorePlayQueue::saveQueue
May 21 17:52:04 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushQueue
May 21 17:52:04 volumio-acer volumio[921]: info: CoreStateMachine::addQueueItems
May 21 17:52:04 volumio-acer volumio[921]: info: CorePlayQueue::addQueueItems
May 21 17:52:04 volumio-acer volumio[921]: info: Preload queue cleared
May 21 17:52:04 volumio-acer volumio[921]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_lBGRuQnsG37Akr1CY4SxL0VWFbPrbO4gs%22%7D%7D%7D
May 21 17:52:04 volumio-acer volumio[921]: info: Exploding uri youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_lBGRuQnsG37Akr1CY4SxL0VWFbPrbO4gs%22%7D%7D%7D in service youtube2
May 21 17:52:04 volumio-acer volumio[921]: info: [youtube2-browse] explodeUri: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_lBGRuQnsG37Akr1CY4SxL0VWFbPrbO4gs%22%7D%7D%7D
May 21 17:52:04 volumio-acer volumiologrotate[604]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory
May 21 17:52:04 volumio-acer volumiologrotate[604]: ls: cannot access 'ACER': No such file or directory
May 21 17:52:05 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushQueue
May 21 17:52:05 volumio-acer volumio[921]: info: CorePlayQueue::saveQueue
May 21 17:52:05 volumio-acer volumio[921]: info: CoreStateMachine::updateTrackBlock
May 21 17:52:05 volumio-acer volumio[921]: info: CorePlayQueue::getTrackBlock
May 21 17:52:05 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPlay
May 21 17:52:05 volumio-acer volumio[921]: info: CoreStateMachine::play index 0
May 21 17:52:05 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:05 volumio-acer volumio[921]: info: CoreStateMachine::stop
May 21 17:52:05 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:05 volumio-acer volumio[921]: info: CoreStateMachine::play index undefined
May 21 17:52:05 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:05 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:05 volumio-acer volumio[921]: info: CoreStateMachine::startPlaybackTimer
May 21 17:52:05 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:05 volumio-acer volumio[921]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%223QwZjhHcLZk%22%2C%22playlistId%22%3A%22RDCLAK5uy_lBGRuQnsG37Akr1CY4SxL0VWFbPrbO4gs%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22BigXthaPlug%20-%20The%20Largest%20(Official%20Music%20Video)%22%2C%22artist%22%3A%22BigXthaPlug%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2F3QwZjhHcLZk%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLA40-wOudMRFY4rMfUuEVRZLQvJbg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%223QwZjhHcLZk%22%2C%22playlistId%22%3A%22RDCLAK5uy_lBGRuQnsG37Akr1CY4SxL0VWFbPrbO4gs%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D
May 21 17:52:06 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:06 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand stop
May 21 17:52:06 volumio-acer volumio[921]: info: sendMpdCommand stop took 0 milliseconds
May 21 17:52:06 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clear
May 21 17:52:06 volumio-acer volumio[921]: info:
May 21 17:52:06 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:06 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:06 volumio-acer volumio[921]: info: sendMpdCommand clear took 1 milliseconds
May 21 17:52:06 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-3tp8nu5g-3fbe.googlevideo.com/videoplayback?expire=1747871525&ei=xRIuaKHfKM2q6dsPh_ao2AY&ip=109.162.37.151&id=o-APvses9AlFLAR9CO_9xH7YFpvSmcHY1E96mSOvJoM7NK&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849925%2C&mh=Nc&mm=31%2C29&mn=sn-3tp8nu5g-3fbe%2Csn-3tp8nu5g-3c2ee&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&initcwndbps=2296250&bui=AecWEAaADAPUWMYKpRK944-FdB_u8J9MvEcAzTN7J2b0icJtQartQAKnp5p3A9dnPtl_cJiCz6664WbW&spc=wk1kZo9PU_5JZGiWTsNajRiwSprZPbtvqYhZL5TY4qux7dQDU99wqFrsatqVzbJutB8&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=XjZIXzbGMe_A7X2nylXZ0ZsQ&rqh=1&gir=yes&clen=2281452&dur=131.781&lmt=1729938082892314&mt=1747849507&fvip=2&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532434&n=vjbd0dbW7eQg54B_OH-_w8_4sX8V0O5fUIjwDy8_6Z&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=ACuhMU0wRgIhAItD6njNGnE04ZpjIaK3byaMBYcJvReYL1sB7hk-PMV-AiEAn6I_QJDJKByJw3knGlwd9hVfVE8ylGK7kfSNkJouWS4%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube"
May 21 17:52:06 volumio-acer volumio[921]: error: updateQueue error: null
May 21 17:52:06 volumio-acer volumio[921]: info: ------------------------------ 0ms
May 21 17:52:06 volumio-acer volumio[921]: info: sendMpdCommand addid "https://rr2---sn-3tp8nu5g-3fbe.googlevideo.com/videoplayback?expire=1747871525&ei=xRIuaKHfKM2q6dsPh_ao2AY&ip=109.162.37.151&id=o-APvses9AlFLAR9CO_9xH7YFpvSmcHY1E96mSOvJoM7NK&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849925%2C&mh=Nc&mm=31%2C29&mn=sn-3tp8nu5g-3fbe%2Csn-3tp8nu5g-3c2ee&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&initcwndbps=2296250&bui=AecWEAaADAPUWMYKpRK944-FdB_u8J9MvEcAzTN7J2b0icJtQartQAKnp5p3A9dnPtl_cJiCz6664WbW&spc=wk1kZo9PU_5JZGiWTsNajRiwSprZPbtvqYhZL5TY4qux7dQDU99wqFrsatqVzbJutB8&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=XjZIXzbGMe_A7X2nylXZ0ZsQ&rqh=1&gir=yes&clen=2281452&dur=131.781&lmt=1729938082892314&mt=1747849507&fvip=2&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532434&n=vjbd0dbW7eQg54B_OH-_w8_4sX8V0O5fUIjwDy8_6Z&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=ACuhMU0wRgIhAItD6njNGnE04ZpjIaK3byaMBYcJvReYL1sB7hk-PMV-AiEAn6I_QJDJKByJw3knGlwd9hVfVE8ylGK7kfSNkJouWS4%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube" took 0 milliseconds
May 21 17:52:06 volumio-acer volumio[921]: verbose: MPD COMMAND [object Object]
May 21 17:52:06 volumio-acer volumio[921]: info:
May 21 17:52:06 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:06 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:06 volumio-acer volumio[921]: info:
May 21 17:52:06 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:06 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService mpd
May 21 17:52:06 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand play
May 21 17:52:06 volumio-acer volumio[921]: info: ------------------------------ 6ms
May 21 17:52:06 volumio-acer volumio[921]: info: sendMpdCommand play took 1 milliseconds
May 21 17:52:06 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:06 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:06 volumio-acer volumio[921]: info:
May 21 17:52:06 volumio-acer volumio[921]: ---------------------------- MPD announces state update: player
May 21 17:52:06 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:06 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:06 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:06 volumio-acer volumio[921]: info: sendMpdCommand status took 13 milliseconds
May 21 17:52:06 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:06 volumio-acer volumio[921]: info: sendMpdCommand status took 11 milliseconds
May 21 17:52:06 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:06 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:06 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:06 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:06 volumio-acer volumio[921]: info: sendMpdCommand clearerror took 6 milliseconds
May 21 17:52:06 volumio-acer volumio[921]: info: sendMpdCommand clearerror took 5 milliseconds
May 21 17:52:06 volumio-acer volumio[921]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 21 17:52:06 volumio-acer volumio[921]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 21 17:52:06 volumio-acer volumio[921]: verbose: ControllerMpd::parseTrackInfo
May 21 17:52:06 volumio-acer volumio[921]: verbose: ControllerMpd::parseTrackInfo
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:06 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:06 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:06 volumio-acer volumio[921]: info: ControllerMpd::pushState
May 21 17:52:06 volumio-acer volumio[921]: info: CoreCommandRouter::servicePushState
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:06 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 17:52:06 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:06 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:06 volumio-acer volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"BigXthaPlug - The Largest (Official Music Video)","artist":"BigXthaPlug","album":"YouTube","uri":"https://rr2---sn-3tp8nu5g-3fbe.googlevideo.com/videoplayback?expire=1747871525&ei=xRIuaKHfKM2q6dsPh_ao2AY&ip=109.162.37.151&id=o-APvses9AlFLAR9CO_9xH7YFpvSmcHY1E96mSOvJoM7NK&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849925%2C&mh=Nc&mm=31%2C29&mn=sn-3tp8nu5g-3fbe%2Csn-3tp8nu5g-3c2ee&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&initcwndbps=2296250&bui=AecWEAaADAPUWMYKpRK944-FdB_u8J9MvEcAzTN7J2b0icJtQartQAKnp5p3A9dnPtl_cJiCz6664WbW&spc=wk1kZo9PU_5JZGiWTsNajRiwSprZPbtvqYhZL5TY4qux7dQDU99wqFrsatqVzbJutB8&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=XjZIXzbGMe_A7X2nylXZ0ZsQ&rqh=1&gir=yes&clen=2281452&dur=131.781&lmt=1729938082892314&mt=1747849507&fvip=2&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532434&n=vjbd0dbW7eQg54B_OH-_w8_4sX8V0O5fUIjwDy8_6Z&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=ACuhMU0wRgIhAItD6njNGnE04ZpjIaK3byaMBYcJvReYL1sB7hk-PMV-AiEAn6I_QJDJKByJw3knGlwd9hVfVE8ylGK7kfSNkJouWS4%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"}
May 21 17:52:06 volumio-acer volumio[921]: verbose: CURRENT POSITION 0
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::syncState stateService stop
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::syncState currentStatus stop
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:06 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:06 volumio-acer volumio[921]: info: No code
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:06 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:06 volumio-acer volumio[921]: info: ------------------------------ 60ms
May 21 17:52:06 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status
May 21 17:52:06 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status undefined
May 21 17:52:06 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status undefined
May 21 17:52:06 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status
May 21 17:52:06 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 21 17:52:06 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 21 17:52:06 volumio-acer volumio[921]: info: Preload queue cleared
May 21 17:52:06 volumio-acer volumio[921]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::ClearQueue
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::stop
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:06 volumio-acer volumio[921]: info: CorePlayQueue::clearPlayQueue
May 21 17:52:06 volumio-acer volumio[921]: info: CorePlayQueue::saveQueue
May 21 17:52:06 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushQueue
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::addQueueItems
May 21 17:52:06 volumio-acer volumio[921]: info: CorePlayQueue::addQueueItems
May 21 17:52:06 volumio-acer volumio[921]: info: Preload queue cleared
May 21 17:52:06 volumio-acer volumio[921]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_lBGRuQnsG37Akr1CY4SxL0VWFbPrbO4gs%22%7D%7D%7D
May 21 17:52:06 volumio-acer volumio[921]: info: Using cached record of: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_lBGRuQnsG37Akr1CY4SxL0VWFbPrbO4gs%22%7D%7D%7D
May 21 17:52:06 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushQueue
May 21 17:52:06 volumio-acer volumio[921]: info: CorePlayQueue::saveQueue
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::updateTrackBlock
May 21 17:52:06 volumio-acer volumio[921]: info: CorePlayQueue::getTrackBlock
May 21 17:52:06 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPlay
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::play index 0
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::stop
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::play index undefined
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:06 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:06 volumio-acer volumio[921]: info: CoreStateMachine::startPlaybackTimer
May 21 17:52:06 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:06 volumio-acer volumio[921]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%223QwZjhHcLZk%22%2C%22playlistId%22%3A%22RDCLAK5uy_lBGRuQnsG37Akr1CY4SxL0VWFbPrbO4gs%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22BigXthaPlug%20-%20The%20Largest%20(Official%20Music%20Video)%22%2C%22artist%22%3A%22BigXthaPlug%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2F3QwZjhHcLZk%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLA40-wOudMRFY4rMfUuEVRZLQvJbg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%223QwZjhHcLZk%22%2C%22playlistId%22%3A%22RDCLAK5uy_lBGRuQnsG37Akr1CY4SxL0VWFbPrbO4gs%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D
May 21 17:52:07 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:07 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand stop
May 21 17:52:07 volumio-acer volumio[921]: info: sendMpdCommand stop took 0 milliseconds
May 21 17:52:07 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clear
May 21 17:52:07 volumio-acer volumio[921]: info:
May 21 17:52:07 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:07 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:07 volumio-acer volumio[921]: info: sendMpdCommand clear took 2 milliseconds
May 21 17:52:07 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-3tp8nu5g-3fbe.googlevideo.com/videoplayback?expire=1747871527&ei=xxIuaO52qfnE3w_7t4Fg&ip=109.162.37.151&id=o-AFp8sZyK1dM43Ii0bCebJdFRRiFrnT9Rbj1q90cS5aeG&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849927%2C&mh=Nc&mm=31%2C29&mn=sn-3tp8nu5g-3fbe%2Csn-3tp8nu5g-3c2ee&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&initcwndbps=2296250&bui=AecWEAYFPl2n9FyvK9AEUZjEBDEo-CGFatAGOo81f3HLXBrwK4oGnWvn48OOzU6j1-7qyyCGE9OPza-U&spc=wk1kZlTYV6wAnzfXp-9o44toLU0yC5X5QSbt0JEVMQtn3lo9Q64Q5fN5rSGJEw4Ee2E&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=7BEfzbCnXvmn3ySKWyHv8ZwQ&rqh=1&gir=yes&clen=2281452&dur=131.781&lmt=1729938082892314&mt=1747849507&fvip=2&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532434&n=vjbd0dbW7eQg54B_OH-_w8_MHbXBFuCSmE_bg96zjl&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=ACuhMU0wRQIhAN2p2zrFgCjDXFeS9RMKgdFitqEzy27wTM2B1UmG4OWSAiA699DS_jyxdqC2fL1tDl_ulY40rmEiZDYJ5N3ecLaA4w%3D%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube"
May 21 17:52:07 volumio-acer volumio[921]: error: updateQueue error: null
May 21 17:52:07 volumio-acer volumio[921]: info:
May 21 17:52:07 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:07 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:07 volumio-acer volumio[921]: info: ------------------------------ 4ms
May 21 17:52:07 volumio-acer volumio[921]: info: sendMpdCommand addid "https://rr2---sn-3tp8nu5g-3fbe.googlevideo.com/videoplayback?expire=1747871527&ei=xxIuaO52qfnE3w_7t4Fg&ip=109.162.37.151&id=o-AFp8sZyK1dM43Ii0bCebJdFRRiFrnT9Rbj1q90cS5aeG&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849927%2C&mh=Nc&mm=31%2C29&mn=sn-3tp8nu5g-3fbe%2Csn-3tp8nu5g-3c2ee&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&initcwndbps=2296250&bui=AecWEAYFPl2n9FyvK9AEUZjEBDEo-CGFatAGOo81f3HLXBrwK4oGnWvn48OOzU6j1-7qyyCGE9OPza-U&spc=wk1kZlTYV6wAnzfXp-9o44toLU0yC5X5QSbt0JEVMQtn3lo9Q64Q5fN5rSGJEw4Ee2E&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=7BEfzbCnXvmn3ySKWyHv8ZwQ&rqh=1&gir=yes&clen=2281452&dur=131.781&lmt=1729938082892314&mt=1747849507&fvip=2&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532434&n=vjbd0dbW7eQg54B_OH-_w8_MHbXBFuCSmE_bg96zjl&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=ACuhMU0wRQIhAN2p2zrFgCjDXFeS9RMKgdFitqEzy27wTM2B1UmG4OWSAiA699DS_jyxdqC2fL1tDl_ulY40rmEiZDYJ5N3ecLaA4w%3D%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube" took 2 milliseconds
May 21 17:52:07 volumio-acer volumio[921]: verbose: MPD COMMAND [object Object]
May 21 17:52:07 volumio-acer volumio[921]: verbose: MPD COMMAND [object Object]
May 21 17:52:07 volumio-acer volumio[921]: verbose: MPD COMMAND [object Object]
May 21 17:52:07 volumio-acer volumio[921]: info:
May 21 17:52:07 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:07 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:07 volumio-acer volumio[921]: info: ------------------------------ 3ms
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService mpd
May 21 17:52:07 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand play
May 21 17:52:07 volumio-acer volumio[921]: info: ------------------------------ 1ms
May 21 17:52:07 volumio-acer volumio[921]: info: sendMpdCommand play took 3 milliseconds
May 21 17:52:07 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:07 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:07 volumio-acer volumio[921]: info:
May 21 17:52:07 volumio-acer volumio[921]: ---------------------------- MPD announces state update: player
May 21 17:52:07 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:07 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:07 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:07 volumio-acer volumio[921]: info: sendMpdCommand status took 11 milliseconds
May 21 17:52:07 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:07 volumio-acer volumio[921]: info: sendMpdCommand status took 9 milliseconds
May 21 17:52:07 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:07 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:07 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:07 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:07 volumio-acer volumio[921]: info: sendMpdCommand clearerror took 8 milliseconds
May 21 17:52:07 volumio-acer volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 21 17:52:07 volumio-acer volumio[921]: info: sendMpdCommand playlistinfo took 0 milliseconds
May 21 17:52:07 volumio-acer volumio[921]: verbose: ControllerMpd::parseTrackInfo
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:07 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:07 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:07 volumio-acer volumio[921]: info: ControllerMpd::pushState
May 21 17:52:07 volumio-acer volumio[921]: info: CoreCommandRouter::servicePushState
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:07 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 17:52:07 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:07 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:07 volumio-acer volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"BigXthaPlug - The Largest (Official Music Video)","artist":"BigXthaPlug","album":"YouTube","uri":"https://rr2---sn-3tp8nu5g-3fbe.googlevideo.com/videoplayback?expire=1747871527&ei=xxIuaO52qfnE3w_7t4Fg&ip=109.162.37.151&id=o-AFp8sZyK1dM43Ii0bCebJdFRRiFrnT9Rbj1q90cS5aeG&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849927%2C&mh=Nc&mm=31%2C29&mn=sn-3tp8nu5g-3fbe%2Csn-3tp8nu5g-3c2ee&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&initcwndbps=2296250&bui=AecWEAYFPl2n9FyvK9AEUZjEBDEo-CGFatAGOo81f3HLXBrwK4oGnWvn48OOzU6j1-7qyyCGE9OPza-U&spc=wk1kZlTYV6wAnzfXp-9o44toLU0yC5X5QSbt0JEVMQtn3lo9Q64Q5fN5rSGJEw4Ee2E&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=7BEfzbCnXvmn3ySKWyHv8ZwQ&rqh=1&gir=yes&clen=2281452&dur=131.781&lmt=1729938082892314&mt=1747849507&fvip=2&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532434&n=vjbd0dbW7eQg54B_OH-_w8_MHbXBFuCSmE_bg96zjl&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=ACuhMU0wRQIhAN2p2zrFgCjDXFeS9RMKgdFitqEzy27wTM2B1UmG4OWSAiA699DS_jyxdqC2fL1tDl_ulY40rmEiZDYJ5N3ecLaA4w%3D%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"}
May 21 17:52:07 volumio-acer volumio[921]: verbose: CURRENT POSITION 0
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::syncState stateService stop
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::syncState currentStatus stop
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:07 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:07 volumio-acer volumio[921]: info: No code
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:07 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:07 volumio-acer volumio[921]: info: ------------------------------ 44ms
May 21 17:52:07 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status
May 21 17:52:07 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status undefined
May 21 17:52:07 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status
May 21 17:52:07 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 21 17:52:07 volumio-acer volumio[921]: info: Preload queue cleared
May 21 17:52:07 volumio-acer volumio[921]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::ClearQueue
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::stop
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:07 volumio-acer volumio[921]: info: CorePlayQueue::clearPlayQueue
May 21 17:52:07 volumio-acer volumio[921]: info: CorePlayQueue::saveQueue
May 21 17:52:07 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushQueue
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::addQueueItems
May 21 17:52:07 volumio-acer volumio[921]: info: CorePlayQueue::addQueueItems
May 21 17:52:07 volumio-acer volumio[921]: info: Preload queue cleared
May 21 17:52:07 volumio-acer volumio[921]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_lBGRuQnsG37Akr1CY4SxL0VWFbPrbO4gs%22%7D%7D%7D
May 21 17:52:07 volumio-acer volumio[921]: info: Using cached record of: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_lBGRuQnsG37Akr1CY4SxL0VWFbPrbO4gs%22%7D%7D%7D
May 21 17:52:07 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushQueue
May 21 17:52:07 volumio-acer volumio[921]: info: CorePlayQueue::saveQueue
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::updateTrackBlock
May 21 17:52:07 volumio-acer volumio[921]: info: CorePlayQueue::getTrackBlock
May 21 17:52:07 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPlay
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::play index 0
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::stop
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::play index undefined
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:07 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:07 volumio-acer volumio[921]: info: CoreStateMachine::startPlaybackTimer
May 21 17:52:07 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:07 volumio-acer volumio[921]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%223QwZjhHcLZk%22%2C%22playlistId%22%3A%22RDCLAK5uy_lBGRuQnsG37Akr1CY4SxL0VWFbPrbO4gs%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22BigXthaPlug%20-%20The%20Largest%20(Official%20Music%20Video)%22%2C%22artist%22%3A%22BigXthaPlug%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2F3QwZjhHcLZk%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLA40-wOudMRFY4rMfUuEVRZLQvJbg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%223QwZjhHcLZk%22%2C%22playlistId%22%3A%22RDCLAK5uy_lBGRuQnsG37Akr1CY4SxL0VWFbPrbO4gs%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D
May 21 17:52:08 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:08 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand stop
May 21 17:52:08 volumio-acer volumio[921]: info: sendMpdCommand stop took 0 milliseconds
May 21 17:52:08 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clear
May 21 17:52:08 volumio-acer volumio[921]: info:
May 21 17:52:08 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:08 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:08 volumio-acer volumio[921]: info: sendMpdCommand clear took 0 milliseconds
May 21 17:52:08 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-3tp8nu5g-3fbe.googlevideo.com/videoplayback?expire=1747871528&ei=yBIuaPPpBPLD6dsPyuDqoAk&ip=109.162.37.151&id=o-ADmB9f7PuDHEhA-4o-w2hsSuFe4T5rGqaybczSPFT6Zs&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849928%2C&mh=Nc&mm=31%2C29&mn=sn-3tp8nu5g-3fbe%2Csn-3tp8nu5g-3c2ee&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&initcwndbps=2296250&bui=AecWEAbcHospfOCcHibQMLbjOKPxzdaNX6cP_Gg4yJ4_kBglKrM9tW6ySEqpGf24Vn522rTrTOoVoz5O&spc=wk1kZo8wbZLndDIvaF6Cr89RgdpDwUD5GuY6qXuZTvwl7PrlZuSAILTFNAHLB9IDrfw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=9HEJdrhGbQhUn-wHQjGN_RMQ&rqh=1&gir=yes&clen=2281452&dur=131.781&lmt=1729938082892314&mt=1747849507&fvip=2&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532434&n=vjbd0dbW7eQg54B_OH-_w8_dLbIf4LMKCGZW0Ijbjv&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=ACuhMU0wRAIgQMJj6dd1b1dfB6rUB9B_7-1zeLkf2B3lBvZLKAHHDYkCIEmigq70eEjO4xUTI4r5uq6k-7yyZGzCzVthhynvxRXo&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube"
May 21 17:52:08 volumio-acer volumio[921]: error: updateQueue error: null
May 21 17:52:08 volumio-acer volumio[921]: info: ------------------------------ 0ms
May 21 17:52:08 volumio-acer volumio[921]: info:
May 21 17:52:08 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:08 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:08 volumio-acer volumio[921]: info: sendMpdCommand addid "https://rr2---sn-3tp8nu5g-3fbe.googlevideo.com/videoplayback?expire=1747871528&ei=yBIuaPPpBPLD6dsPyuDqoAk&ip=109.162.37.151&id=o-ADmB9f7PuDHEhA-4o-w2hsSuFe4T5rGqaybczSPFT6Zs&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849928%2C&mh=Nc&mm=31%2C29&mn=sn-3tp8nu5g-3fbe%2Csn-3tp8nu5g-3c2ee&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&initcwndbps=2296250&bui=AecWEAbcHospfOCcHibQMLbjOKPxzdaNX6cP_Gg4yJ4_kBglKrM9tW6ySEqpGf24Vn522rTrTOoVoz5O&spc=wk1kZo8wbZLndDIvaF6Cr89RgdpDwUD5GuY6qXuZTvwl7PrlZuSAILTFNAHLB9IDrfw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=9HEJdrhGbQhUn-wHQjGN_RMQ&rqh=1&gir=yes&clen=2281452&dur=131.781&lmt=1729938082892314&mt=1747849507&fvip=2&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532434&n=vjbd0dbW7eQg54B_OH-_w8_dLbIf4LMKCGZW0Ijbjv&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=ACuhMU0wRAIgQMJj6dd1b1dfB6rUB9B_7-1zeLkf2B3lBvZLKAHHDYkCIEmigq70eEjO4xUTI4r5uq6k-7yyZGzCzVthhynvxRXo&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube" took 0 milliseconds
May 21 17:52:08 volumio-acer volumio[921]: verbose: MPD COMMAND [object Object]
May 21 17:52:08 volumio-acer volumio[921]: info:
May 21 17:52:08 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:08 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:08 volumio-acer volumio[921]: info: ------------------------------ 1ms
May 21 17:52:08 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService mpd
May 21 17:52:08 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand play
May 21 17:52:08 volumio-acer volumio[921]: info: ------------------------------ 0ms
May 21 17:52:08 volumio-acer volumio[921]: info: sendMpdCommand play took 9 milliseconds
May 21 17:52:08 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:08 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:08 volumio-acer volumio[921]: info:
May 21 17:52:08 volumio-acer volumio[921]: ---------------------------- MPD announces state update: player
May 21 17:52:08 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:08 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:08 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:08 volumio-acer volumio[921]: info: sendMpdCommand status took 9 milliseconds
May 21 17:52:08 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:08 volumio-acer volumio[921]: info: sendMpdCommand status took 9 milliseconds
May 21 17:52:08 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:08 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:08 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:08 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:08 volumio-acer volumio[921]: info: sendMpdCommand clearerror took 8 milliseconds
May 21 17:52:08 volumio-acer volumio[921]: info: sendMpdCommand clearerror took 7 milliseconds
May 21 17:52:08 volumio-acer volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 21 17:52:08 volumio-acer volumio[921]: info: sendMpdCommand playlistinfo took 0 milliseconds
May 21 17:52:08 volumio-acer volumio[921]: verbose: ControllerMpd::parseTrackInfo
May 21 17:52:08 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:08 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:08 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:08 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:08 volumio-acer volumio[921]: info: ControllerMpd::pushState
May 21 17:52:08 volumio-acer volumio[921]: info: CoreCommandRouter::servicePushState
May 21 17:52:08 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:08 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 17:52:08 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:08 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:08 volumio-acer volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"BigXthaPlug - The Largest (Official Music Video)","artist":"BigXthaPlug","album":"YouTube","uri":"https://rr2---sn-3tp8nu5g-3fbe.googlevideo.com/videoplayback?expire=1747871528&ei=yBIuaPPpBPLD6dsPyuDqoAk&ip=109.162.37.151&id=o-ADmB9f7PuDHEhA-4o-w2hsSuFe4T5rGqaybczSPFT6Zs&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849928%2C&mh=Nc&mm=31%2C29&mn=sn-3tp8nu5g-3fbe%2Csn-3tp8nu5g-3c2ee&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&initcwndbps=2296250&bui=AecWEAbcHospfOCcHibQMLbjOKPxzdaNX6cP_Gg4yJ4_kBglKrM9tW6ySEqpGf24Vn522rTrTOoVoz5O&spc=wk1kZo8wbZLndDIvaF6Cr89RgdpDwUD5GuY6qXuZTvwl7PrlZuSAILTFNAHLB9IDrfw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=9HEJdrhGbQhUn-wHQjGN_RMQ&rqh=1&gir=yes&clen=2281452&dur=131.781&lmt=1729938082892314&mt=1747849507&fvip=2&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532434&n=vjbd0dbW7eQg54B_OH-_w8_dLbIf4LMKCGZW0Ijbjv&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=ACuhMU0wRAIgQMJj6dd1b1dfB6rUB9B_7-1zeLkf2B3lBvZLKAHHDYkCIEmigq70eEjO4xUTI4r5uq6k-7yyZGzCzVthhynvxRXo&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"}
May 21 17:52:08 volumio-acer volumio[921]: verbose: CURRENT POSITION 0
May 21 17:52:08 volumio-acer volumio[921]: info: CoreStateMachine::syncState stateService stop
May 21 17:52:08 volumio-acer volumio[921]: info: CoreStateMachine::syncState currentStatus stop
May 21 17:52:08 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:08 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:08 volumio-acer volumio[921]: info: No code
May 21 17:52:08 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:08 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:08 volumio-acer volumio[921]: info: ------------------------------ 52ms
May 21 17:52:08 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status
May 21 17:52:08 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status undefined
May 21 17:52:08 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status undefined
May 21 17:52:08 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status
May 21 17:52:08 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 21 17:52:08 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 21 17:52:16 volumio-acer volumio[921]: info: Preload queue cleared
May 21 17:52:16 volumio-acer volumio[921]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 21 17:52:16 volumio-acer volumio[921]: info: CoreStateMachine::ClearQueue
May 21 17:52:16 volumio-acer volumio[921]: info: CoreStateMachine::stop
May 21 17:52:16 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:16 volumio-acer volumio[921]: info: CorePlayQueue::clearPlayQueue
May 21 17:52:16 volumio-acer volumio[921]: info: CorePlayQueue::saveQueue
May 21 17:52:16 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushQueue
May 21 17:52:16 volumio-acer volumio[921]: info: CoreStateMachine::addQueueItems
May 21 17:52:16 volumio-acer volumio[921]: info: CorePlayQueue::addQueueItems
May 21 17:52:16 volumio-acer volumio[921]: info: Preload queue cleared
May 21 17:52:16 volumio-acer volumio[921]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_k5n4srrEB1wgvIjPNTXS9G1ufE9WQxhnA%22%7D%7D%7D
May 21 17:52:16 volumio-acer volumio[921]: info: Exploding uri youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_k5n4srrEB1wgvIjPNTXS9G1ufE9WQxhnA%22%7D%7D%7D in service youtube2
May 21 17:52:16 volumio-acer volumio[921]: info: [youtube2-browse] explodeUri: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_k5n4srrEB1wgvIjPNTXS9G1ufE9WQxhnA%22%7D%7D%7D
May 21 17:52:17 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushQueue
May 21 17:52:17 volumio-acer volumio[921]: info: CorePlayQueue::saveQueue
May 21 17:52:17 volumio-acer volumio[921]: info: CoreStateMachine::updateTrackBlock
May 21 17:52:17 volumio-acer volumio[921]: info: CorePlayQueue::getTrackBlock
May 21 17:52:17 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPlay
May 21 17:52:17 volumio-acer volumio[921]: info: CoreStateMachine::play index 0
May 21 17:52:17 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:17 volumio-acer volumio[921]: info: CoreStateMachine::stop
May 21 17:52:17 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:17 volumio-acer volumio[921]: info: CoreStateMachine::play index undefined
May 21 17:52:17 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:17 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:17 volumio-acer volumio[921]: info: CoreStateMachine::startPlaybackTimer
May 21 17:52:17 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:17 volumio-acer volumio[921]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22hNrwlzBeFN8%22%2C%22playlistId%22%3A%22RDCLAK5uy_k5n4srrEB1wgvIjPNTXS9G1ufE9WQxhnA%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Morgan%20Wallen%20-%20What%20I%20Want%20(feat.%20Tate%20McRae)%20(Lyric%20Video)%22%2C%22artist%22%3A%22Morgan%20Wallen%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FhNrwlzBeFN8%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBDuWnfFiEMty-YI0ej4lyDcRZDkw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22hNrwlzBeFN8%22%2C%22playlistId%22%3A%22RDCLAK5uy_k5n4srrEB1wgvIjPNTXS9G1ufE9WQxhnA%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D
May 21 17:52:17 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:17 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand stop
May 21 17:52:17 volumio-acer volumio[921]: info: sendMpdCommand stop took 1 milliseconds
May 21 17:52:17 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clear
May 21 17:52:17 volumio-acer volumio[921]: info:
May 21 17:52:17 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:17 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:17 volumio-acer volumio[921]: info: sendMpdCommand clear took 0 milliseconds
May 21 17:52:17 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand addid "https://rr3---sn-3tp8nu5g-3fbl.googlevideo.com/videoplayback?expire=1747871537&ei=0RIuaPaWEbKJ6dsPlMe8sQQ&ip=109.162.37.151&id=o-AEeFNdR6ogmWpfOU7kxqEHla2bqfP2P982gnf0LZoQKH&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849937%2C&mh=eK&mm=31%2C29&mn=sn-3tp8nu5g-3fbl%2Csn-3tp8nu5g-3c2y&ms=au%2Crdu&mv=m&mvi=3&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=2317500&bui=AecWEAYBDFOVKj0pI2_ZGEpMOkpkiQobPOm6bqiljMoFkDxlV4xLlRsRw7FTGhLpGa-dMlCDrzkVm9G2&spc=wk1kZjHmYUw1c215SbnNCjDDyjrrYosRE8MF1dNanWhnnHEoZwrlVd3MT-3IRohZaeY&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Ga4lQOhJVClmt2TRUBhRdjsQ&rqh=1&gir=yes&clen=3225661&dur=183.041&lmt=1747502793833414&mt=1747849507&fvip=1&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532534&n=vjbd0dbW7eQg54B_OH-_w8_eJXpksdlNiWrnfWyXED&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIgDab3lCgkBs065PI-0oPSmsUTT2pOR2K6nAUl7sxAcfoCIQCMBDWQ0szOQWW1JOmO4zJBqR6MvZrrAoNekCXxsKkS8A%3D%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube"
May 21 17:52:17 volumio-acer volumio[921]: error: updateQueue error: null
May 21 17:52:17 volumio-acer volumio[921]: info:
May 21 17:52:17 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:17 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:17 volumio-acer volumio[921]: info: ------------------------------ 3ms
May 21 17:52:17 volumio-acer volumio[921]: info: sendMpdCommand addid "https://rr3---sn-3tp8nu5g-3fbl.googlevideo.com/videoplayback?expire=1747871537&ei=0RIuaPaWEbKJ6dsPlMe8sQQ&ip=109.162.37.151&id=o-AEeFNdR6ogmWpfOU7kxqEHla2bqfP2P982gnf0LZoQKH&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849937%2C&mh=eK&mm=31%2C29&mn=sn-3tp8nu5g-3fbl%2Csn-3tp8nu5g-3c2y&ms=au%2Crdu&mv=m&mvi=3&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=2317500&bui=AecWEAYBDFOVKj0pI2_ZGEpMOkpkiQobPOm6bqiljMoFkDxlV4xLlRsRw7FTGhLpGa-dMlCDrzkVm9G2&spc=wk1kZjHmYUw1c215SbnNCjDDyjrrYosRE8MF1dNanWhnnHEoZwrlVd3MT-3IRohZaeY&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Ga4lQOhJVClmt2TRUBhRdjsQ&rqh=1&gir=yes&clen=3225661&dur=183.041&lmt=1747502793833414&mt=1747849507&fvip=1&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532534&n=vjbd0dbW7eQg54B_OH-_w8_eJXpksdlNiWrnfWyXED&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIgDab3lCgkBs065PI-0oPSmsUTT2pOR2K6nAUl7sxAcfoCIQCMBDWQ0szOQWW1JOmO4zJBqR6MvZrrAoNekCXxsKkS8A%3D%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube" took 1 milliseconds
May 21 17:52:17 volumio-acer volumio[921]: verbose: MPD COMMAND [object Object]
May 21 17:52:17 volumio-acer volumio[921]: info:
May 21 17:52:17 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:17 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:17 volumio-acer volumio[921]: info: ------------------------------ 1ms
May 21 17:52:17 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService mpd
May 21 17:52:17 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand play
May 21 17:52:17 volumio-acer volumio[921]: info: ------------------------------ 0ms
May 21 17:52:17 volumio-acer volumio[921]: info: sendMpdCommand play took 0 milliseconds
May 21 17:52:18 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:18 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:18 volumio-acer volumio[921]: info:
May 21 17:52:18 volumio-acer volumio[921]: ---------------------------- MPD announces state update: player
May 21 17:52:18 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:18 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:18 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:18 volumio-acer volumio[921]: info: sendMpdCommand status took 7 milliseconds
May 21 17:52:18 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:18 volumio-acer volumio[921]: info: sendMpdCommand status took 11 milliseconds
May 21 17:52:18 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:18 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:18 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:18 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:18 volumio-acer volumio[921]: info: sendMpdCommand clearerror took 12 milliseconds
May 21 17:52:18 volumio-acer volumio[921]: info: sendMpdCommand clearerror took 8 milliseconds
May 21 17:52:18 volumio-acer volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 21 17:52:18 volumio-acer volumio[921]: info: sendMpdCommand playlistinfo took 0 milliseconds
May 21 17:52:18 volumio-acer volumio[921]: verbose: ControllerMpd::parseTrackInfo
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:18 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:18 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:18 volumio-acer volumio[921]: info: ControllerMpd::pushState
May 21 17:52:18 volumio-acer volumio[921]: info: CoreCommandRouter::servicePushState
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:18 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 17:52:18 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:18 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:18 volumio-acer volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Morgan Wallen - What I Want (feat. Tate McRae) (Lyric Video)","artist":"Morgan Wallen","album":"YouTube","uri":"https://rr3---sn-3tp8nu5g-3fbl.googlevideo.com/videoplayback?expire=1747871537&ei=0RIuaPaWEbKJ6dsPlMe8sQQ&ip=109.162.37.151&id=o-AEeFNdR6ogmWpfOU7kxqEHla2bqfP2P982gnf0LZoQKH&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849937%2C&mh=eK&mm=31%2C29&mn=sn-3tp8nu5g-3fbl%2Csn-3tp8nu5g-3c2y&ms=au%2Crdu&mv=m&mvi=3&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=2317500&bui=AecWEAYBDFOVKj0pI2_ZGEpMOkpkiQobPOm6bqiljMoFkDxlV4xLlRsRw7FTGhLpGa-dMlCDrzkVm9G2&spc=wk1kZjHmYUw1c215SbnNCjDDyjrrYosRE8MF1dNanWhnnHEoZwrlVd3MT-3IRohZaeY&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Ga4lQOhJVClmt2TRUBhRdjsQ&rqh=1&gir=yes&clen=3225661&dur=183.041&lmt=1747502793833414&mt=1747849507&fvip=1&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532534&n=vjbd0dbW7eQg54B_OH-_w8_eJXpksdlNiWrnfWyXED&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIgDab3lCgkBs065PI-0oPSmsUTT2pOR2K6nAUl7sxAcfoCIQCMBDWQ0szOQWW1JOmO4zJBqR6MvZrrAoNekCXxsKkS8A%3D%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"}
May 21 17:52:18 volumio-acer volumio[921]: verbose: CURRENT POSITION 0
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::syncState stateService stop
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::syncState currentStatus stop
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:18 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:18 volumio-acer volumio[921]: info: No code
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:18 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:18 volumio-acer volumio[921]: info: ------------------------------ 42ms
May 21 17:52:18 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status
May 21 17:52:18 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status undefined
May 21 17:52:18 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status undefined
May 21 17:52:18 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status
May 21 17:52:18 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 21 17:52:18 volumio-acer volumio[921]: info: Preload queue cleared
May 21 17:52:18 volumio-acer volumio[921]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::ClearQueue
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::stop
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:18 volumio-acer volumio[921]: info: CorePlayQueue::clearPlayQueue
May 21 17:52:18 volumio-acer volumio[921]: info: CorePlayQueue::saveQueue
May 21 17:52:18 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushQueue
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::addQueueItems
May 21 17:52:18 volumio-acer volumio[921]: info: CorePlayQueue::addQueueItems
May 21 17:52:18 volumio-acer volumio[921]: info: Preload queue cleared
May 21 17:52:18 volumio-acer volumio[921]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_k5n4srrEB1wgvIjPNTXS9G1ufE9WQxhnA%22%7D%7D%7D
May 21 17:52:18 volumio-acer volumio[921]: info: Using cached record of: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_k5n4srrEB1wgvIjPNTXS9G1ufE9WQxhnA%22%7D%7D%7D
May 21 17:52:18 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushQueue
May 21 17:52:18 volumio-acer volumio[921]: info: CorePlayQueue::saveQueue
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::updateTrackBlock
May 21 17:52:18 volumio-acer volumio[921]: info: CorePlayQueue::getTrackBlock
May 21 17:52:18 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPlay
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::play index 0
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::stop
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::play index undefined
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:18 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:18 volumio-acer volumio[921]: info: CoreStateMachine::startPlaybackTimer
May 21 17:52:18 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:18 volumio-acer volumio[921]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22hNrwlzBeFN8%22%2C%22playlistId%22%3A%22RDCLAK5uy_k5n4srrEB1wgvIjPNTXS9G1ufE9WQxhnA%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Morgan%20Wallen%20-%20What%20I%20Want%20(feat.%20Tate%20McRae)%20(Lyric%20Video)%22%2C%22artist%22%3A%22Morgan%20Wallen%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FhNrwlzBeFN8%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBDuWnfFiEMty-YI0ej4lyDcRZDkw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22hNrwlzBeFN8%22%2C%22playlistId%22%3A%22RDCLAK5uy_k5n4srrEB1wgvIjPNTXS9G1ufE9WQxhnA%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D
May 21 17:52:19 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:19 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand stop
May 21 17:52:19 volumio-acer volumio[921]: info: sendMpdCommand stop took 1 milliseconds
May 21 17:52:19 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clear
May 21 17:52:19 volumio-acer volumio[921]: info:
May 21 17:52:19 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:19 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:19 volumio-acer volumio[921]: info: sendMpdCommand clear took 0 milliseconds
May 21 17:52:19 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand addid "https://rr3---sn-3tp8nu5g-3fbl.googlevideo.com/videoplayback?expire=1747871539&ei=0xIuaM7iBoPsi9oP-sOtyQc&ip=109.162.37.151&id=o-AGt487LvMXQFo2UckJcgQScKrPOWeiAbMc5mF-Sj85H4&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849939%2C&mh=eK&mm=31%2C29&mn=sn-3tp8nu5g-3fbl%2Csn-3tp8nu5g-3c2y&ms=au%2Crdu&mv=m&mvi=3&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=2317500&bui=AecWEAb39BqZyGjGsQVClLA2eCFOM-jDH3hho-_SLNnGlGyK9axxlU-HX38VnNM5WhvuNcXHWAS164G-&spc=wk1kZvB-gSW03Mh2zpLhaMaWBRJJgC9WigRctpPPCyDVAhGMOq6YrBu3fHyVOg6JHkg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=8Np1daOEIgQEGWy3-DV2-FoQ&rqh=1&gir=yes&clen=3225661&dur=183.041&lmt=1747502793833414&mt=1747849507&fvip=1&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532534&n=vjbd0dbW7eQg54B_OH-_w8_9Uvq3H3vurLJW9F_K1Y&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhAPWbmYCJ2kUGTQezMStZxbr4wOgEYdxJO30W8tj_O9BzAiAUAkgH05PcqwdXVqTK5JOR7EoheH_oJsYvn7LoX-hyvA%3D%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube"
May 21 17:52:19 volumio-acer volumio[921]: error: updateQueue error: null
May 21 17:52:19 volumio-acer volumio[921]: info: ------------------------------ 1ms
May 21 17:52:19 volumio-acer volumio[921]: info:
May 21 17:52:19 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:19 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:19 volumio-acer volumio[921]: info: sendMpdCommand addid "https://rr3---sn-3tp8nu5g-3fbl.googlevideo.com/videoplayback?expire=1747871539&ei=0xIuaM7iBoPsi9oP-sOtyQc&ip=109.162.37.151&id=o-AGt487LvMXQFo2UckJcgQScKrPOWeiAbMc5mF-Sj85H4&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849939%2C&mh=eK&mm=31%2C29&mn=sn-3tp8nu5g-3fbl%2Csn-3tp8nu5g-3c2y&ms=au%2Crdu&mv=m&mvi=3&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=2317500&bui=AecWEAb39BqZyGjGsQVClLA2eCFOM-jDH3hho-_SLNnGlGyK9axxlU-HX38VnNM5WhvuNcXHWAS164G-&spc=wk1kZvB-gSW03Mh2zpLhaMaWBRJJgC9WigRctpPPCyDVAhGMOq6YrBu3fHyVOg6JHkg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=8Np1daOEIgQEGWy3-DV2-FoQ&rqh=1&gir=yes&clen=3225661&dur=183.041&lmt=1747502793833414&mt=1747849507&fvip=1&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532534&n=vjbd0dbW7eQg54B_OH-_w8_9Uvq3H3vurLJW9F_K1Y&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhAPWbmYCJ2kUGTQezMStZxbr4wOgEYdxJO30W8tj_O9BzAiAUAkgH05PcqwdXVqTK5JOR7EoheH_oJsYvn7LoX-hyvA%3D%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube" took 1 milliseconds
May 21 17:52:19 volumio-acer volumio[921]: verbose: MPD COMMAND [object Object]
May 21 17:52:19 volumio-acer volumio[921]: info:
May 21 17:52:19 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:19 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:19 volumio-acer volumio[921]: info: ------------------------------ 0ms
May 21 17:52:19 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService mpd
May 21 17:52:19 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand play
May 21 17:52:19 volumio-acer volumio[921]: info: ------------------------------ 1ms
May 21 17:52:19 volumio-acer volumio[921]: info: sendMpdCommand play took 0 milliseconds
May 21 17:52:19 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:19 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:19 volumio-acer volumio[921]: info:
May 21 17:52:19 volumio-acer volumio[921]: ---------------------------- MPD announces state update: player
May 21 17:52:19 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:19 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:19 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:19 volumio-acer volumio[921]: info: sendMpdCommand status took 4 milliseconds
May 21 17:52:19 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:19 volumio-acer volumio[921]: info: sendMpdCommand status took 5 milliseconds
May 21 17:52:19 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:19 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:19 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:19 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:19 volumio-acer volumio[921]: info: sendMpdCommand clearerror took 8 milliseconds
May 21 17:52:19 volumio-acer volumio[921]: info: sendMpdCommand clearerror took 7 milliseconds
May 21 17:52:19 volumio-acer volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 21 17:52:19 volumio-acer volumio[921]: verbose: ControllerMpd::parseTrackInfo
May 21 17:52:19 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:19 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:19 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:19 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:19 volumio-acer volumio[921]: info: ControllerMpd::pushState
May 21 17:52:19 volumio-acer volumio[921]: info: CoreCommandRouter::servicePushState
May 21 17:52:19 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:19 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 17:52:19 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:19 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:19 volumio-acer volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Morgan Wallen - What I Want (feat. Tate McRae) (Lyric Video)","artist":"Morgan Wallen","album":"YouTube","uri":"https://rr3---sn-3tp8nu5g-3fbl.googlevideo.com/videoplayback?expire=1747871539&ei=0xIuaM7iBoPsi9oP-sOtyQc&ip=109.162.37.151&id=o-AGt487LvMXQFo2UckJcgQScKrPOWeiAbMc5mF-Sj85H4&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849939%2C&mh=eK&mm=31%2C29&mn=sn-3tp8nu5g-3fbl%2Csn-3tp8nu5g-3c2y&ms=au%2Crdu&mv=m&mvi=3&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=2317500&bui=AecWEAb39BqZyGjGsQVClLA2eCFOM-jDH3hho-_SLNnGlGyK9axxlU-HX38VnNM5WhvuNcXHWAS164G-&spc=wk1kZvB-gSW03Mh2zpLhaMaWBRJJgC9WigRctpPPCyDVAhGMOq6YrBu3fHyVOg6JHkg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=8Np1daOEIgQEGWy3-DV2-FoQ&rqh=1&gir=yes&clen=3225661&dur=183.041&lmt=1747502793833414&mt=1747849507&fvip=1&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532534&n=vjbd0dbW7eQg54B_OH-_w8_9Uvq3H3vurLJW9F_K1Y&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhAPWbmYCJ2kUGTQezMStZxbr4wOgEYdxJO30W8tj_O9BzAiAUAkgH05PcqwdXVqTK5JOR7EoheH_oJsYvn7LoX-hyvA%3D%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"}
May 21 17:52:19 volumio-acer volumio[921]: verbose: CURRENT POSITION 0
May 21 17:52:19 volumio-acer volumio[921]: info: CoreStateMachine::syncState stateService stop
May 21 17:52:19 volumio-acer volumio[921]: info: CoreStateMachine::syncState currentStatus stop
May 21 17:52:19 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:19 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:19 volumio-acer volumio[921]: info: No code
May 21 17:52:19 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:19 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:19 volumio-acer volumio[921]: info: ------------------------------ 36ms
May 21 17:52:19 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status
May 21 17:52:19 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status undefined
May 21 17:52:19 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status undefined
May 21 17:52:19 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status
May 21 17:52:19 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 21 17:52:26 volumio-acer volumio[921]: info: CoreCommandRouter::volumioGetState
May 21 17:52:31 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPlay
May 21 17:52:31 volumio-acer volumio[921]: info: CoreStateMachine::play index undefined
May 21 17:52:31 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 17:52:31 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:31 volumio-acer volumio[921]: info: CoreStateMachine::startPlaybackTimer
May 21 17:52:31 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:31 volumio-acer volumio[921]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22hNrwlzBeFN8%22%2C%22playlistId%22%3A%22RDCLAK5uy_k5n4srrEB1wgvIjPNTXS9G1ufE9WQxhnA%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Morgan%20Wallen%20-%20What%20I%20Want%20(feat.%20Tate%20McRae)%20(Lyric%20Video)%22%2C%22artist%22%3A%22Morgan%20Wallen%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FhNrwlzBeFN8%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBDuWnfFiEMty-YI0ej4lyDcRZDkw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22hNrwlzBeFN8%22%2C%22playlistId%22%3A%22RDCLAK5uy_k5n4srrEB1wgvIjPNTXS9G1ufE9WQxhnA%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D
May 21 17:52:32 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:32 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand stop
May 21 17:52:32 volumio-acer volumio[921]: info: sendMpdCommand stop took 1 milliseconds
May 21 17:52:32 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clear
May 21 17:52:32 volumio-acer volumio[921]: info:
May 21 17:52:32 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:32 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:32 volumio-acer volumio[921]: info: sendMpdCommand clear took 2 milliseconds
May 21 17:52:32 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand addid "https://rr3---sn-3tp8nu5g-3fbl.googlevideo.com/videoplayback?expire=1747871551&ei=3xIuaJOWI63e6dsPofuzuAM&ip=109.162.37.151&id=o-AO0Y7AgmzK10zIuaPOdl2tg6RbOwI_dy5EH38apfiVoK&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849951%2C&mh=eK&mm=31%2C29&mn=sn-3tp8nu5g-3fbl%2Csn-3tp8nu5g-3c2y&ms=au%2Crdu&mv=m&mvi=3&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=2317500&bui=AecWEAagnwMsCnEmXtG6x7rYxE8MfTBqSx2XbEFJDNS-zWrG6W7V5lYyv_sx9qgJtxgiL1oKyLsDAHIz&spc=wk1kZu6izmZY535BhZnDxPLSdDxCragBQ4blQbMXreSX5CwTDd8XZ_pAzsDHJbsgKOU&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=kZe8d6TsiQvip1dDZu5aSMEQ&rqh=1&gir=yes&clen=3225661&dur=183.041&lmt=1747502793833414&mt=1747849507&fvip=1&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532534&n=vjbd0dbW7eQg54B_OH-_w8_UYvg4EptdyGISD3xOUK&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRgIhANf_lDlOvx00--K7tc87GI2kAW-87Thp4MPusIRlxT9XAiEAgth6uOzIO42kPGMAPfL9tOMLiK0HH8weBz2fZN-XjDo%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube"
May 21 17:52:32 volumio-acer volumio[921]: error: updateQueue error: null
May 21 17:52:32 volumio-acer volumio[921]: info:
May 21 17:52:32 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:32 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:32 volumio-acer volumio[921]: info: ------------------------------ 2ms
May 21 17:52:32 volumio-acer volumio[921]: info: sendMpdCommand addid "https://rr3---sn-3tp8nu5g-3fbl.googlevideo.com/videoplayback?expire=1747871551&ei=3xIuaJOWI63e6dsPofuzuAM&ip=109.162.37.151&id=o-AO0Y7AgmzK10zIuaPOdl2tg6RbOwI_dy5EH38apfiVoK&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849951%2C&mh=eK&mm=31%2C29&mn=sn-3tp8nu5g-3fbl%2Csn-3tp8nu5g-3c2y&ms=au%2Crdu&mv=m&mvi=3&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=2317500&bui=AecWEAagnwMsCnEmXtG6x7rYxE8MfTBqSx2XbEFJDNS-zWrG6W7V5lYyv_sx9qgJtxgiL1oKyLsDAHIz&spc=wk1kZu6izmZY535BhZnDxPLSdDxCragBQ4blQbMXreSX5CwTDd8XZ_pAzsDHJbsgKOU&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=kZe8d6TsiQvip1dDZu5aSMEQ&rqh=1&gir=yes&clen=3225661&dur=183.041&lmt=1747502793833414&mt=1747849507&fvip=1&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532534&n=vjbd0dbW7eQg54B_OH-_w8_UYvg4EptdyGISD3xOUK&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRgIhANf_lDlOvx00--K7tc87GI2kAW-87Thp4MPusIRlxT9XAiEAgth6uOzIO42kPGMAPfL9tOMLiK0HH8weBz2fZN-XjDo%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube" took 1 milliseconds
May 21 17:52:32 volumio-acer volumio[921]: verbose: MPD COMMAND [object Object]
May 21 17:52:32 volumio-acer volumio[921]: info:
May 21 17:52:32 volumio-acer volumio[921]: ---------------------------- MPD announces system playlist update
May 21 17:52:32 volumio-acer volumio[921]: info: Ignoring MPD Status Update
May 21 17:52:32 volumio-acer volumio[921]: info: ------------------------------ 1ms
May 21 17:52:32 volumio-acer volumio[921]: info: CoreStateMachine::setConsumeUpdateService mpd
May 21 17:52:32 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand play
May 21 17:52:32 volumio-acer volumio[921]: info: ------------------------------ 1ms
May 21 17:52:32 volumio-acer volumio[921]: info: sendMpdCommand play took 0 milliseconds
May 21 17:52:32 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:32 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:32 volumio-acer volumio[921]: info:
May 21 17:52:32 volumio-acer volumio[921]: ---------------------------- MPD announces state update: player
May 21 17:52:32 volumio-acer volumio[921]: info: ControllerMpd::getState
May 21 17:52:32 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand status
May 21 17:52:32 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:32 volumio-acer volumio[921]: info: sendMpdCommand status took 10 milliseconds
May 21 17:52:32 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand clearerror
May 21 17:52:32 volumio-acer volumio[921]: info: sendMpdCommand status took 12 milliseconds
May 21 17:52:32 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:32 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:32 volumio-acer volumio[921]: verbose: ControllerMpd::parseState
May 21 17:52:32 volumio-acer volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 17:52:32 volumio-acer volumio[921]: info: sendMpdCommand clearerror took 12 milliseconds
May 21 17:52:32 volumio-acer volumio[921]: info: sendMpdCommand clearerror took 8 milliseconds
May 21 17:52:32 volumio-acer volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 21 17:52:32 volumio-acer volumio[921]: verbose: ControllerMpd::parseTrackInfo
May 21 17:52:32 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:32 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:32 volumio-acer volumio[921]: info: CoreStateMachine::getQueue
May 21 17:52:32 volumio-acer volumio[921]: info: CorePlayQueue::getQueue
May 21 17:52:32 volumio-acer volumio[921]: info: ControllerMpd::pushState
May 21 17:52:32 volumio-acer volumio[921]: info: CoreCommandRouter::servicePushState
May 21 17:52:32 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:32 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 17:52:32 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:32 volumio-acer volumio[921]: info: CorePlayQueue::getTrack 0
May 21 17:52:32 volumio-acer volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Morgan Wallen - What I Want (feat. Tate McRae) (Lyric Video)","artist":"Morgan Wallen","album":"YouTube","uri":"https://rr3---sn-3tp8nu5g-3fbl.googlevideo.com/videoplayback?expire=1747871551&ei=3xIuaJOWI63e6dsPofuzuAM&ip=109.162.37.151&id=o-AO0Y7AgmzK10zIuaPOdl2tg6RbOwI_dy5EH38apfiVoK&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747849951%2C&mh=eK&mm=31%2C29&mn=sn-3tp8nu5g-3fbl%2Csn-3tp8nu5g-3c2y&ms=au%2Crdu&mv=m&mvi=3&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=2317500&bui=AecWEAagnwMsCnEmXtG6x7rYxE8MfTBqSx2XbEFJDNS-zWrG6W7V5lYyv_sx9qgJtxgiL1oKyLsDAHIz&spc=wk1kZu6izmZY535BhZnDxPLSdDxCragBQ4blQbMXreSX5CwTDd8XZ_pAzsDHJbsgKOU&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=kZe8d6TsiQvip1dDZu5aSMEQ&rqh=1&gir=yes&clen=3225661&dur=183.041&lmt=1747502793833414&mt=1747849507&fvip=1&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=5532534&n=vjbd0dbW7eQg54B_OH-_w8_UYvg4EptdyGISD3xOUK&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRgIhANf_lDlOvx00--K7tc87GI2kAW-87Thp4MPusIRlxT9XAiEAgth6uOzIO42kPGMAPfL9tOMLiK0HH8weBz2fZN-XjDo%3D&pot=Mnh1Uhlq2PO2g3VuSXNZbjXe39Q5ebEY4IXBDEdHn_mIRTcAGOE_SNvWjeEEy-2RHBSr1q_e0rnsABtksF328NWWdMiDwSlvQmsT9H08vhwX4rwomAx0oZly1rFg_euOEUvDBhs99wjbYawKGGvFsDopRv-nAkLJIB4%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"}
May 21 17:52:32 volumio-acer volumio[921]: verbose: CURRENT POSITION 0
May 21 17:52:32 volumio-acer volumio[921]: info: CoreStateMachine::syncState stateService stop
May 21 17:52:32 volumio-acer volumio[921]: info: CoreStateMachine::syncState currentStatus stop
May 21 17:52:32 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:32 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:32 volumio-acer volumio[921]: info: No code
May 21 17:52:32 volumio-acer volumio[921]: info: CoreStateMachine::pushState
May 21 17:52:32 volumio-acer volumio[921]: info: CoreCommandRouter::volumioPushState
May 21 17:52:32 volumio-acer volumio[921]: info: ------------------------------ 48ms
May 21 17:52:32 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status
May 21 17:52:32 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status undefined
May 21 17:52:32 volumio-acer volumio[921]: info: PeppySpectrum ---peppyspectrum status undefined
May 21 17:52:32 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status
May 21 17:52:32 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 21 17:52:32 volumio-acer volumio[921]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 21 17:52:41 volumio-acer volumio[921]: info: CoreCommandRouter::getUIConfigOnPlugin
May 21 17:52:41 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
May 21 17:52:41 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
May 21 17:52:41 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs
May 21 17:52:41 volumio-acer volumio[921]: info: Received Get System Version
May 21 17:52:41 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 21 17:53:04 volumio-acer volumiologrotate[604]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory
May 21 17:53:04 volumio-acer volumiologrotate[604]: ls: cannot access 'ACER': No such file or directory
May 21 17:53:05 volumio-acer startx[925]: (EE) client bug: timer event3 debounce short: offset negative (-2ms)
May 21 17:53:17 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard
May 21 17:53:17 volumio-acer volumio[921]: info: CoreCommandRouter::Reload Ui
May 21 17:53:18 volumio-acer volumio[921]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
May 21 17:53:18 volumio-acer volumio[921]: info: CoreCommandRouter::volumioGetVisibleSources
May 21 17:53:18 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 21 17:53:18 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
May 21 17:53:18 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
May 21 17:53:18 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
May 21 17:53:18 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
May 21 17:53:18 volumio-acer volumio[921]: info: Received Get System Info
May 21 17:53:18 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 17:53:18 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 17:53:18 volumio-acer volumio[921]: info: Discovery: Getting this device information
May 21 17:53:18 volumio-acer volumio[921]: info: CoreCommandRouter::volumioGetState
May 21 17:53:18 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 17:53:18 volumio-acer volumio-remote-updater[620]: No test mode
May 21 17:53:18 volumio-acer volumio-remote-updater[620]: No alpha test mode
May 21 17:53:19 volumio-acer volumio[921]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
May 21 17:53:19 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 21 17:53:19 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 21 17:53:19 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 21 17:53:19 volumio-acer volumio[921]: info: CoreCommandRouter::getUIConfigOnPlugin
May 21 17:53:19 volumio-acer volumio[921]: info: Retrieving Cloud Streaming UI
May 21 17:53:19 volumio-acer volumio[921]: info: Getting Tidal Cloud Configuration
May 21 17:53:19 volumio-acer volumio[921]: info: CoreCommandRouter::getUIConfigOnPlugin
May 21 17:53:19 volumio-acer volumio[921]: info: Getting Qobuz Cloud Configuration
May 21 17:53:19 volumio-acer volumio[921]: info: Asking plugin for UI Config
May 21 17:53:19 volumio-acer volumio[921]: info: CoreCommandRouter::getUIConfigOnPlugin
May 21 17:53:19 volumio-acer volumio[921]: info: Getting Spotify Cloud Configuration
May 21 17:53:19 volumio-acer volumio[921]: info: Asking plugin for UI Config
May 21 17:53:19 volumio-acer volumio[921]: info: CoreCommandRouter::getUIConfigOnPlugin
May 21 17:53:19 volumio-acer volumio[921]: info: Saving Spotify Acccount
May 21 17:53:19 volumio-acer volumio[921]: info: Got Tidal Cloud Configuration
May 21 17:53:19 volumio-acer volumio[921]: info: Got it
May 21 17:53:19 volumio-acer volumio[921]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 21 17:53:19 volumio-acer volumio[921]: info: CoreCommandRouter::getUIConfigOnPlugin
May 21 17:53:19 volumio-acer volumio[921]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 21 17:53:20 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
May 21 17:53:20 volumio-acer volumio[921]: info: Loading i18n strings for locale en
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin peppymeterbasic has duplicated i18n key APPLY. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin peppymeterbasic has duplicated i18n key SAVE. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin peppymeterbasic has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin peppymeterbasic has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin peppyspectrum has duplicated i18n key LOCALSETTINGS. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin peppyspectrum has duplicated i18n key SCREENSIZE. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin peppyspectrum has duplicated i18n key SCREENSIZE_DOC. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin peppyspectrum has duplicated i18n key NBARCHANGE. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin peppyspectrum has duplicated i18n key DOWNLOAD. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: Plugin peppyspectrum has duplicated i18n key LIST_FAIL_UPDATE. It is ignored.
May 21 17:53:20 volumio-acer volumio[921]: info: [now-playing] Volumio language changed - pushing localization settings
May 21 17:53:20 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
May 21 17:53:20 volumio-acer volumio[921]: info: Setting timezone to Etc/Unknown
May 21 17:53:20 volumio-acer sudo[8706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
May 21 17:53:20 volumio-acer sudo[8706]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 17:53:20 volumio-acer sudo[8706]: pam_unix(sudo:session): session closed for user root
May 21 17:53:20 volumio-acer sudo[8709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Etc/Unknown /etc/localtime
May 21 17:53:20 volumio-acer sudo[8709]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 17:53:20 volumio-acer sudo[8709]: pam_unix(sudo:session): session closed for user root
May 21 17:53:20 volumio-acer sudo[8712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
May 21 17:53:20 volumio-acer sudo[8712]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 17:53:20 volumio-acer sudo[8712]: pam_unix(sudo:session): session closed for user root
May 21 17:53:20 volumio-acer volumio[921]: /bin/chmod: cannot operate on dangling symlink '/etc/localtime'
May 21 17:53:20 volumio-acer volumio[921]: error: Could not set timezone: Error: Command failed: /usr/bin/sudo /bin/chmod 777 /etc/localtime
May 21 17:53:20 volumio-acer volumio[921]: /bin/chmod: cannot operate on dangling symlink '/etc/localtime'
May 21 17:53:20 volumio-acer sudo[8715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Etc/Unknown
May 21 17:53:20 volumio-acer sudo[8715]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 17:53:20 volumio-acer dbus-daemon[623]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.24' (uid=0 pid=8716 comm="/usr/bin/timedatectl set-timezone Etc/Unknown ")
May 21 17:53:20 volumio-acer systemd[1]: Starting Time & Date Service...
May 21 17:53:20 volumio-acer systemd-timedated[8717]: /etc/localtime should be a symbolic link to a time zone data file in /usr/share/zoneinfo/.
May 21 17:53:20 volumio-acer dbus-daemon[623]: [system] Successfully activated service 'org.freedesktop.timedate1'
May 21 17:53:20 volumio-acer systemd[1]: Started Time & Date Service.
May 21 17:53:20 volumio-acer sudo[8715]: pam_unix(sudo:session): session closed for user root
May 21 17:53:20 volumio-acer volumio[921]: Failed to set time zone: Invalid time zone 'Etc/Unknown'
May 21 17:53:20 volumio-acer volumio[921]: info: Could not set timezone, retrying
May 21 17:53:20 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 21 17:53:20 volumio-acer volumio[921]: Updating browse sources language
May 21 17:53:20 volumio-acer volumio[921]: Cannot find translation for source YouTube2
May 21 17:53:20 volumio-acer volumio[921]: Cannot find translation for source YouTube Music
May 21 17:53:20 volumio-acer volumio[921]: Cannot find translation for source Radio Paradise
May 21 17:53:20 volumio-acer volumio[921]: Cannot find translation for source Volusonic
May 21 17:53:20 volumio-acer volumio[921]: Cannot find translation for source LastFM
May 21 17:53:20 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 21 17:53:20 volumio-acer volumio[921]: Cannot find translation for source YouTube2
May 21 17:53:20 volumio-acer volumio[921]: Cannot find translation for source YouTube Music
May 21 17:53:20 volumio-acer volumio[921]: Cannot find translation for source Radio Paradise
May 21 17:53:20 volumio-acer volumio[921]: Cannot find translation for source Volusonic
May 21 17:53:20 volumio-acer volumio[921]: Cannot find translation for source LastFM
May 21 17:53:20 volumio-acer volumio[921]: info: Fetching Streaming Services browse cache
May 21 17:53:21 volumio-acer volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 21 17:53:21 volumio-acer sudo[8719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Etc/Unknown
May 21 17:53:21 volumio-acer sudo[8719]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 17:53:21 volumio-acer sudo[8719]: pam_unix(sudo:session): session closed for user root
May 21 17:53:21 volumio-acer volumio[921]: Failed to set time zone: Invalid time zone 'Etc/Unknown'
May 21 17:53:21 volumio-acer volumio[921]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 21 17:53:21 volumio-acer volumio[921]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'Etc/Unknown'
May 21 17:53:21 volumio-acer volumio[921]: Failed to set time zone: Invalid time zone 'Etc/Unknown'
May 21 17:53:21 volumio-acer volumio[921]: at checkExecSyncError (child_process.js:790:11)
May 21 17:53:21 volumio-acer volumio[921]: at execSync (child_process.js:863:15)
May 21 17:53:21 volumio-acer volumio[921]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1575:9)
May 21 17:53:21 volumio-acer volumio[921]: at listOnTimeout (internal/timers.js:557:17)
May 21 17:53:21 volumio-acer volumio[921]: at processTimers (internal/timers.js:500:7) {
May 21 17:53:21 volumio-acer volumio[921]: status: 1,
May 21 17:53:21 volumio-acer volumio[921]: signal: null,
May 21 17:53:21 volumio-acer volumio[921]: output: [
May 21 17:53:21 volumio-acer volumio[921]: null,
May 21 17:53:21 volumio-acer volumio[921]: '',
May 21 17:53:21 volumio-acer volumio[921]: "Failed to set time zone: Invalid time zone 'Etc/Unknown'\n"
May 21 17:53:21 volumio-acer volumio[921]: ],
May 21 17:53:21 volumio-acer volumio[921]: pid: 8718,
May 21 17:53:21 volumio-acer volumio[921]: stdout: '',
May 21 17:53:21 volumio-acer volumio[921]: stderr: "Failed to set time zone: Invalid time zone 'Etc/Unknown'\n"
May 21 17:53:21 volumio-acer volumio[921]: }
May 21 17:53:21 volumio-acer volumio[921]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 21 17:53:21 volumio-acer sudo[8730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-21 17:52
May 21 17:53:21 volumio-acer sudo[8730]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
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="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"