-- Logs begin at Wed 2024-04-24 22:21:39 CEST, end at Fri 2024-05-03 18:39:14 CEST. --
May 03 18:38:03 volumio volumio[779]: info: CoreCommandRouter::volumioGetState
May 03 18:38:03 volumio volumio[779]: info: Listing playlists
May 03 18:38:03 volumio volumio[779]: info: Listing playlists
May 03 18:38:13 volumio volumio[779]: info: CoreCommandRouter::volumioGetState
May 03 18:38:23 volumio volumio[779]: info: CoreCommandRouter::volumioGetState
May 03 18:38:23 volumio volumio[779]: info: Listing playlists
May 03 18:38:23 volumio volumio[779]: info: Listing playlists
May 03 18:38:33 volumio volumio[779]: info: CoreCommandRouter::volumioGetState
May 03 18:38:43 volumio volumio[779]: info: CoreCommandRouter::volumioGetState
May 03 18:38:43 volumio volumio[779]: info: Listing playlists
May 03 18:38:43 volumio volumio[779]: info: Listing playlists
May 03 18:38:53 volumio volumio[779]: info: CoreCommandRouter::volumioGetState
May 03 18:39:00 volumio volumio[779]: info: CorePlayQueue::getTrack 0
May 03 18:39:00 volumio volumio[779]: info: CorePlayQueue::getTrack 1
May 03 18:39:00 volumio volumio[779]: info: Prefetching next song
May 03 18:39:03 volumio volumio[779]: info: CoreCommandRouter::volumioGetState
May 03 18:39:03 volumio volumio[779]: info: Listing playlists
May 03 18:39:03 volumio volumio[779]: info: Listing playlists
May 03 18:39:05 volumio volumio[779]: info: CoreStateMachine::startPlaybackTimer
May 03 18:39:05 volumio volumio[779]: info: CorePlayQueue::getTrack 1
May 03 18:39:05 volumio volumio[779]: info:
May 03 18:39:05 volumio volumio[779]: ---------------------------- MPD announces state update: player
May 03 18:39:05 volumio volumio[779]: info: ControllerMpd::getState
May 03 18:39:05 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand status
May 03 18:39:05 volumio volumio[779]: info:
May 03 18:39:05 volumio volumio[779]: ---------------------------- MPD announces state update: player
May 03 18:39:05 volumio volumio[779]: info: ControllerMpd::getState
May 03 18:39:05 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand status
May 03 18:39:05 volumio volumio[779]: info:
May 03 18:39:05 volumio volumio[779]: ---------------------------- MPD announces state update: player
May 03 18:39:05 volumio volumio[779]: info: ControllerMpd::getState
May 03 18:39:05 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand status
May 03 18:39:05 volumio volumio[779]: info: sendMpdCommand status took 19 milliseconds
May 03 18:39:05 volumio volumio[779]: info: sendMpdCommand status took 12 milliseconds
May 03 18:39:05 volumio volumio[779]: info: sendMpdCommand status took 8 milliseconds
May 03 18:39:05 volumio volumio[779]: verbose: ControllerMpd::parseState
May 03 18:39:05 volumio volumio[779]: verbose: ControllerMpd::parseState
May 03 18:39:05 volumio volumio[779]: verbose: ControllerMpd::parseState
May 03 18:39:05 volumio volumio[779]: info: ControllerMpd::pushState
May 03 18:39:05 volumio volumio[779]: info: CoreCommandRouter::servicePushState
May 03 18:39:05 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:05 volumio volumio[779]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 18:39:05 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:05 volumio volumio[779]: info: CorePlayQueue::getTrack 1
May 03 18:39:05 volumio volumio[779]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 03 18:39:05 volumio volumio[779]: verbose: CURRENT POSITION 1
May 03 18:39:05 volumio volumio[779]: info: CoreStateMachine::syncState stateService stop
May 03 18:39:05 volumio volumio[779]: info: CoreStateMachine::syncState currentStatus play
May 03 18:39:05 volumio volumio[779]: info: CoreStateMachine::play index undefined
May 03 18:39:05 volumio volumio[779]: info: CoreStateMachine::setConsumeUpdateService undefined
May 03 18:39:05 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:05 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:05 volumio volumio[779]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 18:39:05 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:05 volumio volumio[779]: info: ControllerMpd::pushState
May 03 18:39:05 volumio volumio[779]: info: CoreCommandRouter::servicePushState
May 03 18:39:05 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:05 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:05 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:05 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:05 volumio volumio[779]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd
May 03 18:39:05 volumio volumio[779]: info: ControllerMpd::pushState
May 03 18:39:05 volumio volumio[779]: info: CoreCommandRouter::servicePushState
May 03 18:39:05 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:05 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:05 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:05 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:05 volumio volumio[779]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd
May 03 18:39:05 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:05 volumio volumio[779]: info: CoreStateMachine::startPlaybackTimer
May 03 18:39:05 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:05 volumio volumio[779]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22Piazza%20Grande%20(Live)%22%2C%22artist%22%3A%22Lucio%20Dalla%20%26%20Francesco%20De%20Gregori%22%2C%22album%22%3A%22duvudub%C3%A0%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2Fm9kYiEMMl-ctLdJ2NAs-zdwZjqBPF0cA-9qY-nTWsJkttQ7fFjaRFaGevfoWFq8osxK1ZEVYOyzkgVd58g%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22mEWYsFyeL8k%22%2C%22playlistId%22%3A%22OLAK5uy_k_0KkOxrH4YUETpP8G6FgWl55nnZpwLEc%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22index%22%3A2%2C%22playlistSetVideoId%22%3A%228CE39915C912189C%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22OLAK5uy_k_0KkOxrH4YUETpP8G6FgWl55nnZpwLEc%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22videoId%22%3A%22nDh93umkwco%22%7D%7D%7D%7D
May 03 18:39:05 volumio volumio[779]: info: ------------------------------ 137ms
May 03 18:39:05 volumio volumio[779]: info: ------------------------------ 126ms
May 03 18:39:05 volumio volumio[779]: info: ------------------------------ 123ms
May 03 18:39:05 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:05 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:05 volumio volumio[779]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 18:39:05 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:05 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:05 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:05 volumio volumio[779]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 18:39:05 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:06 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand addid "https://rr3---sn-25glenlk.googlevideo.com/videoplayback?expire=1714775940&ei=JBM1ZtGZLpGevdIPuIGF-A0&ip=90.90.3.24&id=o-ACwMxKMghMchIOUumAQ594-69kRPlNUmTQnuAUjfkS0v&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=lH&mm=31%2C29&mn=sn-25glenlk%2Csn-25ge7nzr&ms=au%2Crdu&mv=m&mvi=3&pl=16&gcr=fr&initcwndbps=1576250&bui=AWRWj2R2ruwZMod0EOY6fkIACWUBgpOHiHIDKyTOwk3Ixw19lRDBGhDKOU6Au7MWU7pGSTE2qBZ9DEcS&spc=UWF9f4n8B_zdW_Tv4UN-Au8yZA6hdTt9HNj__7ePRYQ4rMc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=-WWXgj1Psg4TvpGZpox-gl0Q&gir=yes&clen=4646205&dur=259.641&lmt=1586683795083296&mt=1714753762&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5531432&n=V4gLh-XjDS1yyg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRAIgQ3u14LhqCZewgf_bkbG4NN_RBVDhnwU_NlU2sOQ19lQCICDaUhULjHnrOzF53WJrRSQ--i5dbMt1Ytl2ogCYWsWW&sig=AJfQdSswRgIhAM5gNFt9oVHu7txhZA1wl8cq9irom7eZLKpz6YPW7tJDAiEApV2QZsMxQ3LOTEvSXR_MwdX1oB7m4CzWnrFR4KNDB4s%3D&cver=1.20211213.00.00&t.YouTube"
May 03 18:39:06 volumio volumio[779]: info:
May 03 18:39:06 volumio volumio[779]: ---------------------------- MPD announces system playlist update
May 03 18:39:06 volumio volumio[779]: info: Ignoring MPD Status Update
May 03 18:39:06 volumio volumio[779]: info: sendMpdCommand addid "https://rr3---sn-25glenlk.googlevideo.com/videoplayback?expire=1714775940&ei=JBM1ZtGZLpGevdIPuIGF-A0&ip=90.90.3.24&id=o-ACwMxKMghMchIOUumAQ594-69kRPlNUmTQnuAUjfkS0v&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=lH&mm=31%2C29&mn=sn-25glenlk%2Csn-25ge7nzr&ms=au%2Crdu&mv=m&mvi=3&pl=16&gcr=fr&initcwndbps=1576250&bui=AWRWj2R2ruwZMod0EOY6fkIACWUBgpOHiHIDKyTOwk3Ixw19lRDBGhDKOU6Au7MWU7pGSTE2qBZ9DEcS&spc=UWF9f4n8B_zdW_Tv4UN-Au8yZA6hdTt9HNj__7ePRYQ4rMc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=-WWXgj1Psg4TvpGZpox-gl0Q&gir=yes&clen=4646205&dur=259.641&lmt=1586683795083296&mt=1714753762&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5531432&n=V4gLh-XjDS1yyg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRAIgQ3u14LhqCZewgf_bkbG4NN_RBVDhnwU_NlU2sOQ19lQCICDaUhULjHnrOzF53WJrRSQ--i5dbMt1Ytl2ogCYWsWW&sig=AJfQdSswRgIhAM5gNFt9oVHu7txhZA1wl8cq9irom7eZLKpz6YPW7tJDAiEApV2QZsMxQ3LOTEvSXR_MwdX1oB7m4CzWnrFR4KNDB4s%3D&cver=1.20211213.00.00&t.YouTube" took 49 milliseconds
May 03 18:39:06 volumio volumio[779]: verbose: MPD COMMAND [object Object]
May 03 18:39:06 volumio volumio[779]: verbose: MPD COMMAND [object Object]
May 03 18:39:06 volumio volumio[779]: verbose: MPD COMMAND [object Object]
May 03 18:39:06 volumio volumio[779]: info:
May 03 18:39:06 volumio volumio[779]: ---------------------------- MPD announces system playlist update
May 03 18:39:06 volumio volumio[779]: info: Ignoring MPD Status Update
May 03 18:39:06 volumio volumio[779]: info:
May 03 18:39:06 volumio volumio[779]: ---------------------------- MPD announces system playlist update
May 03 18:39:06 volumio volumio[779]: info: Ignoring MPD Status Update
May 03 18:39:06 volumio volumio[779]: info:
May 03 18:39:06 volumio volumio[779]: ---------------------------- MPD announces system playlist update
May 03 18:39:06 volumio volumio[779]: info: Ignoring MPD Status Update
May 03 18:39:06 volumio volumio[779]: info: ------------------------------ 39ms
May 03 18:39:06 volumio volumio[779]: info: ------------------------------ 25ms
May 03 18:39:06 volumio volumio[779]: info: ------------------------------ 23ms
May 03 18:39:06 volumio volumio[779]: info: [ytmusic-play] Prefetched and added track to MPD queue: Generale
May 03 18:39:06 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand consume 1
May 03 18:39:06 volumio volumio[779]: info:
May 03 18:39:06 volumio volumio[779]: ---------------------------- MPD announces system playlist update
May 03 18:39:06 volumio volumio[779]: info: Ignoring MPD Status Update
May 03 18:39:06 volumio volumio[779]: info:
May 03 18:39:06 volumio volumio[779]: ---------------------------- MPD announces system playlist update
May 03 18:39:06 volumio volumio[779]: info: Ignoring MPD Status Update
May 03 18:39:06 volumio volumio[779]: info:
May 03 18:39:06 volumio volumio[779]: ---------------------------- MPD announces state update: options
May 03 18:39:06 volumio volumio[779]: info: ------------------------------ 32ms
May 03 18:39:06 volumio volumio[779]: info: sendMpdCommand consume 1 took 21 milliseconds
May 03 18:39:06 volumio volumio[779]: info: ControllerMpd::getState
May 03 18:39:06 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand status
May 03 18:39:06 volumio volumio[779]: info: ------------------------------ 23ms
May 03 18:39:06 volumio volumio[779]: info: ------------------------------ 20ms
May 03 18:39:06 volumio volumio[779]: info:
May 03 18:39:06 volumio volumio[779]: ---------------------------- MPD announces state update: options
May 03 18:39:06 volumio volumio[779]: info: ControllerMpd::getState
May 03 18:39:06 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand status
May 03 18:39:06 volumio volumio[779]: info:
May 03 18:39:06 volumio volumio[779]: ---------------------------- MPD announces state update: options
May 03 18:39:06 volumio volumio[779]: info: ControllerMpd::getState
May 03 18:39:06 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand status
May 03 18:39:06 volumio volumio[779]: info: sendMpdCommand status took 29 milliseconds
May 03 18:39:06 volumio volumio[779]: info: sendMpdCommand status took 20 milliseconds
May 03 18:39:06 volumio volumio[779]: info: sendMpdCommand status took 10 milliseconds
May 03 18:39:06 volumio volumio[779]: verbose: ControllerMpd::parseState
May 03 18:39:06 volumio volumio[779]: verbose: ControllerMpd::parseState
May 03 18:39:06 volumio volumio[779]: verbose: ControllerMpd::parseState
May 03 18:39:06 volumio volumio[779]: info: ControllerMpd::pushState
May 03 18:39:06 volumio volumio[779]: info: CoreCommandRouter::servicePushState
May 03 18:39:06 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:06 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:06 volumio volumio[779]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 18:39:06 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:06 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:06 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:06 volumio volumio[779]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd
May 03 18:39:06 volumio volumio[779]: info: ControllerMpd::pushState
May 03 18:39:06 volumio volumio[779]: info: CoreCommandRouter::servicePushState
May 03 18:39:06 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:06 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:06 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:06 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:06 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:06 volumio volumio[779]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd
May 03 18:39:06 volumio volumio[779]: info: ControllerMpd::pushState
May 03 18:39:06 volumio volumio[779]: info: CoreCommandRouter::servicePushState
May 03 18:39:06 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:06 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:06 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:06 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:06 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:06 volumio volumio[779]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd
May 03 18:39:06 volumio volumio[779]: info: ------------------------------ 101ms
May 03 18:39:06 volumio volumio[779]: info: ------------------------------ 88ms
May 03 18:39:06 volumio volumio[779]: info: ------------------------------ 79ms
May 03 18:39:07 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:07 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand stop
May 03 18:39:07 volumio volumio[779]: info: sendMpdCommand stop took 11 milliseconds
May 03 18:39:07 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand clear
May 03 18:39:07 volumio volumio[779]: info:
May 03 18:39:07 volumio volumio[779]: ---------------------------- MPD announces system playlist update
May 03 18:39:07 volumio volumio[779]: info: Ignoring MPD Status Update
May 03 18:39:07 volumio volumio[779]: info: sendMpdCommand clear took 6 milliseconds
May 03 18:39:07 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-25glenlz.googlevideo.com/videoplayback?expire=1714775945&ei=KRM1ZurIM5P6vdIP9PCXwAQ&ip=90.90.3.24&id=o-ABSb_NYqQs78zIp7y4YmCyy0CehLCdpjmkdrJXZfsZ1A&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W2&mm=31%2C29&mn=sn-25glenlz%2Csn-25ge7nsd&ms=au%2Crdu&mv=m&mvi=2&pl=16&gcr=fr&initcwndbps=1582500&bui=AWRWj2Q2Kpamlw9PoZQumuUoaHHw16UwwtarlA3zCi0yIq9gDwVWU-sKLogqd-jb7CiENIMRGZle4RmY&spc=UWF9f4VGWQkQgJwaySEeRVj3qkn25YnqMX2xTfiRkGIZS5I&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Nww_IrpwRqJM0uGUG6LWHjUQ&gir=yes&clen=3417928&dur=191.201&lmt=1565960786871994&mt=1714753762&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2311222&n=jvDkBAev25clNg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIgTTmg6sE6MAIa_B8JnIexaxJnHfVNtN78r8PDQyrQ1cACIQCsB0ZY0iDlzLqGgZ4vaAI_bUNNRJhmP1-0Gzqsq-u3bQ%3D%3D&sig=AJfQdSswRgIhANkx9Ein2jwftdy7vSkSCbrysgY50Y9OJJQStC7U95_1AiEA0dhRjrVoobomVsy9hCbgp7KTX2cNQOGHaGhx8Uv18Es%3D&cver=1.20211213.00.00&t.YouTube"
May 03 18:39:07 volumio volumio[779]: info:
May 03 18:39:07 volumio volumio[779]: ---------------------------- MPD announces system playlist update
May 03 18:39:07 volumio volumio[779]: info: Ignoring MPD Status Update
May 03 18:39:07 volumio volumio[779]: info:
May 03 18:39:07 volumio volumio[779]: ---------------------------- MPD announces system playlist update
May 03 18:39:07 volumio volumio[779]: info: Ignoring MPD Status Update
May 03 18:39:07 volumio volumio[779]: error: updateQueue error: null
May 03 18:39:07 volumio volumio[779]: info:
May 03 18:39:07 volumio volumio[779]: ---------------------------- MPD announces system playlist update
May 03 18:39:07 volumio volumio[779]: info: Ignoring MPD Status Update
May 03 18:39:07 volumio volumio[779]: info: ------------------------------ 23ms
May 03 18:39:07 volumio volumio[779]: info: sendMpdCommand addid "https://rr2---sn-25glenlz.googlevideo.com/videoplayback?expire=1714775945&ei=KRM1ZurIM5P6vdIP9PCXwAQ&ip=90.90.3.24&id=o-ABSb_NYqQs78zIp7y4YmCyy0CehLCdpjmkdrJXZfsZ1A&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W2&mm=31%2C29&mn=sn-25glenlz%2Csn-25ge7nsd&ms=au%2Crdu&mv=m&mvi=2&pl=16&gcr=fr&initcwndbps=1582500&bui=AWRWj2Q2Kpamlw9PoZQumuUoaHHw16UwwtarlA3zCi0yIq9gDwVWU-sKLogqd-jb7CiENIMRGZle4RmY&spc=UWF9f4VGWQkQgJwaySEeRVj3qkn25YnqMX2xTfiRkGIZS5I&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Nww_IrpwRqJM0uGUG6LWHjUQ&gir=yes&clen=3417928&dur=191.201&lmt=1565960786871994&mt=1714753762&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2311222&n=jvDkBAev25clNg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIgTTmg6sE6MAIa_B8JnIexaxJnHfVNtN78r8PDQyrQ1cACIQCsB0ZY0iDlzLqGgZ4vaAI_bUNNRJhmP1-0Gzqsq-u3bQ%3D%3D&sig=AJfQdSswRgIhANkx9Ein2jwftdy7vSkSCbrysgY50Y9OJJQStC7U95_1AiEA0dhRjrVoobomVsy9hCbgp7KTX2cNQOGHaGhx8Uv18Es%3D&cver=1.20211213.00.00&t.YouTube" took 19 milliseconds
May 03 18:39:07 volumio volumio[779]: info: ------------------------------ 17ms
May 03 18:39:07 volumio volumio[779]: info: ------------------------------ 14ms
May 03 18:39:07 volumio volumio[779]: verbose: MPD COMMAND [object Object]
May 03 18:39:07 volumio volumio[779]: verbose: MPD COMMAND [object Object]
May 03 18:39:07 volumio volumio[779]: verbose: MPD COMMAND [object Object]
May 03 18:39:07 volumio volumio[779]: info:
May 03 18:39:07 volumio volumio[779]: ---------------------------- MPD announces system playlist update
May 03 18:39:07 volumio volumio[779]: info: Ignoring MPD Status Update
May 03 18:39:07 volumio volumio[779]: info:
May 03 18:39:07 volumio volumio[779]: ---------------------------- MPD announces system playlist update
May 03 18:39:07 volumio volumio[779]: info: Ignoring MPD Status Update
May 03 18:39:08 volumio volumio[779]: info:
May 03 18:39:08 volumio volumio[779]: ---------------------------- MPD announces system playlist update
May 03 18:39:08 volumio volumio[779]: info: Ignoring MPD Status Update
May 03 18:39:08 volumio volumio[779]: info: ------------------------------ 28ms
May 03 18:39:08 volumio volumio[779]: info: ------------------------------ 16ms
May 03 18:39:08 volumio volumio[779]: info: ------------------------------ 13ms
May 03 18:39:08 volumio volumio[779]: info: CoreStateMachine::setConsumeUpdateService mpd
May 03 18:39:08 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand play
May 03 18:39:08 volumio volumio[779]: info:
May 03 18:39:08 volumio volumio[779]: ---------------------------- MPD announces system playlist update
May 03 18:39:08 volumio volumio[779]: info: Ignoring MPD Status Update
May 03 18:39:08 volumio volumio[779]: info:
May 03 18:39:08 volumio volumio[779]: ---------------------------- MPD announces system playlist update
May 03 18:39:08 volumio volumio[779]: info: Ignoring MPD Status Update
May 03 18:39:08 volumio volumio[779]: info: ------------------------------ 25ms
May 03 18:39:08 volumio volumio[779]: info: sendMpdCommand play took 16 milliseconds
May 03 18:39:08 volumio volumio[779]: info: ------------------------------ 15ms
May 03 18:39:08 volumio volumio[779]: info: ------------------------------ 12ms
May 03 18:39:09 volumio volumio[779]: info:
May 03 18:39:09 volumio volumio[779]: ---------------------------- MPD announces state update: player
May 03 18:39:09 volumio volumio[779]: info: ControllerMpd::getState
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand status
May 03 18:39:09 volumio volumio[779]: info:
May 03 18:39:09 volumio volumio[779]: ---------------------------- MPD announces state update: player
May 03 18:39:09 volumio volumio[779]: info: ControllerMpd::getState
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand status
May 03 18:39:09 volumio volumio[779]: info:
May 03 18:39:09 volumio volumio[779]: ---------------------------- MPD announces state update: player
May 03 18:39:09 volumio volumio[779]: info: ControllerMpd::getState
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand status
May 03 18:39:09 volumio volumio[779]: info: sendMpdCommand status took 10 milliseconds
May 03 18:39:09 volumio volumio[779]: info: sendMpdCommand status took 6 milliseconds
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::parseState
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::parseState
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 03 18:39:09 volumio volumio[779]: info:
May 03 18:39:09 volumio volumio[779]: ---------------------------- MPD announces state update: player
May 03 18:39:09 volumio volumio[779]: info: ControllerMpd::getState
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand status
May 03 18:39:09 volumio volumio[779]: info:
May 03 18:39:09 volumio volumio[779]: ---------------------------- MPD announces state update: player
May 03 18:39:09 volumio volumio[779]: info: ControllerMpd::getState
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand status
May 03 18:39:09 volumio volumio[779]: info: sendMpdCommand status took 19 milliseconds
May 03 18:39:09 volumio volumio[779]: info: sendMpdCommand playlistinfo took 16 milliseconds
May 03 18:39:09 volumio volumio[779]: info: sendMpdCommand playlistinfo took 15 milliseconds
May 03 18:39:09 volumio volumio[779]: info: sendMpdCommand status took 11 milliseconds
May 03 18:39:09 volumio volumio[779]: info: sendMpdCommand status took 8 milliseconds
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::parseState
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::parseTrackInfo
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::parseTrackInfo
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::parseState
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::parseState
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 03 18:39:09 volumio volumio[779]: info: ControllerMpd::pushState
May 03 18:39:09 volumio volumio[779]: info: CoreCommandRouter::servicePushState
May 03 18:39:09 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:09 volumio volumio[779]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":191,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Piazza Grande (Live)","artist":"Lucio Dalla & Francesco De Gregori","album":"duvudubà","uri":"https://rr2---sn-25glenlz.googlevideo.com/videoplayback?expire=1714775945&ei=KRM1ZurIM5P6vdIP9PCXwAQ&ip=90.90.3.24&id=o-ABSb_NYqQs78zIp7y4YmCyy0CehLCdpjmkdrJXZfsZ1A&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W2&mm=31%2C29&mn=sn-25glenlz%2Csn-25ge7nsd&ms=au%2Crdu&mv=m&mvi=2&pl=16&gcr=fr&initcwndbps=1582500&bui=AWRWj2Q2Kpamlw9PoZQumuUoaHHw16UwwtarlA3zCi0yIq9gDwVWU-sKLogqd-jb7CiENIMRGZle4RmY&spc=UWF9f4VGWQkQgJwaySEeRVj3qkn25YnqMX2xTfiRkGIZS5I&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Nww_IrpwRqJM0uGUG6LWHjUQ&gir=yes&clen=3417928&dur=191.201&lmt=1565960786871994&mt=1714753762&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2311222&n=jvDkBAev25clNg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIgTTmg6sE6MAIa_B8JnIexaxJnHfVNtN78r8PDQyrQ1cACIQCsB0ZY0iDlzLqGgZ4vaAI_bUNNRJhmP1-0Gzqsq-u3bQ%3D%3D&sig=AJfQdSswRgIhANkx9Ein2jwftdy7vSkSCbrysgY50Y9OJJQStC7U95_1AiEA0dhRjrVoobomVsy9hCbgp7KTX2cNQOGHaGhx8Uv18Es%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"}
May 03 18:39:09 volumio volumio[779]: verbose: CURRENT POSITION 2
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::syncState stateService play
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::syncState currentStatus stop
May 03 18:39:09 volumio volumio[779]: info: ControllerMpd::pushState
May 03 18:39:09 volumio volumio[779]: info: CoreCommandRouter::servicePushState
May 03 18:39:09 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:09 volumio volumio[779]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":191,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Piazza Grande (Live)","artist":"Lucio Dalla & Francesco De Gregori","album":"duvudubà","uri":"https://rr2---sn-25glenlz.googlevideo.com/videoplayback?expire=1714775945&ei=KRM1ZurIM5P6vdIP9PCXwAQ&ip=90.90.3.24&id=o-ABSb_NYqQs78zIp7y4YmCyy0CehLCdpjmkdrJXZfsZ1A&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W2&mm=31%2C29&mn=sn-25glenlz%2Csn-25ge7nsd&ms=au%2Crdu&mv=m&mvi=2&pl=16&gcr=fr&initcwndbps=1582500&bui=AWRWj2Q2Kpamlw9PoZQumuUoaHHw16UwwtarlA3zCi0yIq9gDwVWU-sKLogqd-jb7CiENIMRGZle4RmY&spc=UWF9f4VGWQkQgJwaySEeRVj3qkn25YnqMX2xTfiRkGIZS5I&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Nww_IrpwRqJM0uGUG6LWHjUQ&gir=yes&clen=3417928&dur=191.201&lmt=1565960786871994&mt=1714753762&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2311222&n=jvDkBAev25clNg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIgTTmg6sE6MAIa_B8JnIexaxJnHfVNtN78r8PDQyrQ1cACIQCsB0ZY0iDlzLqGgZ4vaAI_bUNNRJhmP1-0Gzqsq-u3bQ%3D%3D&sig=AJfQdSswRgIhANkx9Ein2jwftdy7vSkSCbrysgY50Y9OJJQStC7U95_1AiEA0dhRjrVoobomVsy9hCbgp7KTX2cNQOGHaGhx8Uv18Es%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"}
May 03 18:39:09 volumio volumio[779]: verbose: CURRENT POSITION 2
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::syncState stateService play
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::syncState currentStatus play
May 03 18:39:09 volumio volumio[779]: info: Received an update from plugin. extracting info from payload
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:09 volumio volumio[779]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 18:39:09 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:09 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:09 volumio volumio[779]: info: ------------------------------ 79ms
May 03 18:39:09 volumio volumio[779]: info: ------------------------------ 83ms
May 03 18:39:09 volumio volumio[779]: info:
May 03 18:39:09 volumio volumio[779]: ---------------------------- MPD announces state update: player
May 03 18:39:09 volumio volumio[779]: info: ControllerMpd::getState
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand status
May 03 18:39:09 volumio volumio[779]: info: sendMpdCommand playlistinfo took 57 milliseconds
May 03 18:39:09 volumio volumio[779]: info: sendMpdCommand playlistinfo took 51 milliseconds
May 03 18:39:09 volumio volumio[779]: info: sendMpdCommand playlistinfo took 50 milliseconds
May 03 18:39:09 volumio volumio[779]: info: sendMpdCommand status took 6 milliseconds
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::parseTrackInfo
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::parseTrackInfo
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::parseTrackInfo
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::parseState
May 03 18:39:09 volumio volumio[779]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 03 18:39:09 volumio volumio[779]: info: ControllerMpd::pushState
May 03 18:39:09 volumio volumio[779]: info: CoreCommandRouter::servicePushState
May 03 18:39:09 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:09 volumio volumio[779]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":191,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Piazza Grande (Live)","artist":"Lucio Dalla & Francesco De Gregori","album":"duvudubà","uri":"https://rr2---sn-25glenlz.googlevideo.com/videoplayback?expire=1714775945&ei=KRM1ZurIM5P6vdIP9PCXwAQ&ip=90.90.3.24&id=o-ABSb_NYqQs78zIp7y4YmCyy0CehLCdpjmkdrJXZfsZ1A&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W2&mm=31%2C29&mn=sn-25glenlz%2Csn-25ge7nsd&ms=au%2Crdu&mv=m&mvi=2&pl=16&gcr=fr&initcwndbps=1582500&bui=AWRWj2Q2Kpamlw9PoZQumuUoaHHw16UwwtarlA3zCi0yIq9gDwVWU-sKLogqd-jb7CiENIMRGZle4RmY&spc=UWF9f4VGWQkQgJwaySEeRVj3qkn25YnqMX2xTfiRkGIZS5I&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Nww_IrpwRqJM0uGUG6LWHjUQ&gir=yes&clen=3417928&dur=191.201&lmt=1565960786871994&mt=1714753762&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2311222&n=jvDkBAev25clNg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIgTTmg6sE6MAIa_B8JnIexaxJnHfVNtN78r8PDQyrQ1cACIQCsB0ZY0iDlzLqGgZ4vaAI_bUNNRJhmP1-0Gzqsq-u3bQ%3D%3D&sig=AJfQdSswRgIhANkx9Ein2jwftdy7vSkSCbrysgY50Y9OJJQStC7U95_1AiEA0dhRjrVoobomVsy9hCbgp7KTX2cNQOGHaGhx8Uv18Es%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"}
May 03 18:39:09 volumio volumio[779]: verbose: CURRENT POSITION 2
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::syncState stateService play
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::syncState currentStatus play
May 03 18:39:09 volumio volumio[779]: info: Received an update from plugin. extracting info from payload
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:09 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:09 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:09 volumio volumio[779]: info: ControllerMpd::pushState
May 03 18:39:09 volumio volumio[779]: info: CoreCommandRouter::servicePushState
May 03 18:39:09 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:09 volumio volumio[779]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":191,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Piazza Grande (Live)","artist":"Lucio Dalla & Francesco De Gregori","album":"duvudubà","uri":"https://rr2---sn-25glenlz.googlevideo.com/videoplayback?expire=1714775945&ei=KRM1ZurIM5P6vdIP9PCXwAQ&ip=90.90.3.24&id=o-ABSb_NYqQs78zIp7y4YmCyy0CehLCdpjmkdrJXZfsZ1A&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W2&mm=31%2C29&mn=sn-25glenlz%2Csn-25ge7nsd&ms=au%2Crdu&mv=m&mvi=2&pl=16&gcr=fr&initcwndbps=1582500&bui=AWRWj2Q2Kpamlw9PoZQumuUoaHHw16UwwtarlA3zCi0yIq9gDwVWU-sKLogqd-jb7CiENIMRGZle4RmY&spc=UWF9f4VGWQkQgJwaySEeRVj3qkn25YnqMX2xTfiRkGIZS5I&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Nww_IrpwRqJM0uGUG6LWHjUQ&gir=yes&clen=3417928&dur=191.201&lmt=1565960786871994&mt=1714753762&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2311222&n=jvDkBAev25clNg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIgTTmg6sE6MAIa_B8JnIexaxJnHfVNtN78r8PDQyrQ1cACIQCsB0ZY0iDlzLqGgZ4vaAI_bUNNRJhmP1-0Gzqsq-u3bQ%3D%3D&sig=AJfQdSswRgIhANkx9Ein2jwftdy7vSkSCbrysgY50Y9OJJQStC7U95_1AiEA0dhRjrVoobomVsy9hCbgp7KTX2cNQOGHaGhx8Uv18Es%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"}
May 03 18:39:09 volumio volumio[779]: verbose: CURRENT POSITION 2
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::syncState stateService play
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::syncState currentStatus play
May 03 18:39:09 volumio volumio[779]: info: Received an update from plugin. extracting info from payload
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:09 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:09 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:09 volumio volumio[779]: info: ControllerMpd::pushState
May 03 18:39:09 volumio volumio[779]: info: CoreCommandRouter::servicePushState
May 03 18:39:09 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:09 volumio volumio[779]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":191,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Piazza Grande (Live)","artist":"Lucio Dalla & Francesco De Gregori","album":"duvudubà","uri":"https://rr2---sn-25glenlz.googlevideo.com/videoplayback?expire=1714775945&ei=KRM1ZurIM5P6vdIP9PCXwAQ&ip=90.90.3.24&id=o-ABSb_NYqQs78zIp7y4YmCyy0CehLCdpjmkdrJXZfsZ1A&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W2&mm=31%2C29&mn=sn-25glenlz%2Csn-25ge7nsd&ms=au%2Crdu&mv=m&mvi=2&pl=16&gcr=fr&initcwndbps=1582500&bui=AWRWj2Q2Kpamlw9PoZQumuUoaHHw16UwwtarlA3zCi0yIq9gDwVWU-sKLogqd-jb7CiENIMRGZle4RmY&spc=UWF9f4VGWQkQgJwaySEeRVj3qkn25YnqMX2xTfiRkGIZS5I&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Nww_IrpwRqJM0uGUG6LWHjUQ&gir=yes&clen=3417928&dur=191.201&lmt=1565960786871994&mt=1714753762&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2311222&n=jvDkBAev25clNg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIgTTmg6sE6MAIa_B8JnIexaxJnHfVNtN78r8PDQyrQ1cACIQCsB0ZY0iDlzLqGgZ4vaAI_bUNNRJhmP1-0Gzqsq-u3bQ%3D%3D&sig=AJfQdSswRgIhANkx9Ein2jwftdy7vSkSCbrysgY50Y9OJJQStC7U95_1AiEA0dhRjrVoobomVsy9hCbgp7KTX2cNQOGHaGhx8Uv18Es%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"}
May 03 18:39:09 volumio volumio[779]: verbose: CURRENT POSITION 2
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::syncState stateService play
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::syncState currentStatus play
May 03 18:39:09 volumio volumio[779]: info: Received an update from plugin. extracting info from payload
May 03 18:39:09 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:09 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:10 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:10 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:10 volumio volumio[779]: info: ------------------------------ 178ms
May 03 18:39:10 volumio volumio[779]: info: ------------------------------ 169ms
May 03 18:39:10 volumio volumio[779]: info: ------------------------------ 168ms
May 03 18:39:10 volumio volumio[779]: info: sendMpdCommand playlistinfo took 103 milliseconds
May 03 18:39:10 volumio volumio[779]: verbose: ControllerMpd::parseTrackInfo
May 03 18:39:10 volumio volumio[779]: info: ControllerMpd::pushState
May 03 18:39:10 volumio volumio[779]: info: CoreCommandRouter::servicePushState
May 03 18:39:10 volumio volumio[779]: info: CorePlayQueue::getTrack 2
May 03 18:39:10 volumio volumio[779]: verbose: STATE SERVICE {"status":"play","position":0,"seek":988,"duration":191,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Piazza Grande (Live)","artist":"Lucio Dalla & Francesco De Gregori","album":"duvudubà","uri":"https://rr2---sn-25glenlz.googlevideo.com/videoplayback?expire=1714775945&ei=KRM1ZurIM5P6vdIP9PCXwAQ&ip=90.90.3.24&id=o-ABSb_NYqQs78zIp7y4YmCyy0CehLCdpjmkdrJXZfsZ1A&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W2&mm=31%2C29&mn=sn-25glenlz%2Csn-25ge7nsd&ms=au%2Crdu&mv=m&mvi=2&pl=16&gcr=fr&initcwndbps=1582500&bui=AWRWj2Q2Kpamlw9PoZQumuUoaHHw16UwwtarlA3zCi0yIq9gDwVWU-sKLogqd-jb7CiENIMRGZle4RmY&spc=UWF9f4VGWQkQgJwaySEeRVj3qkn25YnqMX2xTfiRkGIZS5I&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Nww_IrpwRqJM0uGUG6LWHjUQ&gir=yes&clen=3417928&dur=191.201&lmt=1565960786871994&mt=1714753762&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2311222&n=jvDkBAev25clNg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIgTTmg6sE6MAIa_B8JnIexaxJnHfVNtN78r8PDQyrQ1cACIQCsB0ZY0iDlzLqGgZ4vaAI_bUNNRJhmP1-0Gzqsq-u3bQ%3D%3D&sig=AJfQdSswRgIhANkx9Ein2jwftdy7vSkSCbrysgY50Y9OJJQStC7U95_1AiEA0dhRjrVoobomVsy9hCbgp7KTX2cNQOGHaGhx8Uv18Es%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"}
May 03 18:39:10 volumio volumio[779]: verbose: CURRENT POSITION 2
May 03 18:39:10 volumio volumio[779]: info: CoreStateMachine::syncState stateService play
May 03 18:39:10 volumio volumio[779]: info: CoreStateMachine::syncState currentStatus play
May 03 18:39:10 volumio volumio[779]: info: Received an update from plugin. extracting info from payload
May 03 18:39:10 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:10 volumio volumio[779]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 18:39:10 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:10 volumio volumio[779]: info: CoreStateMachine::pushState
May 03 18:39:10 volumio volumio[779]: info: CoreCommandRouter::volumioPushState
May 03 18:39:10 volumio volumio[779]: info: ------------------------------ 139ms
May 03 18:39:10 volumio volumio[779]: info: [LastFM] Current track has sufficient metadata: title (Piazza Grande (Live)) and artist (Lucio Dalla & Francesco De Gregori) passed on explicitly
May 03 18:39:13 volumio volumio[779]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 03 18:39:13 volumio volumio[779]: TypeError: Cannot read property '@' of null
May 03 18:39:13 volumio volumio[779]: at Object.callback (/data/plugins/user_interface/lastfm/node_modules/simple-lastfm/lib/index.js:342:14)
May 03 18:39:13 volumio volumio[779]: at /data/plugins/user_interface/lastfm/node_modules/simple-lastfm/lib/index.js:60:13
May 03 18:39:13 volumio volumio[779]: at Parser. (/data/plugins/user_interface/lastfm/node_modules/xml2js/lib/parser.js:304:18)
May 03 18:39:13 volumio volumio[779]: at Parser.emit (events.js:315:20)
May 03 18:39:13 volumio volumio[779]: at Parser.exports.Parser.Parser.parseString (/data/plugins/user_interface/lastfm/node_modules/xml2js/lib/parser.js:314:16)
May 03 18:39:13 volumio volumio[779]: at Parser.parseString (/data/plugins/user_interface/lastfm/node_modules/xml2js/lib/parser.js:5:59)
May 03 18:39:13 volumio volumio[779]: at IncomingMessage. (/data/plugins/user_interface/lastfm/node_modules/simple-lastfm/lib/index.js:58:14)
May 03 18:39:13 volumio volumio[779]: at IncomingMessage.emit (events.js:327:22)
May 03 18:39:13 volumio volumio[779]: at endReadableNT (internal/streams/readable.js:1327:12)
May 03 18:39:13 volumio volumio[779]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
May 03 18:39:13 volumio volumio[779]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 03 18:39:14 volumio sudo[1817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-03 18:38
May 03 18:39:14 volumio sudo[1817]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET"
VOLUMIO_VERSION="3.631"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"