Feb 09 13:29:05 volumio sudo[9554]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 09 13:29:05 volumio sudo[9554]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 09 13:29:05 volumio sudo[9554]: pam_unix(sudo:session): session closed for user root
Feb 09 13:29:05 volumio sudo[9556]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 09 13:29:05 volumio sudo[9556]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 09 13:29:05 volumio sudo[9556]: pam_unix(sudo:session): session closed for user root
Feb 09 13:29:05 volumio volumio[1134]: verbose: New Socket.io Connection to 192.168.1.21 from 192.168.1.12 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Feb 09 13:29:06 volumio sudo[9560]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 09 13:29:06 volumio sudo[9560]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 09 13:29:06 volumio sudo[9562]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 09 13:29:06 volumio sudo[9560]: pam_unix(sudo:session): session closed for user root
Feb 09 13:29:06 volumio sudo[9562]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 09 13:29:06 volumio sudo[9562]: pam_unix(sudo:session): session closed for user root
Feb 09 13:29:06 volumio volumio[1134]: verbose: New Socket.io Connection to 192.168.1.21 from 192.168.1.12 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Feb 09 13:29:06 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState
Feb 09 13:29:06 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:06 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 09 13:29:06 volumio volumio[1134]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 09 13:29:06 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 09 13:29:06 volumio volumio[1134]: info: Listing playlists
Feb 09 13:29:06 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Feb 09 13:29:06 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 09 13:29:06 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 09 13:29:06 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 09 13:29:08 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 09 13:29:08 volumio volumio[1134]: info: Received Get System Info
Feb 09 13:29:08 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 09 13:29:08 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 09 13:29:08 volumio volumio[1134]: info: Discovery: Getting this device information
Feb 09 13:29:08 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState
Feb 09 13:29:08 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:08 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 09 13:29:09 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 09 13:29:09 volumio volumio[1134]: info: Received Get System Info
Feb 09 13:29:09 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 09 13:29:09 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 09 13:29:09 volumio volumio[1134]: info: Discovery: Getting this device information
Feb 09 13:29:09 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState
Feb 09 13:29:09 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:09 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 09 13:29:11 volumio volumio[1134]: info: CoreCommandRouter::volumioPlay
Feb 09 13:29:11 volumio volumio[1134]: info: CoreStateMachine::play index undefined
Feb 09 13:29:11 volumio volumio[1134]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 09 13:29:11 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:11 volumio volumio[1134]: info: CoreStateMachine::startPlaybackTimer
Feb 09 13:29:11 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:11 volumio volumio[1134]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22Everybody%20Wants%20To%20Rule%20The%20World%20(Official%20Music%20Video)%22%2C%22artist%22%3A%22Tears%20For%20Fears%22%2C%22album%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FaGCdLKXNF3w%2Fhq720.jpg%3Fsqp%3D-oaymwEXCNUGEOADIAQqCwjVARCqCBh4INgESFo%26rs%3DAMzJL3k7LPna7qgKkzVmfQtuzkfrAIPqUA%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22aGCdLKXNF3w%22%2C%22playlistId%22%3A%22RDCLAK5uy_nKfNEHo6Yu1lao4pamzirHgatT0liBhzY%22%2C%22params%22%3A%22OAHyAQQIARgD%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%2256B44F6D10557CC6%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_OMV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_nKfNEHo6Yu1lao4pamzirHgatT0liBhzY%22%2C%22params%22%3A%22OAHyAQQIARgD%22%2C%22videoId%22%3A%22Lrle0x_DHBM%22%7D%7D%7D%7D
Feb 09 13:29:11 volumio volumio[1134]: info: [ytmusic] Obtained PO token for video #aGCdLKXNF3w: MlWmAdTUqi3UKaY_iD0okroIlQWklDAiJNh4HyVU11n-CW0_-eF8v7AF0z0GAQgytXVccQHzCRDAXhhk7nW5A4gPLbapNPtRE05QgRV2A0nJRwQ_lZnU
Feb 09 13:29:11 volumio volumio[1134]: info: [ytmusic] (Everybody Wants To Rule The World (Official Music Video)) validating stream URL "https://rr3---sn-ab5l6nk6.googlevideo.com/videoplayback?expire=1770683351&ei=dyeKacmGF620kucP4LXusQI&ip=74.70.83.118&id=o-ADuNmc_wPfBxgOEdJhQ82krDCSlKwRi8Df3HeQESyOHj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1770661751%2C&mh=Wc&mm=31%2C29&mn=sn-ab5l6nk6%2Csn-ab5sznzk&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=3641250&bui=AW-iu_qpZeWSNdpsEtJ3A928eAjVJzaUwP99X-2uFNZmZMJAPpzSPsMrghe8NAJQ468XOSKbeEpjvRgj&spc=q5xjPAwpYr-2jE22K0i9xXeT2viBI5TDVUKsvLjPkZOjDZFphQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=mO5OYEQOPqHKKhKKoMKteL8S&rqh=1&gir=yes&clen=4814643&dur=290.741&lmt=1741840271438086&mt=1770661329&fvip=3&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_REMIX&sefc=1&txp=4532534&n=hRa60LbVCgfMeQ&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=APaTxxMwRAIgUgsFqMQ0tINukn4UMxEXQwW2f5prctAU-HSPpfOeuKMCIACef8DvzdgpM5pRxmEXSTSBZVUJTzpSjcucJWETZbPl&sig=AJEij0EwRAIgNaf8m9dQHNxGsM_73geYlvBvrx8htd4Akt3Gi7Ag99ACICLsuofGraHyDRp1wx2PiskadWoJAGTUn1qSk0PGA4Ao&pot=MlWmAdTUqi3UKaY_iD0okroIlQWklDAiJNh4HyVU11n-CW0_-eF8v7AF0z0GAQgytXVccQHzCRDAXhhk7nW5A4gPLbapNPtRE05QgRV2A0nJRwQ_lZnU&cver=1.20250219.01.00"...
Feb 09 13:29:11 volumio volumio[1134]: info: [ytmusic] (Everybody Wants To Rule The World (Official Music Video)) stream validated in 0.097s.
Feb 09 13:29:11 volumio volumio[1134]: info: [ytmusic] (AutoplayManager) Enabled
Feb 09 13:29:11 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand stop
Feb 09 13:29:11 volumio volumio[1134]: info: sendMpdCommand stop took 2 milliseconds
Feb 09 13:29:11 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand clear
Feb 09 13:29:11 volumio volumio[1134]: info:
Feb 09 13:29:11 volumio volumio[1134]: ---------------------------- MPD announces system playlist update
Feb 09 13:29:11 volumio volumio[1134]: info: Ignoring MPD Status Update
Feb 09 13:29:11 volumio volumio[1134]: info: sendMpdCommand clear took 3 milliseconds
Feb 09 13:29:11 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand addid "https://rr3---sn-ab5l6nk6.googlevideo.com/videoplayback?expire=1770683351&ei=dyeKacmGF620kucP4LXusQI&ip=74.70.83.118&id=o-ADuNmc_wPfBxgOEdJhQ82krDCSlKwRi8Df3HeQESyOHj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1770661751%2C&mh=Wc&mm=31%2C29&mn=sn-ab5l6nk6%2Csn-ab5sznzk&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=3641250&bui=AW-iu_qpZeWSNdpsEtJ3A928eAjVJzaUwP99X-2uFNZmZMJAPpzSPsMrghe8NAJQ468XOSKbeEpjvRgj&spc=q5xjPAwpYr-2jE22K0i9xXeT2viBI5TDVUKsvLjPkZOjDZFphQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=mO5OYEQOPqHKKhKKoMKteL8S&rqh=1&gir=yes&clen=4814643&dur=290.741&lmt=1741840271438086&mt=1770661329&fvip=3&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_REMIX&sefc=1&txp=4532534&n=hRa60LbVCgfMeQ&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=APaTxxMwRAIgUgsFqMQ0tINukn4UMxEXQwW2f5prctAU-HSPpfOeuKMCIACef8DvzdgpM5pRxmEXSTSBZVUJTzpSjcucJWETZbPl&sig=AJEij0EwRAIgNaf8m9dQHNxGsM_73geYlvBvrx8htd4Akt3Gi7Ag99ACICLsuofGraHyDRp1wx2PiskadWoJAGTUn1qSk0PGA4Ao&pot=MlWmAdTUqi3UKaY_iD0okroIlQWklDAiJNh4HyVU11n-CW0_-eF8v7AF0z0GAQgytXVccQHzCRDAXhhk7nW5A4gPLbapNPtRE05QgRV2A0nJRwQ_lZnU&cver=1.20250219.01.00&t.YouTube"
Feb 09 13:29:11 volumio volumio[1134]: info:
Feb 09 13:29:11 volumio volumio[1134]: ---------------------------- MPD announces system playlist update
Feb 09 13:29:11 volumio volumio[1134]: info: Ignoring MPD Status Update
Feb 09 13:29:11 volumio volumio[1134]: info:
Feb 09 13:29:11 volumio volumio[1134]: ---------------------------- MPD announces system playlist update
Feb 09 13:29:11 volumio volumio[1134]: info: Ignoring MPD Status Update
Feb 09 13:29:11 volumio volumio[1134]: error: updateQueue error: null
Feb 09 13:29:11 volumio volumio[1134]: info: ------------------------------ 7ms
Feb 09 13:29:11 volumio volumio[1134]: info: sendMpdCommand addid "https://rr3---sn-ab5l6nk6.googlevideo.com/videoplayback?expire=1770683351&ei=dyeKacmGF620kucP4LXusQI&ip=74.70.83.118&id=o-ADuNmc_wPfBxgOEdJhQ82krDCSlKwRi8Df3HeQESyOHj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1770661751%2C&mh=Wc&mm=31%2C29&mn=sn-ab5l6nk6%2Csn-ab5sznzk&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=3641250&bui=AW-iu_qpZeWSNdpsEtJ3A928eAjVJzaUwP99X-2uFNZmZMJAPpzSPsMrghe8NAJQ468XOSKbeEpjvRgj&spc=q5xjPAwpYr-2jE22K0i9xXeT2viBI5TDVUKsvLjPkZOjDZFphQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=mO5OYEQOPqHKKhKKoMKteL8S&rqh=1&gir=yes&clen=4814643&dur=290.741&lmt=1741840271438086&mt=1770661329&fvip=3&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_REMIX&sefc=1&txp=4532534&n=hRa60LbVCgfMeQ&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=APaTxxMwRAIgUgsFqMQ0tINukn4UMxEXQwW2f5prctAU-HSPpfOeuKMCIACef8DvzdgpM5pRxmEXSTSBZVUJTzpSjcucJWETZbPl&sig=AJEij0EwRAIgNaf8m9dQHNxGsM_73geYlvBvrx8htd4Akt3Gi7Ag99ACICLsuofGraHyDRp1wx2PiskadWoJAGTUn1qSk0PGA4Ao&pot=MlWmAdTUqi3UKaY_iD0okroIlQWklDAiJNh4HyVU11n-CW0_-eF8v7AF0z0GAQgytXVccQHzCRDAXhhk7nW5A4gPLbapNPtRE05QgRV2A0nJRwQ_lZnU&cver=1.20250219.01.00&t.YouTube" took 4 milliseconds
Feb 09 13:29:11 volumio volumio[1134]: verbose: MPD COMMAND [object Object]
Feb 09 13:29:11 volumio volumio[1134]: verbose: MPD COMMAND [object Object]
Feb 09 13:29:11 volumio volumio[1134]: info:
Feb 09 13:29:11 volumio volumio[1134]: ---------------------------- MPD announces system playlist update
Feb 09 13:29:11 volumio volumio[1134]: info: Ignoring MPD Status Update
Feb 09 13:29:11 volumio volumio[1134]: info:
Feb 09 13:29:11 volumio volumio[1134]: ---------------------------- MPD announces system playlist update
Feb 09 13:29:11 volumio volumio[1134]: info: Ignoring MPD Status Update
Feb 09 13:29:11 volumio volumio[1134]: info: ------------------------------ 8ms
Feb 09 13:29:11 volumio volumio[1134]: info: ------------------------------ 8ms
Feb 09 13:29:11 volumio volumio[1134]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 09 13:29:11 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand play
Feb 09 13:29:11 volumio volumio[1134]: info:
Feb 09 13:29:11 volumio volumio[1134]: ---------------------------- MPD announces system playlist update
Feb 09 13:29:11 volumio volumio[1134]: info: Ignoring MPD Status Update
Feb 09 13:29:11 volumio volumio[1134]: info:
Feb 09 13:29:11 volumio volumio[1134]: ---------------------------- MPD announces system playlist update
Feb 09 13:29:11 volumio volumio[1134]: info: Ignoring MPD Status Update
Feb 09 13:29:11 volumio volumio[1134]: info: ------------------------------ 10ms
Feb 09 13:29:11 volumio volumio[1134]: info: ------------------------------ 9ms
Feb 09 13:29:11 volumio volumio[1134]: info: sendMpdCommand play took 7 milliseconds
Feb 09 13:29:11 volumio volumio[1134]: info: ------------------------------ 5ms
Feb 09 13:29:11 volumio volumio[1134]: info: ------------------------------ 3ms
Feb 09 13:29:11 volumio volumio[1134]: info:
Feb 09 13:29:11 volumio volumio[1134]: ---------------------------- MPD announces system playlist update
Feb 09 13:29:11 volumio volumio[1134]: info: Ignoring MPD Status Update
Feb 09 13:29:11 volumio volumio[1134]: info:
Feb 09 13:29:11 volumio volumio[1134]: ---------------------------- MPD announces system playlist update
Feb 09 13:29:11 volumio volumio[1134]: info: Ignoring MPD Status Update
Feb 09 13:29:11 volumio volumio[1134]: info: ------------------------------ 4ms
Feb 09 13:29:11 volumio volumio[1134]: info: ------------------------------ 3ms
Feb 09 13:29:12 volumio volumio[1134]: info:
Feb 09 13:29:12 volumio volumio[1134]: ---------------------------- MPD announces state update: player
Feb 09 13:29:12 volumio volumio[1134]: info: ControllerMpd::getState
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 13:29:12 volumio volumio[1134]: info:
Feb 09 13:29:12 volumio volumio[1134]: ---------------------------- MPD announces state update: player
Feb 09 13:29:12 volumio volumio[1134]: info: ControllerMpd::getState
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 13:29:12 volumio volumio[1134]: info:
Feb 09 13:29:12 volumio volumio[1134]: ---------------------------- MPD announces state update: player
Feb 09 13:29:12 volumio volumio[1134]: info: ControllerMpd::getState
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 13:29:12 volumio volumio[1134]: info:
Feb 09 13:29:12 volumio volumio[1134]: ---------------------------- MPD announces state update: player
Feb 09 13:29:12 volumio volumio[1134]: info: sendMpdCommand status took 19 milliseconds
Feb 09 13:29:12 volumio volumio[1134]: info: sendMpdCommand status took 18 milliseconds
Feb 09 13:29:12 volumio volumio[1134]: info: sendMpdCommand status took 18 milliseconds
Feb 09 13:29:12 volumio volumio[1134]: info: ControllerMpd::getState
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::parseState
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::parseState
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::parseState
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 09 13:29:12 volumio volumio[1134]: info:
Feb 09 13:29:12 volumio volumio[1134]: ---------------------------- MPD announces state update: player
Feb 09 13:29:12 volumio volumio[1134]: info: ControllerMpd::getState
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 13:29:12 volumio volumio[1134]: info: sendMpdCommand status took 4 milliseconds
Feb 09 13:29:12 volumio volumio[1134]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 09 13:29:12 volumio volumio[1134]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 09 13:29:12 volumio volumio[1134]: info: sendMpdCommand playlistinfo took 4 milliseconds
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::parseState
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::parseTrackInfo
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::parseTrackInfo
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::parseTrackInfo
Feb 09 13:29:12 volumio volumio[1134]: info: ControllerMpd::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::servicePushState
Feb 09 13:29:12 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:12 volumio volumio[1134]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":291,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Everybody Wants To Rule The World (Official Music Video)","artist":"Tears For Fears","album":null,"uri":"https://rr3---sn-ab5l6nk6.googlevideo.com/videoplayback?expire=1770683351&ei=dyeKacmGF620kucP4LXusQI&ip=74.70.83.118&id=o-ADuNmc_wPfBxgOEdJhQ82krDCSlKwRi8Df3HeQESyOHj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1770661751%2C&mh=Wc&mm=31%2C29&mn=sn-ab5l6nk6%2Csn-ab5sznzk&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=3641250&bui=AW-iu_qpZeWSNdpsEtJ3A928eAjVJzaUwP99X-2uFNZmZMJAPpzSPsMrghe8NAJQ468XOSKbeEpjvRgj&spc=q5xjPAwpYr-2jE22K0i9xXeT2viBI5TDVUKsvLjPkZOjDZFphQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=mO5OYEQOPqHKKhKKoMKteL8S&rqh=1&gir=yes&clen=4814643&dur=290.741&lmt=1741840271438086&mt=1770661329&fvip=3&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_REMIX&sefc=1&txp=4532534&n=hRa60LbVCgfMeQ&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=APaTxxMwRAIgUgsFqMQ0tINukn4UMxEXQwW2f5prctAU-HSPpfOeuKMCIACef8DvzdgpM5pRxmEXSTSBZVUJTzpSjcucJWETZbPl&sig=AJEij0EwRAIgNaf8m9dQHNxGsM_73geYlvBvrx8htd4Akt3Gi7Ag99ACICLsuofGraHyDRp1wx2PiskadWoJAGTUn1qSk0PGA4Ao&pot=MlWmAdTUqi3UKaY_iD0okroIlQWklDAiJNh4HyVU11n-CW0_-eF8v7AF0z0GAQgytXVccQHzCRDAXhhk7nW5A4gPLbapNPtRE05QgRV2A0nJRwQ_lZnU&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Feb 09 13:29:12 volumio volumio[1134]: verbose: CURRENT POSITION 0
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::syncState stateService play
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::syncState currentStatus stop
Feb 09 13:29:12 volumio volumio[1134]: info: ControllerMpd::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::servicePushState
Feb 09 13:29:12 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:12 volumio volumio[1134]: verbose: STATE SERVICE {"status":"play","position":0,"seek":343,"duration":291,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Everybody Wants To Rule The World (Official Music Video)","artist":"Tears For Fears","album":null,"uri":"https://rr3---sn-ab5l6nk6.googlevideo.com/videoplayback?expire=1770683351&ei=dyeKacmGF620kucP4LXusQI&ip=74.70.83.118&id=o-ADuNmc_wPfBxgOEdJhQ82krDCSlKwRi8Df3HeQESyOHj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1770661751%2C&mh=Wc&mm=31%2C29&mn=sn-ab5l6nk6%2Csn-ab5sznzk&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=3641250&bui=AW-iu_qpZeWSNdpsEtJ3A928eAjVJzaUwP99X-2uFNZmZMJAPpzSPsMrghe8NAJQ468XOSKbeEpjvRgj&spc=q5xjPAwpYr-2jE22K0i9xXeT2viBI5TDVUKsvLjPkZOjDZFphQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=mO5OYEQOPqHKKhKKoMKteL8S&rqh=1&gir=yes&clen=4814643&dur=290.741&lmt=1741840271438086&mt=1770661329&fvip=3&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_REMIX&sefc=1&txp=4532534&n=hRa60LbVCgfMeQ&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=APaTxxMwRAIgUgsFqMQ0tINukn4UMxEXQwW2f5prctAU-HSPpfOeuKMCIACef8DvzdgpM5pRxmEXSTSBZVUJTzpSjcucJWETZbPl&sig=AJEij0EwRAIgNaf8m9dQHNxGsM_73geYlvBvrx8htd4Akt3Gi7Ag99ACICLsuofGraHyDRp1wx2PiskadWoJAGTUn1qSk0PGA4Ao&pot=MlWmAdTUqi3UKaY_iD0okroIlQWklDAiJNh4HyVU11n-CW0_-eF8v7AF0z0GAQgytXVccQHzCRDAXhhk7nW5A4gPLbapNPtRE05QgRV2A0nJRwQ_lZnU&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Feb 09 13:29:12 volumio volumio[1134]: verbose: CURRENT POSITION 0
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::syncState stateService play
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::syncState currentStatus play
Feb 09 13:29:12 volumio volumio[1134]: info: Received an update from plugin. extracting info from payload
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState
Feb 09 13:29:12 volumio volumio[1134]: info: [ytmusic] (AutoplayManager) Added mpdStateListener
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState
Feb 09 13:29:12 volumio volumio[1134]: info: ControllerMpd::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::servicePushState
Feb 09 13:29:12 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:12 volumio volumio[1134]: verbose: STATE SERVICE {"status":"play","position":0,"seek":996,"duration":291,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Everybody Wants To Rule The World (Official Music Video)","artist":"Tears For Fears","album":null,"uri":"https://rr3---sn-ab5l6nk6.googlevideo.com/videoplayback?expire=1770683351&ei=dyeKacmGF620kucP4LXusQI&ip=74.70.83.118&id=o-ADuNmc_wPfBxgOEdJhQ82krDCSlKwRi8Df3HeQESyOHj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1770661751%2C&mh=Wc&mm=31%2C29&mn=sn-ab5l6nk6%2Csn-ab5sznzk&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=3641250&bui=AW-iu_qpZeWSNdpsEtJ3A928eAjVJzaUwP99X-2uFNZmZMJAPpzSPsMrghe8NAJQ468XOSKbeEpjvRgj&spc=q5xjPAwpYr-2jE22K0i9xXeT2viBI5TDVUKsvLjPkZOjDZFphQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=mO5OYEQOPqHKKhKKoMKteL8S&rqh=1&gir=yes&clen=4814643&dur=290.741&lmt=1741840271438086&mt=1770661329&fvip=3&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_REMIX&sefc=1&txp=4532534&n=hRa60LbVCgfMeQ&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=APaTxxMwRAIgUgsFqMQ0tINukn4UMxEXQwW2f5prctAU-HSPpfOeuKMCIACef8DvzdgpM5pRxmEXSTSBZVUJTzpSjcucJWETZbPl&sig=AJEij0EwRAIgNaf8m9dQHNxGsM_73geYlvBvrx8htd4Akt3Gi7Ag99ACICLsuofGraHyDRp1wx2PiskadWoJAGTUn1qSk0PGA4Ao&pot=MlWmAdTUqi3UKaY_iD0okroIlQWklDAiJNh4HyVU11n-CW0_-eF8v7AF0z0GAQgytXVccQHzCRDAXhhk7nW5A4gPLbapNPtRE05QgRV2A0nJRwQ_lZnU&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Feb 09 13:29:12 volumio volumio[1134]: verbose: CURRENT POSITION 0
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::syncState stateService play
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::syncState currentStatus play
Feb 09 13:29:12 volumio volumio[1134]: info: Received an update from plugin. extracting info from payload
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState
Feb 09 13:29:12 volumio volumio[1134]: info: ------------------------------ 42ms
Feb 09 13:29:12 volumio volumio[1134]: info: ------------------------------ 47ms
Feb 09 13:29:12 volumio volumio[1134]: info: ------------------------------ 47ms
Feb 09 13:29:12 volumio volumio[1134]: info:
Feb 09 13:29:12 volumio volumio[1134]: ---------------------------- MPD announces state update: player
Feb 09 13:29:12 volumio volumio[1134]: info: ControllerMpd::getState
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 13:29:12 volumio volumio[1134]: info: sendMpdCommand status took 29 milliseconds
Feb 09 13:29:12 volumio volumio[1134]: info: sendMpdCommand playlistinfo took 27 milliseconds
Feb 09 13:29:12 volumio volumio[1134]: info: sendMpdCommand status took 2 milliseconds
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::parseState
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::parseTrackInfo
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::parseState
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 09 13:29:12 volumio volumio[1134]: info: ControllerMpd::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::servicePushState
Feb 09 13:29:12 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:12 volumio volumio[1134]: verbose: STATE SERVICE {"status":"play","position":0,"seek":996,"duration":291,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Everybody Wants To Rule The World (Official Music Video)","artist":"Tears For Fears","album":null,"uri":"https://rr3---sn-ab5l6nk6.googlevideo.com/videoplayback?expire=1770683351&ei=dyeKacmGF620kucP4LXusQI&ip=74.70.83.118&id=o-ADuNmc_wPfBxgOEdJhQ82krDCSlKwRi8Df3HeQESyOHj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1770661751%2C&mh=Wc&mm=31%2C29&mn=sn-ab5l6nk6%2Csn-ab5sznzk&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=3641250&bui=AW-iu_qpZeWSNdpsEtJ3A928eAjVJzaUwP99X-2uFNZmZMJAPpzSPsMrghe8NAJQ468XOSKbeEpjvRgj&spc=q5xjPAwpYr-2jE22K0i9xXeT2viBI5TDVUKsvLjPkZOjDZFphQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=mO5OYEQOPqHKKhKKoMKteL8S&rqh=1&gir=yes&clen=4814643&dur=290.741&lmt=1741840271438086&mt=1770661329&fvip=3&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_REMIX&sefc=1&txp=4532534&n=hRa60LbVCgfMeQ&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=APaTxxMwRAIgUgsFqMQ0tINukn4UMxEXQwW2f5prctAU-HSPpfOeuKMCIACef8DvzdgpM5pRxmEXSTSBZVUJTzpSjcucJWETZbPl&sig=AJEij0EwRAIgNaf8m9dQHNxGsM_73geYlvBvrx8htd4Akt3Gi7Ag99ACICLsuofGraHyDRp1wx2PiskadWoJAGTUn1qSk0PGA4Ao&pot=MlWmAdTUqi3UKaY_iD0okroIlQWklDAiJNh4HyVU11n-CW0_-eF8v7AF0z0GAQgytXVccQHzCRDAXhhk7nW5A4gPLbapNPtRE05QgRV2A0nJRwQ_lZnU&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Feb 09 13:29:12 volumio volumio[1134]: verbose: CURRENT POSITION 0
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::syncState stateService play
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::syncState currentStatus play
Feb 09 13:29:12 volumio volumio[1134]: info: Received an update from plugin. extracting info from payload
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState
Feb 09 13:29:12 volumio volumio[1134]: info: ------------------------------ 47ms
Feb 09 13:29:12 volumio volumio[1134]: info: sendMpdCommand playlistinfo took 19 milliseconds
Feb 09 13:29:12 volumio volumio[1134]: info: sendMpdCommand playlistinfo took 22 milliseconds
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::parseTrackInfo
Feb 09 13:29:12 volumio volumio[1134]: verbose: ControllerMpd::parseTrackInfo
Feb 09 13:29:12 volumio volumio[1134]: info: ControllerMpd::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::servicePushState
Feb 09 13:29:12 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:12 volumio volumio[1134]: verbose: STATE SERVICE {"status":"play","position":0,"seek":996,"duration":291,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Everybody Wants To Rule The World (Official Music Video)","artist":"Tears For Fears","album":null,"uri":"https://rr3---sn-ab5l6nk6.googlevideo.com/videoplayback?expire=1770683351&ei=dyeKacmGF620kucP4LXusQI&ip=74.70.83.118&id=o-ADuNmc_wPfBxgOEdJhQ82krDCSlKwRi8Df3HeQESyOHj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1770661751%2C&mh=Wc&mm=31%2C29&mn=sn-ab5l6nk6%2Csn-ab5sznzk&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=3641250&bui=AW-iu_qpZeWSNdpsEtJ3A928eAjVJzaUwP99X-2uFNZmZMJAPpzSPsMrghe8NAJQ468XOSKbeEpjvRgj&spc=q5xjPAwpYr-2jE22K0i9xXeT2viBI5TDVUKsvLjPkZOjDZFphQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=mO5OYEQOPqHKKhKKoMKteL8S&rqh=1&gir=yes&clen=4814643&dur=290.741&lmt=1741840271438086&mt=1770661329&fvip=3&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_REMIX&sefc=1&txp=4532534&n=hRa60LbVCgfMeQ&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=APaTxxMwRAIgUgsFqMQ0tINukn4UMxEXQwW2f5prctAU-HSPpfOeuKMCIACef8DvzdgpM5pRxmEXSTSBZVUJTzpSjcucJWETZbPl&sig=AJEij0EwRAIgNaf8m9dQHNxGsM_73geYlvBvrx8htd4Akt3Gi7Ag99ACICLsuofGraHyDRp1wx2PiskadWoJAGTUn1qSk0PGA4Ao&pot=MlWmAdTUqi3UKaY_iD0okroIlQWklDAiJNh4HyVU11n-CW0_-eF8v7AF0z0GAQgytXVccQHzCRDAXhhk7nW5A4gPLbapNPtRE05QgRV2A0nJRwQ_lZnU&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Feb 09 13:29:12 volumio volumio[1134]: verbose: CURRENT POSITION 0
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::syncState stateService play
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::syncState currentStatus play
Feb 09 13:29:12 volumio volumio[1134]: info: Received an update from plugin. extracting info from payload
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState
Feb 09 13:29:12 volumio volumio[1134]: info: ControllerMpd::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::servicePushState
Feb 09 13:29:12 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:12 volumio volumio[1134]: verbose: STATE SERVICE {"status":"play","position":0,"seek":996,"duration":291,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Everybody Wants To Rule The World (Official Music Video)","artist":"Tears For Fears","album":null,"uri":"https://rr3---sn-ab5l6nk6.googlevideo.com/videoplayback?expire=1770683351&ei=dyeKacmGF620kucP4LXusQI&ip=74.70.83.118&id=o-ADuNmc_wPfBxgOEdJhQ82krDCSlKwRi8Df3HeQESyOHj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1770661751%2C&mh=Wc&mm=31%2C29&mn=sn-ab5l6nk6%2Csn-ab5sznzk&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=3641250&bui=AW-iu_qpZeWSNdpsEtJ3A928eAjVJzaUwP99X-2uFNZmZMJAPpzSPsMrghe8NAJQ468XOSKbeEpjvRgj&spc=q5xjPAwpYr-2jE22K0i9xXeT2viBI5TDVUKsvLjPkZOjDZFphQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=mO5OYEQOPqHKKhKKoMKteL8S&rqh=1&gir=yes&clen=4814643&dur=290.741&lmt=1741840271438086&mt=1770661329&fvip=3&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_REMIX&sefc=1&txp=4532534&n=hRa60LbVCgfMeQ&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=APaTxxMwRAIgUgsFqMQ0tINukn4UMxEXQwW2f5prctAU-HSPpfOeuKMCIACef8DvzdgpM5pRxmEXSTSBZVUJTzpSjcucJWETZbPl&sig=AJEij0EwRAIgNaf8m9dQHNxGsM_73geYlvBvrx8htd4Akt3Gi7Ag99ACICLsuofGraHyDRp1wx2PiskadWoJAGTUn1qSk0PGA4Ao&pot=MlWmAdTUqi3UKaY_iD0okroIlQWklDAiJNh4HyVU11n-CW0_-eF8v7AF0z0GAQgytXVccQHzCRDAXhhk7nW5A4gPLbapNPtRE05QgRV2A0nJRwQ_lZnU&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Feb 09 13:29:12 volumio volumio[1134]: verbose: CURRENT POSITION 0
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::syncState stateService play
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::syncState currentStatus play
Feb 09 13:29:12 volumio volumio[1134]: info: Received an update from plugin. extracting info from payload
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreStateMachine::pushState
Feb 09 13:29:12 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState
Feb 09 13:29:12 volumio volumio[1134]: info: ------------------------------ 69ms
Feb 09 13:29:12 volumio volumio[1134]: info: ------------------------------ 42ms
Feb 09 13:29:21 volumio volumio[1134]: info: CoreCommandRouter::volumioPause
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::pause
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::stPlaybackTimer
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::servicePause
Feb 09 13:29:21 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:21 volumio volumio[1134]: info: CoreCommandRouter::servicePause
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 09 13:29:21 volumio volumio[1134]: info: ControllerMpd::pause
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand pause
Feb 09 13:29:21 volumio volumio[1134]: info: ControllerMpd::getState
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 13:29:21 volumio volumio[1134]: info:
Feb 09 13:29:21 volumio volumio[1134]: ---------------------------- MPD announces state update: player
Feb 09 13:29:21 volumio volumio[1134]: info: sendMpdCommand pause took 2 milliseconds
Feb 09 13:29:21 volumio volumio[1134]: info: ControllerMpd::getState
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 13:29:21 volumio volumio[1134]: info:
Feb 09 13:29:21 volumio volumio[1134]: ---------------------------- MPD announces state update: player
Feb 09 13:29:21 volumio volumio[1134]: info: ControllerMpd::getState
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 13:29:21 volumio volumio[1134]: info:
Feb 09 13:29:21 volumio volumio[1134]: ---------------------------- MPD announces state update: player
Feb 09 13:29:21 volumio volumio[1134]: info: ControllerMpd::getState
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 13:29:21 volumio volumio[1134]: info: sendMpdCommand status took 4 milliseconds
Feb 09 13:29:21 volumio volumio[1134]: info: sendMpdCommand status took 4 milliseconds
Feb 09 13:29:21 volumio volumio[1134]: info: sendMpdCommand status took 3 milliseconds
Feb 09 13:29:21 volumio volumio[1134]: info: sendMpdCommand status took 2 milliseconds
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::parseState
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::parseState
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::parseState
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::parseState
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 09 13:29:21 volumio volumio[1134]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 09 13:29:21 volumio volumio[1134]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 09 13:29:21 volumio volumio[1134]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 09 13:29:21 volumio volumio[1134]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::parseTrackInfo
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::parseTrackInfo
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::parseTrackInfo
Feb 09 13:29:21 volumio volumio[1134]: verbose: ControllerMpd::parseTrackInfo
Feb 09 13:29:21 volumio volumio[1134]: info: ControllerMpd::pushState
Feb 09 13:29:21 volumio volumio[1134]: info: CoreCommandRouter::servicePushState
Feb 09 13:29:21 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:21 volumio volumio[1134]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":9738,"duration":291,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Everybody Wants To Rule The World (Official Music Video)","artist":"Tears For Fears","album":null,"uri":"https://rr3---sn-ab5l6nk6.googlevideo.com/videoplayback?expire=1770683351&ei=dyeKacmGF620kucP4LXusQI&ip=74.70.83.118&id=o-ADuNmc_wPfBxgOEdJhQ82krDCSlKwRi8Df3HeQESyOHj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1770661751%2C&mh=Wc&mm=31%2C29&mn=sn-ab5l6nk6%2Csn-ab5sznzk&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=3641250&bui=AW-iu_qpZeWSNdpsEtJ3A928eAjVJzaUwP99X-2uFNZmZMJAPpzSPsMrghe8NAJQ468XOSKbeEpjvRgj&spc=q5xjPAwpYr-2jE22K0i9xXeT2viBI5TDVUKsvLjPkZOjDZFphQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=mO5OYEQOPqHKKhKKoMKteL8S&rqh=1&gir=yes&clen=4814643&dur=290.741&lmt=1741840271438086&mt=1770661329&fvip=3&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_REMIX&sefc=1&txp=4532534&n=hRa60LbVCgfMeQ&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=APaTxxMwRAIgUgsFqMQ0tINukn4UMxEXQwW2f5prctAU-HSPpfOeuKMCIACef8DvzdgpM5pRxmEXSTSBZVUJTzpSjcucJWETZbPl&sig=AJEij0EwRAIgNaf8m9dQHNxGsM_73geYlvBvrx8htd4Akt3Gi7Ag99ACICLsuofGraHyDRp1wx2PiskadWoJAGTUn1qSk0PGA4Ao&pot=MlWmAdTUqi3UKaY_iD0okroIlQWklDAiJNh4HyVU11n-CW0_-eF8v7AF0z0GAQgytXVccQHzCRDAXhhk7nW5A4gPLbapNPtRE05QgRV2A0nJRwQ_lZnU&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Feb 09 13:29:21 volumio volumio[1134]: verbose: CURRENT POSITION 0
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::syncState stateService pause
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::syncState currentStatus pause
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::pushState
Feb 09 13:29:21 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 09 13:29:21 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::stPlaybackTimer
Feb 09 13:29:21 volumio volumio[1134]: info: ControllerMpd::pushState
Feb 09 13:29:21 volumio volumio[1134]: info: CoreCommandRouter::servicePushState
Feb 09 13:29:21 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:21 volumio volumio[1134]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":9738,"duration":291,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Everybody Wants To Rule The World (Official Music Video)","artist":"Tears For Fears","album":null,"uri":"https://rr3---sn-ab5l6nk6.googlevideo.com/videoplayback?expire=1770683351&ei=dyeKacmGF620kucP4LXusQI&ip=74.70.83.118&id=o-ADuNmc_wPfBxgOEdJhQ82krDCSlKwRi8Df3HeQESyOHj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1770661751%2C&mh=Wc&mm=31%2C29&mn=sn-ab5l6nk6%2Csn-ab5sznzk&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=3641250&bui=AW-iu_qpZeWSNdpsEtJ3A928eAjVJzaUwP99X-2uFNZmZMJAPpzSPsMrghe8NAJQ468XOSKbeEpjvRgj&spc=q5xjPAwpYr-2jE22K0i9xXeT2viBI5TDVUKsvLjPkZOjDZFphQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=mO5OYEQOPqHKKhKKoMKteL8S&rqh=1&gir=yes&clen=4814643&dur=290.741&lmt=1741840271438086&mt=1770661329&fvip=3&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_REMIX&sefc=1&txp=4532534&n=hRa60LbVCgfMeQ&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=APaTxxMwRAIgUgsFqMQ0tINukn4UMxEXQwW2f5prctAU-HSPpfOeuKMCIACef8DvzdgpM5pRxmEXSTSBZVUJTzpSjcucJWETZbPl&sig=AJEij0EwRAIgNaf8m9dQHNxGsM_73geYlvBvrx8htd4Akt3Gi7Ag99ACICLsuofGraHyDRp1wx2PiskadWoJAGTUn1qSk0PGA4Ao&pot=MlWmAdTUqi3UKaY_iD0okroIlQWklDAiJNh4HyVU11n-CW0_-eF8v7AF0z0GAQgytXVccQHzCRDAXhhk7nW5A4gPLbapNPtRE05QgRV2A0nJRwQ_lZnU&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Feb 09 13:29:21 volumio volumio[1134]: verbose: CURRENT POSITION 0
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::syncState stateService pause
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::syncState currentStatus pause
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::pushState
Feb 09 13:29:21 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::stPlaybackTimer
Feb 09 13:29:21 volumio volumio[1134]: info: ControllerMpd::pushState
Feb 09 13:29:21 volumio volumio[1134]: info: CoreCommandRouter::servicePushState
Feb 09 13:29:21 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:21 volumio volumio[1134]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":9738,"duration":291,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Everybody Wants To Rule The World (Official Music Video)","artist":"Tears For Fears","album":null,"uri":"https://rr3---sn-ab5l6nk6.googlevideo.com/videoplayback?expire=1770683351&ei=dyeKacmGF620kucP4LXusQI&ip=74.70.83.118&id=o-ADuNmc_wPfBxgOEdJhQ82krDCSlKwRi8Df3HeQESyOHj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1770661751%2C&mh=Wc&mm=31%2C29&mn=sn-ab5l6nk6%2Csn-ab5sznzk&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=3641250&bui=AW-iu_qpZeWSNdpsEtJ3A928eAjVJzaUwP99X-2uFNZmZMJAPpzSPsMrghe8NAJQ468XOSKbeEpjvRgj&spc=q5xjPAwpYr-2jE22K0i9xXeT2viBI5TDVUKsvLjPkZOjDZFphQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=mO5OYEQOPqHKKhKKoMKteL8S&rqh=1&gir=yes&clen=4814643&dur=290.741&lmt=1741840271438086&mt=1770661329&fvip=3&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_REMIX&sefc=1&txp=4532534&n=hRa60LbVCgfMeQ&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=APaTxxMwRAIgUgsFqMQ0tINukn4UMxEXQwW2f5prctAU-HSPpfOeuKMCIACef8DvzdgpM5pRxmEXSTSBZVUJTzpSjcucJWETZbPl&sig=AJEij0EwRAIgNaf8m9dQHNxGsM_73geYlvBvrx8htd4Akt3Gi7Ag99ACICLsuofGraHyDRp1wx2PiskadWoJAGTUn1qSk0PGA4Ao&pot=MlWmAdTUqi3UKaY_iD0okroIlQWklDAiJNh4HyVU11n-CW0_-eF8v7AF0z0GAQgytXVccQHzCRDAXhhk7nW5A4gPLbapNPtRE05QgRV2A0nJRwQ_lZnU&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Feb 09 13:29:21 volumio volumio[1134]: verbose: CURRENT POSITION 0
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::syncState stateService pause
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::syncState currentStatus pause
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::pushState
Feb 09 13:29:21 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState
Feb 09 13:29:21 volumio volumio[1134]: info: CoreStateMachine::stPlaybackTimer
Feb 09 13:29:21 volumio volumio[1134]: info: ------------------------------ 22ms
Feb 09 13:29:21 volumio volumio[1134]: info: ------------------------------ 22ms
Feb 09 13:29:21 volumio volumio[1134]: info: ------------------------------ 22ms
Feb 09 13:29:23 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 09 13:29:23 volumio volumio[1134]: info: CURURI: music-library
Feb 09 13:29:23 volumio volumio[1134]: info: CoreCommandRouter::volumioGetQueue
Feb 09 13:29:23 volumio volumio[1134]: info: CoreStateMachine::getQueue
Feb 09 13:29:23 volumio volumio[1134]: info: CorePlayQueue::getQueue
Feb 09 13:29:23 volumio volumio[1134]: info: Preload queue cleared
Feb 09 13:29:24 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 09 13:29:24 volumio volumio[1134]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Feb 09 13:29:24 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Feb 09 13:29:24 volumio volumio[1134]: info: Received Get System Version
Feb 09 13:29:24 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 09 13:29:24 volumio volumio[1134]: info: Received Get System Info
Feb 09 13:29:24 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 09 13:29:24 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 09 13:29:24 volumio volumio[1134]: info: Discovery: Getting this device information
Feb 09 13:29:24 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState
Feb 09 13:29:24 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 09 13:29:25 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 09 13:29:25 volumio volumio[1134]: info: CURURI: music-library/USB
Feb 09 13:29:25 volumio volumio[1134]: info: Preload queue cleared
Feb 09 13:29:27 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 09 13:29:27 volumio volumio[1134]: info: CURURI: music-library/USB/USB20FD
Feb 09 13:29:27 volumio volumio[1134]: info: Preload queue cleared
Feb 09 13:29:32 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 09 13:29:32 volumio volumio[1134]: info: CURURI: music-library/USB/USB20FD/Amy Winehouse
Feb 09 13:29:32 volumio volumio[1134]: info: Preload queue cleared
Feb 09 13:29:35 volumio volumio[1134]: info: Preload queue cleared
Feb 09 13:29:35 volumio volumio[1134]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 09 13:29:35 volumio volumio[1134]: info: CoreStateMachine::ClearQueue
Feb 09 13:29:35 volumio volumio[1134]: info: CoreStateMachine::stop
Feb 09 13:29:35 volumio volumio[1134]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 09 13:29:35 volumio volumio[1134]: info: CoreStateMachine::updateTrackBlock
Feb 09 13:29:35 volumio volumio[1134]: info: CorePlayQueue::getTrackBlock
Feb 09 13:29:35 volumio volumio[1134]: info: CoreStateMachine::stPlaybackTimer
Feb 09 13:29:35 volumio volumio[1134]: info: CoreStateMachine::pushState
Feb 09 13:29:35 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:35 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 09 13:29:35 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState
Feb 09 13:29:35 volumio volumio[1134]: info: CoreStateMachine::serviceStop
Feb 09 13:29:35 volumio volumio[1134]: info: CorePlayQueue::getTrack 0
Feb 09 13:29:35 volumio volumio[1134]: info: CoreCommandRouter::serviceStop
Feb 09 13:29:35 volumio volumio[1134]: info: [ytmusic] (AutoplayManager) Removed mpdStateListener
Feb 09 13:29:35 volumio volumio[1134]: info: [ytmusic] (AutoplayManager) Removed volumioStateListener
Feb 09 13:29:35 volumio volumio[1134]: info: [ytmusic] (AutoplayManager) Disabled
Feb 09 13:29:35 volumio volumio[1134]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 09 13:29:35 volumio volumio[1134]: info: ControllerMpd::stop
Feb 09 13:29:35 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand stop
Feb 09 13:29:35 volumio volumio[1134]: info: CorePlayQueue::clearPlayQueue
Feb 09 13:29:35 volumio volumio[1134]: info: CorePlayQueue::saveQueue
Feb 09 13:29:35 volumio volumio[1134]: info: CoreCommandRouter::volumioPushQueue
Feb 09 13:29:35 volumio volumio[1134]: info: CoreStateMachine::addQueueItems
Feb 09 13:29:35 volumio volumio[1134]: info: CorePlayQueue::addQueueItems
Feb 09 13:29:35 volumio volumio[1134]: info: Preload queue cleared
Feb 09 13:29:35 volumio volumio[1134]: info: Adding Item to queue: music-library/USB/USB20FD/Amy Winehouse/Back To Black
Feb 09 13:29:35 volumio volumio[1134]: info: Exploding uri music-library/USB/USB20FD/Amy Winehouse/Back To Black in service mpd
Feb 09 13:29:35 volumio volumio[1134]: info:
Feb 09 13:29:35 volumio volumio[1134]: ---------------------------- MPD announces state update: player
Feb 09 13:29:35 volumio volumio[1134]: info: sendMpdCommand stop took 27 milliseconds
Feb 09 13:29:35 volumio volumio[1134]: info: ControllerMpd::getState
Feb 09 13:29:35 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 13:29:35 volumio volumio[1134]: info:
Feb 09 13:29:35 volumio volumio[1134]: ---------------------------- MPD announces state update: player
Feb 09 13:29:35 volumio volumio[1134]: info: ControllerMpd::getState
Feb 09 13:29:35 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 13:29:35 volumio volumio[1134]: info:
Feb 09 13:29:35 volumio volumio[1134]: ---------------------------- MPD announces state update: player
Feb 09 13:29:35 volumio volumio[1134]: info: ControllerMpd::getState
Feb 09 13:29:35 volumio volumio[1134]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 13:29:35 volumio volumio[1134]: info: ALBUMART /albumart?cacheid=413&web=Amy%20Winehouse/Back%20To%20Black/extralarge&path=%2Fmnt%2FUSB%2FUSB20FD%2FAmy%20Winehouse%2FBack%20To%20Black%2F01%20Rehab%20-%20Amy%20Winehouse.flac&metadata=false
Feb 09 13:29:35 volumio volumio[1134]: info: URI /mnt/USB/USB20FD/Amy Winehouse/Back To Black/01 Rehab - Amy Winehouse.flac
Feb 09 13:29:35 volumio volumio[1134]: info: ALBUMART /albumart?cacheid=413&web=Amy%20Winehouse/Back%20To%20Black/extralarge&path=%2Fmnt%2FUSB%2FUSB20FD%2FAmy%20Winehouse%2FBack%20To%20Black%2F02%20You%20Know%20I'm%20No%20Good%20-%20Amy%20Winehouse.flac&metadata=false
Feb 09 13:29:35 volumio volumio[1134]: info: URI /mnt/USB/USB20FD/Amy Winehouse/Back To Black/02 You Know I'm No Good - Amy Winehouse.flac
Feb 09 13:29:35 volumio volumio[1134]: info: ALBUMART /albumart?cacheid=413&web=Amy%20Winehouse/Back%20To%20Black/extralarge&path=%2Fmnt%2FUSB%2FUSB20FD%2FAmy%20Winehouse%2FBack%20To%20Black%2F03%20Me%20%26%20Mr.%20Jones%20-%20Amy%20Winehouse.flac&metadata=false
Feb 09 13:29:35 volumio volumio[1134]: info: URI /mnt/USB/USB20FD/Amy Winehouse/Back To Black/03 Me & Mr. Jones - Amy Winehouse.flac
Feb 09 13:29:35 volumio volumio[1134]: info: ALBUMART /albumart?cacheid=413&web=Amy%20Winehouse/Back%20To%20Black/extralarge&path=%2Fmnt%2FUSB%2FUSB20FD%2FAmy%20Winehouse%2FBack%20To%20Black%2F04%20Just%20Friends%20-%20Amy%20Winehouse.flac&metadata=false
Feb 09 13:29:35 volumio volumio[1134]: info: URI /mnt/USB/USB20FD/Amy Winehouse/Back To Black/04 Just Friends - Amy Winehouse.flac
Feb 09 13:29:35 volumio volumio[1134]: info: ALBUMART /albumart?cacheid=413&web=Amy%20Winehouse/Back%20To%20Black/extralarge&path=%2Fmnt%2FUSB%2FUSB20FD%2FAmy%20Winehouse%2FBack%20To%20Black%2F05%20Back%20To%20Black%20-%20Amy%20Winehouse.flac&metadata=false
Feb 09 13:29:35 volumio volumio[1134]: info: URI /mnt/USB/USB20FD/Amy Winehouse/Back To Black/05 Back To Black - Amy Winehouse.flac
Feb 09 13:29:35 volumio volumio[1134]: info: ALBUMART /albumart?cacheid=413&web=Amy%20Winehouse/Back%20To%20Black/extralarge&path=%2Fmnt%2FUSB%2FUSB20FD%2FAmy%20Winehouse%2FBack%20To%20Black%2F06%20Love%20Is%20A%20Losing%20Game%20-%20Amy%20Winehouse.flac&metadata=false
Feb 09 13:29:35 volumio volumio[1134]: info: URI /mnt/USB/USB20FD/Amy Winehouse/Back To Black/06 Love Is A Losing Game - Amy Winehouse.flac
Feb 09 13:29:35 volumio volumio[1134]: info: ALBUMART /albumart?cacheid=413&web=Amy%20Winehouse/Back%20To%20Black/extralarge&path=%2Fmnt%2FUSB%2FUSB20FD%2FAmy%20Winehouse%2FBack%20To%20Black%2F07%20Tears%20Dry%20On%20Their%20Own%20-%20Amy%20Winehouse.flac&metadata=false
Feb 09 13:29:35 volumio volumio[1134]: info: URI /mnt/USB/USB20FD/Amy Winehouse/Back To Black/07 Tears Dry On Their Own - Amy Winehouse.flac
Feb 09 13:29:35 volumio volumio[1134]: info: ALBUMART /albumart?cacheid=413&web=Amy%20Winehouse/Back%20To%20Black/extralarge&path=%2Fmnt%2FUSB%2FUSB20FD%2FAmy%20Winehouse%2FBack%20To%20Black%2F08%20Wake%20Up%20Alone%20-%20Amy%20Winehouse.flac&metadata=false
Feb 09 13:29:35 volumio volumio[1134]: info: URI /mnt/USB/USB20FD/Amy Winehouse/Back To Black/08 Wake Up Alone - Amy Winehouse.flac
Feb 09 13:29:35 volumio volumio[1134]: info: ALBUMART /albumart?cacheid=413&web=Amy%20Winehouse/Back%20To%20Black/extralarge&path=%2Fmnt%2FUSB%2FUSB20FD%2FAmy%20Winehouse%2FBack%20To%20Black%2F09%20Some%20Unholy%20War%20-%20Amy%20Winehouse.flac&metadata=false
Feb 09 13:29:35 volumio volumio[1134]: info: URI /mnt/USB/USB20FD/Amy Winehouse/Back To Black/09 Some Unholy War - Amy Winehouse.flac
Feb 09 13:29:35 volumio volumio[1134]: info: ALBUMART /albumart?cacheid=413&web=Amy%20Winehouse/Back%20To%20Black/extralarge&path=%2Fmnt%2FUSB%2FUSB20FD%2FAmy%20Winehouse%2FBack%20To%20Black%2F10%20He%20Can%20Only%20Hold%20Her%20-%20Amy%20Winehouse.flac&metadata=false
Feb 09 13:29:35 volumio volumio[1134]: info: URI /mnt/USB/USB20FD/Amy Winehouse/Back To Black/10 He Can Only Hold Her - Amy Winehouse.flac
Feb 09 13:29:35 volumio volumio[1134]: info: ALBUMART /albumart?cacheid=413&web=Amy%20Winehouse/Back%20To%20Black/extralarge&path=%2Fmnt%2FUSB%2FUSB20FD%2FAmy%20Winehouse%2FBack%20To%20Black%2F11%20Addicted%20-%20Amy%20Winehouse.flac&metadata=false
Feb 09 13:29:35 volumio volumio[1134]: info: URI /mnt/USB/USB20FD/Amy Winehouse/Back To Black/11 Addicted - Amy Winehouse.flac
Feb 09 13:29:35 volumio volumio[1134]: info: ALBUMART /albumart?cacheid=413&web=Amy%20Winehouse/Back%20To%20Black/extralarge&path=%2Fmnt%2FUSB%2FUSB20FD%2FAmy%20Winehouse%2FBack%20To%20Black%2FAmy%20Winehouse%20-%20Back%20To%20Black.cue&metadata=false
Feb 09 13:29:35 volumio volumio[1134]: info: URI /mnt/USB/USB20FD/Amy Winehouse/Back To Black/Amy Winehouse - Back To Black.cue
Feb 09 13:29:35 volumio volumio[1134]: info: ALBUMART /albumart?cacheid=413&web=Amy%20Winehouse/Back%20To%20Black/extralarge&path=%2Fmnt%2FUSB%2FUSB20FD%2FAmy%20Winehouse%2FBack%20To%20Black%2FAmy%20Winehouse%20-%20Back%20To%20Black.cue&metadata=false
Feb 09 13:29:35 volumio volumio[1134]: info: URI /mnt/USB/USB20FD/Amy Winehouse/Back To Black/Amy Winehouse - Back To Black.cue
Feb 09 13:29:35 volumio volumio[1134]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 09 13:29:35 volumio volumio[1134]: Error: Unable to resolve or reject the same promise twice
Feb 09 13:29:35 volumio volumio[1134]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Feb 09 13:29:35 volumio volumio[1134]: at /volumio/app/plugins/music_service/mpd/index.js:2569:21
Feb 09 13:29:35 volumio volumio[1134]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Feb 09 13:29:35 volumio volumio[1134]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Feb 09 13:29:35 volumio volumio[1134]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Feb 09 13:29:35 volumio volumio[1134]: at Socket.emit (node:events:514:28)
Feb 09 13:29:35 volumio volumio[1134]: at addChunk (node:internal/streams/readable:343:12)
Feb 09 13:29:35 volumio volumio[1134]: at readableAddChunk (node:internal/streams/readable:312:11)
Feb 09 13:29:35 volumio volumio[1134]: at Readable.push (node:internal/streams/readable:253:10)
Feb 09 13:29:35 volumio volumio[1134]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23)
Feb 09 13:29:35 volumio volumio[1134]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 09 13:29:36 volumio sudo[9666]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-09 13:28'
Feb 09 13:29:36 volumio sudo[9666]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025"
VOLUMIO_VERSION="4.084"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"