Jul 08 16:41:00 volumio volumio[1292]: info: [youtube2] InnertubeLoader: obtaining po_token by visitorData... Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::volumioGetBrowseSources Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 08 16:41:01 volumio volumio[1292]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jul 08 16:41:01 volumio volumio[1292]: info: Completed starting MyVolumio Plugin Jul 08 16:41:01 volumio volumio[1292]: [Metrics] CommandRouter: 76s 232.91ms Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::volumiosetStartupVolume Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::Close All Modals sent Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::Close All Modals sent Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::volumioGetQueue Jul 08 16:41:01 volumio volumio[1292]: info: CoreStateMachine::getQueue Jul 08 16:41:01 volumio volumio[1292]: info: CorePlayQueue::getQueue Jul 08 16:41:01 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Jul 08 16:41:01 volumio volumio[1292]: info: [youtube2-browse] browseUri: youtube2 Jul 08 16:41:02 volumio volumio[1292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jul 08 16:41:02 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Jul 08 16:41:02 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 08 16:41:02 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 16:41:02 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 08 16:41:03 volumio volumio[1292]: info: CoreCommandRouter::volumioGetState Jul 08 16:41:03 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:06 volumio volumio[1292]: info: [youtube2] InnertubeLoader: obtained po_token (expires in 43200 seconds) Jul 08 16:41:06 volumio volumio[1292]: info: [youtube2] InnertubeLoader: re-create Innertube instance with po_token Jul 08 16:41:06 volumio volumio[1292]: info: [youtube2] InnertubeLoader: creating Innertube instance with po_token... Jul 08 16:41:24 volumio volumio[1292]: info: [youtube2] InnertubeLoader: going to refresh po_token in 43100 seconds Jul 08 16:41:25 volumio volumio[1292]: info: BOOT COMPLETED Jul 08 16:41:25 volumio volumio[1292]: info: CoreCommandRouter::volumioGetState Jul 08 16:41:25 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:25 volumio volumio[1292]: info: CoreCommandRouter::volumioPlay Jul 08 16:41:25 volumio volumio[1292]: info: CoreStateMachine::play index undefined Jul 08 16:41:25 volumio volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 08 16:41:25 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:25 volumio volumio[1292]: info: CoreStateMachine::startPlaybackTimer Jul 08 16:41:25 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:25 volumio volumio[1292]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Bg-An7TQBbI%22%2C%22playlistId%22%3A%22RDBg-An7TQBbI%22%2C%22params%22%3A%22OAHAAQG4BQE%253D%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22The%20Best%20of%20Verdi%20-150%20minutes%20of%20Classical%20Music%20.%20HQ%20Recording%22%2C%22artist%22%3A%22Classical%20Tunes%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FBg-An7TQBbI%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLB1zsdbwy_j2X1YxXJdPVMWE4qfvg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Bg-An7TQBbI%22%2C%22playlistId%22%3A%22RDBg-An7TQBbI%22%2C%22params%22%3A%22OAHAAQG4BQE%253D%22%7D%7D%7D Jul 08 16:41:25 volumio volumio[1292]: info: CoreCommandRouter::volumioSeek Jul 08 16:41:25 volumio volumio[1292]: info: CoreStateMachine::seek Jul 08 16:41:25 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:25 volumio volumio[1292]: info: TRACKBLOCK {"service":"youtube2","uri":"youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Bg-An7TQBbI%22%2C%22playlistId%22%3A%22RDBg-An7TQBbI%22%2C%22params%22%3A%22OAHAAQG4BQE%253D%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22The%20Best%20of%20Verdi%20-150%20minutes%20of%20Classical%20Music%20.%20HQ%20Recording%22%2C%22artist%22%3A%22Classical%20Tunes%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FBg-An7TQBbI%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLB1zsdbwy_j2X1YxXJdPVMWE4qfvg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Bg-An7TQBbI%22%2C%22playlistId%22%3A%22RDBg-An7TQBbI%22%2C%22params%22%3A%22OAHAAQG4BQE%253D%22%7D%7D%7D","albumart":"https://i.ytimg.com/vi/Bg-An7TQBbI/hq720.jpg?sqp=-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg==&rs=AOn4CLB1zsdbwy_j2X1YxXJdPVMWE4qfvg","artist":"Classical Tunes","album":"YouTube","name":"The Best of Verdi -150 minutes of Classical Music . HQ Recording","title":"The Best of Verdi -150 minutes of Classical Music . HQ Recording"} Jul 08 16:41:25 volumio volumio[1292]: info: CoreStateMachine::startPlaybackTimer Jul 08 16:41:25 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:26 volumio volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 08 16:41:26 volumio volumio[1292]: info: ControllerMpd::seek Jul 08 16:41:26 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:26 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:26 volumio volumio[1292]: info: Preload queue cleared Jul 08 16:41:26 volumio volumio[1292]: info: Preload queue cleared Jul 08 16:41:26 volumio volumio[1292]: info: Preload queue cleared Jul 08 16:41:26 volumio volumio[1292]: error: [2@0] {seek} Bad song index Jul 08 16:41:26 volumio volumio[1292]: warn: [youtube2] Error getting stream with default client in VideoModel.getInfo(Bg-An7TQBbI): No valid URL to decipher - retry with 'WEB_EMBEDDED' client. Jul 08 16:41:26 volumio volumio[1292]: warn: [youtube2] Error getting stream with default client in VideoModel.getInfo(Bg-An7TQBbI): No valid URL to decipher - retry with 'WEB_EMBEDDED' client. Jul 08 16:41:26 volumio volumio[1292]: warn: [youtube2] Error getting stream with default client in VideoModel.getInfo(Bg-An7TQBbI): No valid URL to decipher - retry with 'WEB_EMBEDDED' client. Jul 08 16:41:27 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand stop Jul 08 16:41:27 volumio volumio[1292]: info: CoreCommandRouter::volumioPlay Jul 08 16:41:27 volumio volumio[1292]: info: CoreStateMachine::play index undefined Jul 08 16:41:27 volumio volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 08 16:41:27 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:27 volumio volumio[1292]: info: CoreStateMachine::startPlaybackTimer Jul 08 16:41:27 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:27 volumio volumio[1292]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Bg-An7TQBbI%22%2C%22playlistId%22%3A%22RDBg-An7TQBbI%22%2C%22params%22%3A%22OAHAAQG4BQE%253D%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22The%20Best%20of%20Verdi%20-150%20minutes%20of%20Classical%20Music%20.%20HQ%20Recording%22%2C%22artist%22%3A%22Classical%20Tunes%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FBg-An7TQBbI%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLB1zsdbwy_j2X1YxXJdPVMWE4qfvg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Bg-An7TQBbI%22%2C%22playlistId%22%3A%22RDBg-An7TQBbI%22%2C%22params%22%3A%22OAHAAQG4BQE%253D%22%7D%7D%7D Jul 08 16:41:28 volumio volumio[1292]: info: sendMpdCommand stop took 69 milliseconds Jul 08 16:41:28 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand clear Jul 08 16:41:28 volumio volumio[1292]: info: Jul 08 16:41:28 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:28 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:28 volumio volumio[1292]: info: sendMpdCommand clear took 41 milliseconds Jul 08 16:41:28 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand addid "https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007287&ei=Fy5taJPeE7qfhcIPvdrSwQg&ip=85.219.48.243&id=o-AIeUkS60VpAm7t3EBANZs4cL0KZ1pKSrPb56MgIep6nB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985687%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5qzened&ms=au%2Crdu&mv=m&mvi=6&pcm2cms=yes&pl=21&rms=au%2Cau&initcwndbps=3010000&bui=AY1jyLMzptiyN6qkW7srSczN6AOvjIqe70T5xcUxixVM73MxlQ4gwoSDtgSNNssnd_9m_MVF2MTUfQfa&spc=l3OVKdk1EZNbkRZw-qcfc5b9ic0ZHCV7ERs3P4Ba54sUKPUoDNha6Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=BOMhA1J2jZVnNsGrbAbrUGIQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985205&fvip=5&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=xT_DnI8eJdIFkw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhALL1wkJUXasT43sVmTzPGObYwoCfMUhxbS84n0TJMf23AiBIfJQAstXiEKTJ4lyjGS6s_-IUzJ7HdMnu5MmWfoyMRg%3D%3D&sig=AJfQdSswRQIhAIjhTd0cCQ555N0LRiOKr1lMZ6saaP0QmdsVIQYL-d4rAiA-HIWBUyDWAojvIWWJEFlbeoiw9jR-BHhYY45SQijMSg%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube" Jul 08 16:41:28 volumio volumio[1292]: info: Jul 08 16:41:28 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:28 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:28 volumio volumio[1292]: info: Jul 08 16:41:28 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:28 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:28 volumio volumio[1292]: error: updateQueue error: null Jul 08 16:41:28 volumio volumio[1292]: info: Jul 08 16:41:28 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:28 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:28 volumio volumio[1292]: info: ------------------------------ 81ms Jul 08 16:41:28 volumio volumio[1292]: info: sendMpdCommand addid "https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007287&ei=Fy5taJPeE7qfhcIPvdrSwQg&ip=85.219.48.243&id=o-AIeUkS60VpAm7t3EBANZs4cL0KZ1pKSrPb56MgIep6nB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985687%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5qzened&ms=au%2Crdu&mv=m&mvi=6&pcm2cms=yes&pl=21&rms=au%2Cau&initcwndbps=3010000&bui=AY1jyLMzptiyN6qkW7srSczN6AOvjIqe70T5xcUxixVM73MxlQ4gwoSDtgSNNssnd_9m_MVF2MTUfQfa&spc=l3OVKdk1EZNbkRZw-qcfc5b9ic0ZHCV7ERs3P4Ba54sUKPUoDNha6Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=BOMhA1J2jZVnNsGrbAbrUGIQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985205&fvip=5&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=xT_DnI8eJdIFkw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhALL1wkJUXasT43sVmTzPGObYwoCfMUhxbS84n0TJMf23AiBIfJQAstXiEKTJ4lyjGS6s_-IUzJ7HdMnu5MmWfoyMRg%3D%3D&sig=AJfQdSswRQIhAIjhTd0cCQ555N0LRiOKr1lMZ6saaP0QmdsVIQYL-d4rAiA-HIWBUyDWAojvIWWJEFlbeoiw9jR-BHhYY45SQijMSg%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube" took 67 milliseconds Jul 08 16:41:28 volumio volumio[1292]: info: ------------------------------ 39ms Jul 08 16:41:28 volumio volumio[1292]: info: ------------------------------ 37ms Jul 08 16:41:28 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:28 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:28 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:28 volumio volumio[1292]: info: Jul 08 16:41:28 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:28 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:28 volumio volumio[1292]: info: Jul 08 16:41:28 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:28 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:28 volumio volumio[1292]: info: Jul 08 16:41:28 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:28 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:28 volumio volumio[1292]: info: ------------------------------ 72ms Jul 08 16:41:28 volumio volumio[1292]: info: ------------------------------ 27ms Jul 08 16:41:28 volumio volumio[1292]: info: ------------------------------ 26ms Jul 08 16:41:28 volumio volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 08 16:41:28 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand play Jul 08 16:41:28 volumio volumio[1292]: info: Jul 08 16:41:28 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:28 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:28 volumio volumio[1292]: info: Jul 08 16:41:28 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:28 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:28 volumio volumio[1292]: info: ------------------------------ 30ms Jul 08 16:41:28 volumio volumio[1292]: info: sendMpdCommand play took 8 milliseconds Jul 08 16:41:28 volumio volumio[1292]: info: ------------------------------ 34ms Jul 08 16:41:28 volumio volumio[1292]: info: ------------------------------ 32ms Jul 08 16:41:29 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand stop Jul 08 16:41:29 volumio volumio[1292]: info: CoreCommandRouter::volumioPlay Jul 08 16:41:29 volumio volumio[1292]: info: CoreStateMachine::play index undefined Jul 08 16:41:29 volumio volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 08 16:41:29 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:29 volumio volumio[1292]: info: CoreStateMachine::startPlaybackTimer Jul 08 16:41:29 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:29 volumio volumio[1292]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Bg-An7TQBbI%22%2C%22playlistId%22%3A%22RDBg-An7TQBbI%22%2C%22params%22%3A%22OAHAAQG4BQE%253D%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22The%20Best%20of%20Verdi%20-150%20minutes%20of%20Classical%20Music%20.%20HQ%20Recording%22%2C%22artist%22%3A%22Classical%20Tunes%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FBg-An7TQBbI%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLB1zsdbwy_j2X1YxXJdPVMWE4qfvg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Bg-An7TQBbI%22%2C%22playlistId%22%3A%22RDBg-An7TQBbI%22%2C%22params%22%3A%22OAHAAQG4BQE%253D%22%7D%7D%7D Jul 08 16:41:29 volumio volumio[1292]: info: Jul 08 16:41:29 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:29 volumio volumio[1292]: info: sendMpdCommand stop took 116 milliseconds Jul 08 16:41:29 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:29 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:29 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand clear Jul 08 16:41:29 volumio volumio[1292]: info: Jul 08 16:41:29 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:29 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:29 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:29 volumio volumio[1292]: info: Jul 08 16:41:29 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:29 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:29 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:29 volumio volumio[1292]: info: Jul 08 16:41:29 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:29 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:29 volumio volumio[1292]: info: sendMpdCommand status took 31 milliseconds Jul 08 16:41:29 volumio volumio[1292]: info: sendMpdCommand clear took 32 milliseconds Jul 08 16:41:29 volumio volumio[1292]: info: sendMpdCommand status took 22 milliseconds Jul 08 16:41:29 volumio volumio[1292]: info: sendMpdCommand status took 16 milliseconds Jul 08 16:41:29 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:29 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:29 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand addid "https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007287&ei=Fy5taKv3Hbqlp-oP3M3b4A8&ip=85.219.48.243&id=o-AHNYZG9I3DjvmWmIkq3xb059bMmHmWk3i3eb2Or6Yep_&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985687%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5qzened&ms=au%2Crdu&mv=m&mvi=6&pcm2cms=yes&pl=21&rms=au%2Cau&initcwndbps=2438750&bui=AY1jyLPMDdUiGObX1CBsnfnaIp_vnA8MytmRFlwl2mySGuAIjh2i_xATCzUxWVKduFp7SdRWMo3ZEjxE&spc=l3OVKXWdu90ZJHKk42MWLFGuKyogLRSYLwyyuPllMu8gp4rdSTDkeg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=nMnyEiD7tInV8A8VnW__YkAQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985446&fvip=5&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=0QgQoB5YEXzwtQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgE7jPDkCAFZgxQF6O3Yz84UYGlyjurI7t99UO_rTvgEACICWHOqv22hNcFVdOOpvjixlRPZVyKqs_ceu0gl7EBqIf&sig=AJfQdSswRQIhANe01LT931mh230OIjlmBl5jxKcCDPjNruqWEtRvoxksAiARqEaNtaDCR-EfH9GI-hw-UU3Po9ibOifYqORMCHiR1Q%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube" Jul 08 16:41:29 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:29 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:29 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:29 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:29 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:29 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:29 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 16:41:29 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:29 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:29 volumio volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Jul 08 16:41:29 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:29 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:29 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:29 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:29 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:29 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:29 volumio volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Jul 08 16:41:29 volumio volumio[1292]: info: ------------------------------ 130ms Jul 08 16:41:29 volumio volumio[1292]: info: ------------------------------ 124ms Jul 08 16:41:29 volumio volumio[1292]: info: Jul 08 16:41:29 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:29 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:29 volumio volumio[1292]: info: Jul 08 16:41:29 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:29 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:29 volumio volumio[1292]: error: updateQueue error: null Jul 08 16:41:29 volumio volumio[1292]: info: Jul 08 16:41:29 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:29 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:29 volumio volumio[1292]: info: ------------------------------ 136ms Jul 08 16:41:29 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 121 milliseconds Jul 08 16:41:29 volumio volumio[1292]: info: sendMpdCommand addid "https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007287&ei=Fy5taKv3Hbqlp-oP3M3b4A8&ip=85.219.48.243&id=o-AHNYZG9I3DjvmWmIkq3xb059bMmHmWk3i3eb2Or6Yep_&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985687%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5qzened&ms=au%2Crdu&mv=m&mvi=6&pcm2cms=yes&pl=21&rms=au%2Cau&initcwndbps=2438750&bui=AY1jyLPMDdUiGObX1CBsnfnaIp_vnA8MytmRFlwl2mySGuAIjh2i_xATCzUxWVKduFp7SdRWMo3ZEjxE&spc=l3OVKXWdu90ZJHKk42MWLFGuKyogLRSYLwyyuPllMu8gp4rdSTDkeg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=nMnyEiD7tInV8A8VnW__YkAQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985446&fvip=5&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=0QgQoB5YEXzwtQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgE7jPDkCAFZgxQF6O3Yz84UYGlyjurI7t99UO_rTvgEACICWHOqv22hNcFVdOOpvjixlRPZVyKqs_ceu0gl7EBqIf&sig=AJfQdSswRQIhANe01LT931mh230OIjlmBl5jxKcCDPjNruqWEtRvoxksAiARqEaNtaDCR-EfH9GI-hw-UU3Po9ibOifYqORMCHiR1Q%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube" took 121 milliseconds Jul 08 16:41:29 volumio volumio[1292]: info: ------------------------------ 28ms Jul 08 16:41:29 volumio volumio[1292]: info: ------------------------------ 19ms Jul 08 16:41:29 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:29 volumio volumio[1292]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jul 08 16:41:29 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:29 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:29 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:29 volumio volumio[1292]: info: ------------------------------ 198ms Jul 08 16:41:29 volumio volumio[1292]: info: Jul 08 16:41:29 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:29 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:29 volumio volumio[1292]: info: Jul 08 16:41:29 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:29 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:29 volumio volumio[1292]: info: Jul 08 16:41:29 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:29 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:29 volumio volumio[1292]: info: ------------------------------ 61ms Jul 08 16:41:29 volumio volumio[1292]: info: ------------------------------ 31ms Jul 08 16:41:29 volumio volumio[1292]: info: ------------------------------ 32ms Jul 08 16:41:29 volumio volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 08 16:41:29 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand play Jul 08 16:41:29 volumio volumio[1292]: info: Jul 08 16:41:29 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:29 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:29 volumio volumio[1292]: info: Jul 08 16:41:29 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:29 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:29 volumio volumio[1292]: info: ------------------------------ 67ms Jul 08 16:41:29 volumio volumio[1292]: info: sendMpdCommand play took 72 milliseconds Jul 08 16:41:29 volumio volumio[1292]: info: ------------------------------ 72ms Jul 08 16:41:29 volumio volumio[1292]: info: ------------------------------ 65ms Jul 08 16:41:30 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand stop Jul 08 16:41:30 volumio volumio[1292]: info: Jul 08 16:41:30 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:30 volumio volumio[1292]: info: sendMpdCommand stop took 158 milliseconds Jul 08 16:41:30 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:30 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:30 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand clear Jul 08 16:41:30 volumio volumio[1292]: info: Jul 08 16:41:30 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:30 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:30 volumio volumio[1292]: info: sendMpdCommand status took 29 milliseconds Jul 08 16:41:30 volumio volumio[1292]: info: sendMpdCommand clear took 28 milliseconds Jul 08 16:41:30 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:30 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:30 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand addid "https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007287&ei=Fy5taIzBIq7x6dsPy-fK8AU&ip=85.219.48.243&id=o-AMo99ys6XE779vODGslizqraGK3Fs0TjtJdNErLwpoyp&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985687%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5qzened&ms=au%2Crdu&mv=m&mvi=6&pl=21&rms=au%2Cau&initcwndbps=3010000&bui=AY1jyLO5w7OvWKwaL_5dhLHKWApFQPUhNElljxUux0ljziLWMH3Eoddx2BXFRAIC1l598ZAmWDFQoM97&spc=l3OVKdcDSAUOUMma1Kbo1bUk04UbRKeMi9Fcyas4r0lyEEd41T8tWw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=LVRXFMeFeaqvDUUflLlL-DwQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985205&fvip=5&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=BfB9s6iqzsz4nA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhALV9OZFGdPcQ_F-H11eHJHYrTjYKRdgP4PSAhQHNE0k2AiEAhYSpGTcNcruKobKOen6u32F7taff7Lta_g0kfbkqgGc%3D&sig=AJfQdSswRQIgUGBkL8LKenGe3Z5l9hjdnZRCXexXXo0EoQvwJ0zXBMICIQC0sWkrOCOFVgQX9MeCiZS0Jj9Ukkk1I3iemKFxPYSdGg%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube" Jul 08 16:41:30 volumio volumio[1292]: info: Jul 08 16:41:30 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:30 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:30 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:30 volumio volumio[1292]: info: Jul 08 16:41:30 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:30 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:30 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:30 volumio volumio[1292]: error: updateQueue error: null Jul 08 16:41:30 volumio volumio[1292]: info: Jul 08 16:41:30 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:30 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:30 volumio volumio[1292]: info: ------------------------------ 67ms Jul 08 16:41:30 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 51 milliseconds Jul 08 16:41:30 volumio volumio[1292]: info: sendMpdCommand addid "https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007287&ei=Fy5taIzBIq7x6dsPy-fK8AU&ip=85.219.48.243&id=o-AMo99ys6XE779vODGslizqraGK3Fs0TjtJdNErLwpoyp&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985687%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5qzened&ms=au%2Crdu&mv=m&mvi=6&pl=21&rms=au%2Cau&initcwndbps=3010000&bui=AY1jyLO5w7OvWKwaL_5dhLHKWApFQPUhNElljxUux0ljziLWMH3Eoddx2BXFRAIC1l598ZAmWDFQoM97&spc=l3OVKdcDSAUOUMma1Kbo1bUk04UbRKeMi9Fcyas4r0lyEEd41T8tWw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=LVRXFMeFeaqvDUUflLlL-DwQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985205&fvip=5&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=BfB9s6iqzsz4nA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhALV9OZFGdPcQ_F-H11eHJHYrTjYKRdgP4PSAhQHNE0k2AiEAhYSpGTcNcruKobKOen6u32F7taff7Lta_g0kfbkqgGc%3D&sig=AJfQdSswRQIgUGBkL8LKenGe3Z5l9hjdnZRCXexXXo0EoQvwJ0zXBMICIQC0sWkrOCOFVgQX9MeCiZS0Jj9Ukkk1I3iemKFxPYSdGg%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube" took 51 milliseconds Jul 08 16:41:30 volumio volumio[1292]: info: sendMpdCommand status took 37 milliseconds Jul 08 16:41:30 volumio volumio[1292]: info: sendMpdCommand status took 26 milliseconds Jul 08 16:41:30 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:30 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:30 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:30 volumio volumio[1292]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jul 08 16:41:30 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:30 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:30 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:31 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:31 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:31 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:31 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 16:41:31 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:31 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:31 volumio volumio[1292]: 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} Jul 08 16:41:31 volumio volumio[1292]: verbose: CURRENT POSITION 0 Jul 08 16:41:31 volumio volumio[1292]: info: CoreStateMachine::syncState stateService stop Jul 08 16:41:31 volumio volumio[1292]: info: CoreStateMachine::syncState currentStatus stop Jul 08 16:41:31 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:31 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:31 volumio volumio[1292]: info: No code Jul 08 16:41:31 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:31 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:31 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:31 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:31 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:31 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:31 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:31 volumio volumio[1292]: 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} Jul 08 16:41:31 volumio volumio[1292]: verbose: CURRENT POSITION 0 Jul 08 16:41:31 volumio volumio[1292]: info: CoreStateMachine::syncState stateService stop Jul 08 16:41:31 volumio volumio[1292]: info: CoreStateMachine::syncState currentStatus stop Jul 08 16:41:31 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:31 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:31 volumio volumio[1292]: info: No code Jul 08 16:41:31 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:31 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:31 volumio volumio[1292]: info: ------------------------------ 244ms Jul 08 16:41:31 volumio volumio[1292]: info: ------------------------------ 298ms Jul 08 16:41:31 volumio volumio[1292]: info: ------------------------------ 284ms Jul 08 16:41:31 volumio volumio[1292]: info: Jul 08 16:41:31 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:31 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:31 volumio volumio[1292]: info: Jul 08 16:41:31 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:31 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:31 volumio volumio[1292]: info: Jul 08 16:41:31 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:31 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:31 volumio volumio[1292]: info: ------------------------------ 288ms Jul 08 16:41:31 volumio volumio[1292]: info: ------------------------------ 29ms Jul 08 16:41:31 volumio volumio[1292]: info: ------------------------------ 21ms Jul 08 16:41:31 volumio volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 08 16:41:31 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand play Jul 08 16:41:31 volumio volumio[1292]: info: Jul 08 16:41:31 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:31 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:31 volumio volumio[1292]: info: Jul 08 16:41:31 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:31 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:31 volumio volumio[1292]: info: ------------------------------ 146ms Jul 08 16:41:31 volumio volumio[1292]: info: sendMpdCommand play took 151 milliseconds Jul 08 16:41:31 volumio volumio[1292]: info: ------------------------------ 136ms Jul 08 16:41:31 volumio volumio[1292]: info: ------------------------------ 132ms Jul 08 16:41:31 volumio volumio[1292]: warn: [youtube2] Error getting stream with default client in VideoModel.getInfo(Bg-An7TQBbI): No valid URL to decipher - retry with 'WEB_EMBEDDED' client. Jul 08 16:41:31 volumio volumio[1292]: warn: [youtube2] Error getting stream with default client in VideoModel.getInfo(Bg-An7TQBbI): No valid URL to decipher - retry with 'WEB_EMBEDDED' client. Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand stop Jul 08 16:41:32 volumio volumio[1292]: info: Jul 08 16:41:32 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:32 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:32 volumio volumio[1292]: info: Jul 08 16:41:32 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:32 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:32 volumio volumio[1292]: info: Jul 08 16:41:32 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:32 volumio volumio[1292]: info: Jul 08 16:41:32 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:32 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:32 volumio volumio[1292]: info: sendMpdCommand stop took 25 milliseconds Jul 08 16:41:32 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:32 volumio volumio[1292]: info: sendMpdCommand status took 24 milliseconds Jul 08 16:41:32 volumio volumio[1292]: info: sendMpdCommand status took 23 milliseconds Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand clear Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:32 volumio volumio[1292]: info: Jul 08 16:41:32 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:32 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:32 volumio volumio[1292]: info: Jul 08 16:41:32 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:32 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:32 volumio volumio[1292]: info: Jul 08 16:41:32 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:32 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:32 volumio volumio[1292]: info: sendMpdCommand status took 63 milliseconds Jul 08 16:41:32 volumio volumio[1292]: info: sendMpdCommand status took 43 milliseconds Jul 08 16:41:32 volumio volumio[1292]: info: sendMpdCommand clear took 38 milliseconds Jul 08 16:41:32 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 35 milliseconds Jul 08 16:41:32 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 35 milliseconds Jul 08 16:41:32 volumio volumio[1292]: info: sendMpdCommand status took 23 milliseconds Jul 08 16:41:32 volumio volumio[1292]: info: sendMpdCommand status took 19 milliseconds Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand addid "https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007292&ei=HC5taPTXL4uC9fgPvqPxyAY&ip=85.219.48.243&id=o-AIV98xAA8F20HEl-cTDvQHgOfy6bq5WRoS4sDDAMPIqC&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985692%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5q7knel&ms=au%2Crdu&mv=m&mvi=6&pl=21&rms=au%2Cau&initcwndbps=3010000&bui=AY1jyLOS7HSGyveq1TTPHzOoPnf1IDeZLjvVcZUQ5pvu1yxYpvNThKJa7mVvSvIemqwfjl50W_Y8EEV3&spc=l3OVKc0HHhn7Ah8397bWGNiKF3cJGl13m4O4PGrYVDmMZiftUexY6g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=QuPJVkaevzCl8esuhvSqQbsQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985205&fvip=1&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=ty68U-zLq-tPeA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAOIvO1uUAfC5LEKfQp8pcoUo1-agw8DroqczGD-Wnz1HAiEA3bN8ZTMoec1BmpD5UagtChE08xZu9dkTo1lSMiCwSlg%3D&sig=AJfQdSswRQIgGVSQQrMciTJGF22q5gqvS83_8AESqrXaACIL8zKIoiwCIQC8ZvXEaH4nCLndo2x3YalhDxn7ORj8u4mN3qQBJMq2-w%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube" Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:32 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:33 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:33 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:33 volumio volumio[1292]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jul 08 16:41:33 volumio volumio[1292]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jul 08 16:41:33 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:33 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:33 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:33 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 16:41:33 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:33 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:33 volumio volumio[1292]: 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} Jul 08 16:41:33 volumio volumio[1292]: verbose: CURRENT POSITION 0 Jul 08 16:41:33 volumio volumio[1292]: info: CoreStateMachine::syncState stateService stop Jul 08 16:41:33 volumio volumio[1292]: info: CoreStateMachine::syncState currentStatus stop Jul 08 16:41:33 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:33 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:33 volumio volumio[1292]: info: No code Jul 08 16:41:33 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:33 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:33 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:33 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:33 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:33 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:33 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:33 volumio volumio[1292]: 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} Jul 08 16:41:33 volumio volumio[1292]: verbose: CURRENT POSITION 0 Jul 08 16:41:33 volumio volumio[1292]: info: CoreStateMachine::syncState stateService stop Jul 08 16:41:33 volumio volumio[1292]: info: CoreStateMachine::syncState currentStatus stop Jul 08 16:41:33 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:33 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:33 volumio volumio[1292]: info: No code Jul 08 16:41:33 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:33 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:33 volumio volumio[1292]: info: ------------------------------ 167ms Jul 08 16:41:33 volumio volumio[1292]: info: ------------------------------ 165ms Jul 08 16:41:33 volumio volumio[1292]: info: ------------------------------ 156ms Jul 08 16:41:33 volumio volumio[1292]: info: ------------------------------ 149ms Jul 08 16:41:33 volumio volumio[1292]: info: Jul 08 16:41:33 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:33 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:33 volumio volumio[1292]: info: Jul 08 16:41:33 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:33 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:33 volumio volumio[1292]: error: updateQueue error: null Jul 08 16:41:33 volumio volumio[1292]: info: Jul 08 16:41:33 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:33 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:33 volumio volumio[1292]: info: ------------------------------ 171ms Jul 08 16:41:33 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 153 milliseconds Jul 08 16:41:33 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 149 milliseconds Jul 08 16:41:33 volumio volumio[1292]: info: sendMpdCommand addid "https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007292&ei=HC5taPTXL4uC9fgPvqPxyAY&ip=85.219.48.243&id=o-AIV98xAA8F20HEl-cTDvQHgOfy6bq5WRoS4sDDAMPIqC&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985692%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5q7knel&ms=au%2Crdu&mv=m&mvi=6&pl=21&rms=au%2Cau&initcwndbps=3010000&bui=AY1jyLOS7HSGyveq1TTPHzOoPnf1IDeZLjvVcZUQ5pvu1yxYpvNThKJa7mVvSvIemqwfjl50W_Y8EEV3&spc=l3OVKc0HHhn7Ah8397bWGNiKF3cJGl13m4O4PGrYVDmMZiftUexY6g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=QuPJVkaevzCl8esuhvSqQbsQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985205&fvip=1&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=ty68U-zLq-tPeA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAOIvO1uUAfC5LEKfQp8pcoUo1-agw8DroqczGD-Wnz1HAiEA3bN8ZTMoec1BmpD5UagtChE08xZu9dkTo1lSMiCwSlg%3D&sig=AJfQdSswRQIgGVSQQrMciTJGF22q5gqvS83_8AESqrXaACIL8zKIoiwCIQC8ZvXEaH4nCLndo2x3YalhDxn7ORj8u4mN3qQBJMq2-w%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube" took 146 milliseconds Jul 08 16:41:33 volumio volumio[1292]: info: ------------------------------ 11ms Jul 08 16:41:33 volumio volumio[1292]: info: ------------------------------ 9ms Jul 08 16:41:33 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:33 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:33 volumio volumio[1292]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jul 08 16:41:33 volumio volumio[1292]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jul 08 16:41:33 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:33 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:33 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:33 volumio volumio[1292]: info: ------------------------------ 249ms Jul 08 16:41:33 volumio volumio[1292]: info: ------------------------------ 249ms Jul 08 16:41:33 volumio volumio[1292]: info: Jul 08 16:41:33 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:33 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:33 volumio volumio[1292]: info: Jul 08 16:41:33 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:33 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:33 volumio volumio[1292]: info: Jul 08 16:41:33 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:33 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:33 volumio volumio[1292]: info: ------------------------------ 97ms Jul 08 16:41:33 volumio volumio[1292]: info: ------------------------------ 15ms Jul 08 16:41:33 volumio volumio[1292]: info: ------------------------------ 7ms Jul 08 16:41:33 volumio volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 08 16:41:33 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand play Jul 08 16:41:33 volumio volumio[1292]: info: Jul 08 16:41:33 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:33 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:33 volumio volumio[1292]: info: Jul 08 16:41:33 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:33 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:33 volumio volumio[1292]: info: ------------------------------ 19ms Jul 08 16:41:33 volumio volumio[1292]: info: sendMpdCommand play took 12 milliseconds Jul 08 16:41:33 volumio volumio[1292]: info: ------------------------------ 11ms Jul 08 16:41:33 volumio volumio[1292]: info: ------------------------------ 9ms Jul 08 16:41:34 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand stop Jul 08 16:41:34 volumio volumio[1292]: info: Jul 08 16:41:34 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:34 volumio volumio[1292]: info: sendMpdCommand stop took 30 milliseconds Jul 08 16:41:34 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:34 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:34 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand clear Jul 08 16:41:34 volumio volumio[1292]: info: Jul 08 16:41:34 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:34 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:34 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:34 volumio volumio[1292]: info: Jul 08 16:41:34 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:34 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:34 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:34 volumio volumio[1292]: info: Jul 08 16:41:34 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:34 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:34 volumio volumio[1292]: info: sendMpdCommand status took 16 milliseconds Jul 08 16:41:34 volumio volumio[1292]: info: sendMpdCommand clear took 16 milliseconds Jul 08 16:41:34 volumio volumio[1292]: info: sendMpdCommand status took 12 milliseconds Jul 08 16:41:34 volumio volumio[1292]: info: sendMpdCommand status took 7 milliseconds Jul 08 16:41:34 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:34 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:34 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand addid "https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007292&ei=HC5taLPxNceQp-oPqavhqA4&ip=85.219.48.243&id=o-AHgRI-TqV1N9BaULxVix9_39V_-Y5mSyjR0D_s0kwuRG&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985692%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5q7knel&ms=au%2Crdu&mv=m&mvi=6&pl=21&rms=au%2Cau&initcwndbps=3010000&bui=AY1jyLNXPoKkDlIqrKuKNOmM598cbga-MHbRS3P-4Otx-gjjs92ySq6s88sjCKNBazDFrcDoZyJ6lKOt&spc=l3OVKfu9Pn7ScsSDwE_j9ar2mnJ-UiLA66fQRkHsrE9JDLsw-w142Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=-sdUcoTKkFcQGBBomlTjgsQQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985205&fvip=1&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=90LBXY7WduslKQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgb1J1EFXY-8l-UfcCnawpzNeZuDU8qylKXY3_V4_8ES8CIAegKmwuvmfsQg1Vsk__fZ8eK9uuAQytQv_yCYFJxu71&sig=AJfQdSswRgIhAMayOm8fRolWgbPtu7bkWmPL49mjzPlnEHhfpXEL9eHMAiEAtv_utxq2kO7IgcwKYvP8_gblDGHtl_hAHANJhpov1QA%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube" Jul 08 16:41:34 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:34 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:34 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:34 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:34 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:34 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 16:41:34 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:34 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:34 volumio volumio[1292]: 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} Jul 08 16:41:34 volumio volumio[1292]: verbose: CURRENT POSITION 0 Jul 08 16:41:34 volumio volumio[1292]: info: CoreStateMachine::syncState stateService stop Jul 08 16:41:34 volumio volumio[1292]: info: CoreStateMachine::syncState currentStatus stop Jul 08 16:41:34 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:34 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:34 volumio volumio[1292]: info: No code Jul 08 16:41:34 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:34 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:34 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:34 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:34 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:34 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:34 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:34 volumio volumio[1292]: 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} Jul 08 16:41:34 volumio volumio[1292]: verbose: CURRENT POSITION 0 Jul 08 16:41:34 volumio volumio[1292]: info: CoreStateMachine::syncState stateService stop Jul 08 16:41:34 volumio volumio[1292]: info: CoreStateMachine::syncState currentStatus stop Jul 08 16:41:34 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:34 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:34 volumio volumio[1292]: info: No code Jul 08 16:41:34 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:34 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:34 volumio volumio[1292]: info: ------------------------------ 110ms Jul 08 16:41:34 volumio volumio[1292]: info: ------------------------------ 106ms Jul 08 16:41:34 volumio volumio[1292]: info: Jul 08 16:41:34 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:34 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:34 volumio volumio[1292]: info: Jul 08 16:41:34 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:34 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:34 volumio volumio[1292]: error: updateQueue error: null Jul 08 16:41:34 volumio volumio[1292]: info: Jul 08 16:41:34 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:34 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:34 volumio volumio[1292]: info: ------------------------------ 110ms Jul 08 16:41:34 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 100 milliseconds Jul 08 16:41:34 volumio volumio[1292]: info: sendMpdCommand addid "https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007292&ei=HC5taLPxNceQp-oPqavhqA4&ip=85.219.48.243&id=o-AHgRI-TqV1N9BaULxVix9_39V_-Y5mSyjR0D_s0kwuRG&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985692%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5q7knel&ms=au%2Crdu&mv=m&mvi=6&pl=21&rms=au%2Cau&initcwndbps=3010000&bui=AY1jyLNXPoKkDlIqrKuKNOmM598cbga-MHbRS3P-4Otx-gjjs92ySq6s88sjCKNBazDFrcDoZyJ6lKOt&spc=l3OVKfu9Pn7ScsSDwE_j9ar2mnJ-UiLA66fQRkHsrE9JDLsw-w142Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=-sdUcoTKkFcQGBBomlTjgsQQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985205&fvip=1&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=90LBXY7WduslKQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgb1J1EFXY-8l-UfcCnawpzNeZuDU8qylKXY3_V4_8ES8CIAegKmwuvmfsQg1Vsk__fZ8eK9uuAQytQv_yCYFJxu71&sig=AJfQdSswRgIhAMayOm8fRolWgbPtu7bkWmPL49mjzPlnEHhfpXEL9eHMAiEAtv_utxq2kO7IgcwKYvP8_gblDGHtl_hAHANJhpov1QA%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube" took 100 milliseconds Jul 08 16:41:34 volumio volumio[1292]: info: ------------------------------ 8ms Jul 08 16:41:34 volumio volumio[1292]: info: ------------------------------ 5ms Jul 08 16:41:34 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:34 volumio volumio[1292]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jul 08 16:41:34 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:34 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:34 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:34 volumio volumio[1292]: info: ------------------------------ 157ms Jul 08 16:41:34 volumio volumio[1292]: info: Jul 08 16:41:34 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:34 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:34 volumio volumio[1292]: info: Jul 08 16:41:34 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:34 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:34 volumio volumio[1292]: info: Jul 08 16:41:34 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:34 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:34 volumio volumio[1292]: info: ------------------------------ 93ms Jul 08 16:41:34 volumio volumio[1292]: info: ------------------------------ 70ms Jul 08 16:41:34 volumio volumio[1292]: info: ------------------------------ 66ms Jul 08 16:41:34 volumio volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 08 16:41:34 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand play Jul 08 16:41:34 volumio volumio[1292]: info: Jul 08 16:41:34 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:34 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:34 volumio volumio[1292]: info: Jul 08 16:41:34 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:34 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:34 volumio volumio[1292]: info: CoreCommandRouter::volumioSeek Jul 08 16:41:34 volumio volumio[1292]: info: CoreStateMachine::seek Jul 08 16:41:34 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:34 volumio volumio[1292]: info: TRACKBLOCK {"service":"youtube2","uri":"youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Bg-An7TQBbI%22%2C%22playlistId%22%3A%22RDBg-An7TQBbI%22%2C%22params%22%3A%22OAHAAQG4BQE%253D%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22The%20Best%20of%20Verdi%20-150%20minutes%20of%20Classical%20Music%20.%20HQ%20Recording%22%2C%22artist%22%3A%22Classical%20Tunes%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FBg-An7TQBbI%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLB1zsdbwy_j2X1YxXJdPVMWE4qfvg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Bg-An7TQBbI%22%2C%22playlistId%22%3A%22RDBg-An7TQBbI%22%2C%22params%22%3A%22OAHAAQG4BQE%253D%22%7D%7D%7D","albumart":"https://i.ytimg.com/vi_webp/Bg-An7TQBbI/maxresdefault.webp","artist":"Classical Tunes","album":"YouTube","name":"The Best of Verdi -150 minutes of Classical Music . HQ Recording","title":"The Best of Verdi -150 minutes of Classical Music . HQ Recording","duration":9183,"samplerate":"160 kbps"} Jul 08 16:41:34 volumio volumio[1292]: info: CoreStateMachine::startPlaybackTimer Jul 08 16:41:34 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:34 volumio volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 08 16:41:34 volumio volumio[1292]: info: ControllerMpd::seek Jul 08 16:41:34 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:34 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 16:41:34 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:34 volumio volumio[1292]: info: ------------------------------ 82ms Jul 08 16:41:34 volumio volumio[1292]: info: sendMpdCommand play took 80 milliseconds Jul 08 16:41:34 volumio volumio[1292]: info: ------------------------------ 62ms Jul 08 16:41:34 volumio volumio[1292]: info: ------------------------------ 66ms Jul 08 16:41:35 volumio volumio[1292]: info: CoreCommandRouter::volumioPlay Jul 08 16:41:35 volumio volumio[1292]: info: CoreStateMachine::play index undefined Jul 08 16:41:35 volumio volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 08 16:41:35 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:35 volumio volumio[1292]: info: CoreStateMachine::startPlaybackTimer Jul 08 16:41:35 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:35 volumio volumio[1292]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Bg-An7TQBbI%22%2C%22playlistId%22%3A%22RDBg-An7TQBbI%22%2C%22params%22%3A%22OAHAAQG4BQE%253D%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22The%20Best%20of%20Verdi%20-150%20minutes%20of%20Classical%20Music%20.%20HQ%20Recording%22%2C%22artist%22%3A%22Classical%20Tunes%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FBg-An7TQBbI%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLB1zsdbwy_j2X1YxXJdPVMWE4qfvg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Bg-An7TQBbI%22%2C%22playlistId%22%3A%22RDBg-An7TQBbI%22%2C%22params%22%3A%22OAHAAQG4BQE%253D%22%7D%7D%7D Jul 08 16:41:35 volumio volumio[1292]: error: null Jul 08 16:41:35 volumio volumio[1292]: info: Jul 08 16:41:35 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:35 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:35 volumio volumio[1292]: info: Jul 08 16:41:35 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:35 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:35 volumio volumio[1292]: info: Jul 08 16:41:35 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:35 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:35 volumio volumio[1292]: info: Jul 08 16:41:35 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:35 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:35 volumio volumio[1292]: info: sendMpdCommand status took 31 milliseconds Jul 08 16:41:35 volumio volumio[1292]: info: sendMpdCommand status took 23 milliseconds Jul 08 16:41:35 volumio volumio[1292]: info: sendMpdCommand status took 16 milliseconds Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:35 volumio volumio[1292]: info: Jul 08 16:41:35 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:35 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:35 volumio volumio[1292]: info: Jul 08 16:41:35 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:35 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:35 volumio volumio[1292]: info: sendMpdCommand status took 33 milliseconds Jul 08 16:41:35 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 24 milliseconds Jul 08 16:41:35 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 27 milliseconds Jul 08 16:41:35 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 23 milliseconds Jul 08 16:41:35 volumio volumio[1292]: info: sendMpdCommand status took 17 milliseconds Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:35 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:35 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:35 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:35 volumio volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Jul 08 16:41:35 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:35 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:35 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:35 volumio volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Jul 08 16:41:35 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:35 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:35 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:35 volumio volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Jul 08 16:41:35 volumio volumio[1292]: info: ------------------------------ 107ms Jul 08 16:41:35 volumio volumio[1292]: info: ------------------------------ 102ms Jul 08 16:41:35 volumio volumio[1292]: info: ------------------------------ 92ms Jul 08 16:41:35 volumio volumio[1292]: info: sendMpdCommand status took 43 milliseconds Jul 08 16:41:35 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 32 milliseconds Jul 08 16:41:35 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 22 milliseconds Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:35 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:35 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:35 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:35 volumio volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Jul 08 16:41:35 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:35 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:35 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:35 volumio volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Jul 08 16:41:35 volumio volumio[1292]: info: ------------------------------ 108ms Jul 08 16:41:35 volumio volumio[1292]: info: ------------------------------ 82ms Jul 08 16:41:35 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 08 16:41:35 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:35 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:35 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:35 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:35 volumio volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Jul 08 16:41:35 volumio volumio[1292]: info: ------------------------------ 88ms Jul 08 16:41:36 volumio volumio[1292]: warn: [youtube2] Error getting stream with default client in VideoModel.getInfo(Bg-An7TQBbI): No valid URL to decipher - retry with 'WEB_EMBEDDED' client. Jul 08 16:41:37 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:37 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand stop Jul 08 16:41:37 volumio volumio[1292]: info: Jul 08 16:41:37 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:37 volumio volumio[1292]: info: sendMpdCommand stop took 26 milliseconds Jul 08 16:41:37 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:37 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:37 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand clear Jul 08 16:41:37 volumio volumio[1292]: info: Jul 08 16:41:37 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:37 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:37 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:37 volumio volumio[1292]: info: Jul 08 16:41:37 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:37 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:37 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:37 volumio volumio[1292]: info: Jul 08 16:41:37 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:37 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:37 volumio volumio[1292]: info: sendMpdCommand status took 5 milliseconds Jul 08 16:41:37 volumio volumio[1292]: info: sendMpdCommand clear took 5 milliseconds Jul 08 16:41:37 volumio volumio[1292]: info: sendMpdCommand status took 4 milliseconds Jul 08 16:41:37 volumio volumio[1292]: info: sendMpdCommand status took 4 milliseconds Jul 08 16:41:37 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:37 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:37 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand addid "https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007297&ei=IS5taKXoIeuri9oP4-WJuQQ&ip=85.219.48.243&id=o-ABLZIojAy2undu4kp86uPV7so_1sfXcquQSzm6D2-jfW&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985697%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5q7knel&ms=au%2Crdu&mv=m&mvi=6&pl=21&rms=au%2Cau&initcwndbps=2438750&bui=AY1jyLOoJdE_McnLGPKIS-Lf8Xrxwf4bwm48ufM_U-T4NxUxlEKZfRSfzpRty8ww5MLf8L3wQXvF6kpy&spc=l3OVKVJSmTKY8rvRCWlVQVztmzmumeppGYH-v6Y3wU2zMyJKuh_DiA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=u5UVvSG18at-REuHBkmeCwoQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985446&fvip=1&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=yBOmySnhcLL7QA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgPxZV2QR9g3HUnGF666FGnDxizQzcCDlHmVmYQx8IsTYCICZGLXWU4sCBf-UFmPi1hFj6M6a6F49mr54B-rGaSoXX&sig=AJfQdSswRQIhAI2S8kQycXGq5OsH4K7idP9fEnvDkjBz-zTRLs0fkW5wAiBxyedE9vfmpDgVEGJMmKj2nQ1btuQ8wN3Job4CSBEnEQ%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube" Jul 08 16:41:37 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:37 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:37 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:37 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:37 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:37 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:37 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 16:41:37 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:37 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:37 volumio volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Jul 08 16:41:37 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:37 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:37 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:37 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:37 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:37 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:37 volumio volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Jul 08 16:41:37 volumio volumio[1292]: info: ------------------------------ 75ms Jul 08 16:41:37 volumio volumio[1292]: info: ------------------------------ 77ms Jul 08 16:41:37 volumio volumio[1292]: info: Jul 08 16:41:37 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:37 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:37 volumio volumio[1292]: info: Jul 08 16:41:37 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:37 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:37 volumio volumio[1292]: error: updateQueue error: null Jul 08 16:41:37 volumio volumio[1292]: info: Jul 08 16:41:37 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:37 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:37 volumio volumio[1292]: info: ------------------------------ 86ms Jul 08 16:41:37 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 84 milliseconds Jul 08 16:41:37 volumio volumio[1292]: info: sendMpdCommand addid "https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007297&ei=IS5taKXoIeuri9oP4-WJuQQ&ip=85.219.48.243&id=o-ABLZIojAy2undu4kp86uPV7so_1sfXcquQSzm6D2-jfW&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985697%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5q7knel&ms=au%2Crdu&mv=m&mvi=6&pl=21&rms=au%2Cau&initcwndbps=2438750&bui=AY1jyLOoJdE_McnLGPKIS-Lf8Xrxwf4bwm48ufM_U-T4NxUxlEKZfRSfzpRty8ww5MLf8L3wQXvF6kpy&spc=l3OVKVJSmTKY8rvRCWlVQVztmzmumeppGYH-v6Y3wU2zMyJKuh_DiA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=u5UVvSG18at-REuHBkmeCwoQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985446&fvip=1&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=yBOmySnhcLL7QA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgPxZV2QR9g3HUnGF666FGnDxizQzcCDlHmVmYQx8IsTYCICZGLXWU4sCBf-UFmPi1hFj6M6a6F49mr54B-rGaSoXX&sig=AJfQdSswRQIhAI2S8kQycXGq5OsH4K7idP9fEnvDkjBz-zTRLs0fkW5wAiBxyedE9vfmpDgVEGJMmKj2nQ1btuQ8wN3Job4CSBEnEQ%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube" took 84 milliseconds Jul 08 16:41:37 volumio volumio[1292]: info: ------------------------------ 9ms Jul 08 16:41:37 volumio volumio[1292]: info: ------------------------------ 6ms Jul 08 16:41:37 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:37 volumio volumio[1292]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jul 08 16:41:37 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:37 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:37 volumio volumio[1292]: verbose: MPD COMMAND [object Object] Jul 08 16:41:37 volumio volumio[1292]: info: ------------------------------ 94ms Jul 08 16:41:37 volumio volumio[1292]: info: Jul 08 16:41:37 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:37 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:37 volumio volumio[1292]: info: Jul 08 16:41:37 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:37 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:37 volumio volumio[1292]: info: Jul 08 16:41:37 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:37 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:37 volumio volumio[1292]: info: ------------------------------ 70ms Jul 08 16:41:37 volumio volumio[1292]: info: ------------------------------ 65ms Jul 08 16:41:37 volumio volumio[1292]: info: ------------------------------ 65ms Jul 08 16:41:37 volumio volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 08 16:41:37 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand play Jul 08 16:41:37 volumio volumio[1292]: info: Jul 08 16:41:37 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:37 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:37 volumio volumio[1292]: info: Jul 08 16:41:37 volumio volumio[1292]: ---------------------------- MPD announces system playlist update Jul 08 16:41:37 volumio volumio[1292]: info: Ignoring MPD Status Update Jul 08 16:41:37 volumio volumio[1292]: info: ------------------------------ 7ms Jul 08 16:41:37 volumio volumio[1292]: info: sendMpdCommand play took 5 milliseconds Jul 08 16:41:37 volumio volumio[1292]: info: ------------------------------ 5ms Jul 08 16:41:37 volumio volumio[1292]: info: ------------------------------ 4ms Jul 08 16:41:38 volumio volumio[1292]: info: Jul 08 16:41:38 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:38 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:38 volumio volumio[1292]: info: Jul 08 16:41:38 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:38 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:38 volumio volumio[1292]: info: Jul 08 16:41:38 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:38 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:38 volumio volumio[1292]: info: sendMpdCommand status took 23 milliseconds Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:38 volumio volumio[1292]: info: Jul 08 16:41:38 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:38 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:38 volumio volumio[1292]: info: Jul 08 16:41:38 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:38 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:38 volumio volumio[1292]: info: sendMpdCommand status took 26 milliseconds Jul 08 16:41:38 volumio volumio[1292]: info: sendMpdCommand status took 22 milliseconds Jul 08 16:41:38 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 08 16:41:38 volumio volumio[1292]: info: sendMpdCommand status took 5 milliseconds Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:38 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:38 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:38 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:38 volumio volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":9183,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Best of Verdi -150 minutes of Classical Music . HQ Recording","artist":"Classical Tunes","album":"YouTube","uri":"https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007297&ei=IS5taKXoIeuri9oP4-WJuQQ&ip=85.219.48.243&id=o-ABLZIojAy2undu4kp86uPV7so_1sfXcquQSzm6D2-jfW&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985697%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5q7knel&ms=au%2Crdu&mv=m&mvi=6&pl=21&rms=au%2Cau&initcwndbps=2438750&bui=AY1jyLOoJdE_McnLGPKIS-Lf8Xrxwf4bwm48ufM_U-T4NxUxlEKZfRSfzpRty8ww5MLf8L3wQXvF6kpy&spc=l3OVKVJSmTKY8rvRCWlVQVztmzmumeppGYH-v6Y3wU2zMyJKuh_DiA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=u5UVvSG18at-REuHBkmeCwoQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985446&fvip=1&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=yBOmySnhcLL7QA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgPxZV2QR9g3HUnGF666FGnDxizQzcCDlHmVmYQx8IsTYCICZGLXWU4sCBf-UFmPi1hFj6M6a6F49mr54B-rGaSoXX&sig=AJfQdSswRQIhAI2S8kQycXGq5OsH4K7idP9fEnvDkjBz-zTRLs0fkW5wAiBxyedE9vfmpDgVEGJMmKj2nQ1btuQ8wN3Job4CSBEnEQ%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jul 08 16:41:38 volumio volumio[1292]: verbose: CURRENT POSITION 0 Jul 08 16:41:38 volumio volumio[1292]: info: CoreStateMachine::syncState stateService play Jul 08 16:41:38 volumio volumio[1292]: info: CoreStateMachine::syncState currentStatus stop Jul 08 16:41:38 volumio volumio[1292]: info: ------------------------------ 64ms Jul 08 16:41:38 volumio volumio[1292]: info: Jul 08 16:41:38 volumio volumio[1292]: ---------------------------- MPD announces state update: player Jul 08 16:41:38 volumio volumio[1292]: info: ControllerMpd::getState Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jul 08 16:41:38 volumio volumio[1292]: info: sendMpdCommand status took 48 milliseconds Jul 08 16:41:38 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 46 milliseconds Jul 08 16:41:38 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 46 milliseconds Jul 08 16:41:38 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 45 milliseconds Jul 08 16:41:38 volumio volumio[1292]: info: sendMpdCommand status took 3 milliseconds Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::parseState Jul 08 16:41:38 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 16:41:38 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:38 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:38 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:38 volumio volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":9183,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Best of Verdi -150 minutes of Classical Music . HQ Recording","artist":"Classical Tunes","album":"YouTube","uri":"https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007297&ei=IS5taKXoIeuri9oP4-WJuQQ&ip=85.219.48.243&id=o-ABLZIojAy2undu4kp86uPV7so_1sfXcquQSzm6D2-jfW&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985697%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5q7knel&ms=au%2Crdu&mv=m&mvi=6&pl=21&rms=au%2Cau&initcwndbps=2438750&bui=AY1jyLOoJdE_McnLGPKIS-Lf8Xrxwf4bwm48ufM_U-T4NxUxlEKZfRSfzpRty8ww5MLf8L3wQXvF6kpy&spc=l3OVKVJSmTKY8rvRCWlVQVztmzmumeppGYH-v6Y3wU2zMyJKuh_DiA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=u5UVvSG18at-REuHBkmeCwoQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985446&fvip=1&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=yBOmySnhcLL7QA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgPxZV2QR9g3HUnGF666FGnDxizQzcCDlHmVmYQx8IsTYCICZGLXWU4sCBf-UFmPi1hFj6M6a6F49mr54B-rGaSoXX&sig=AJfQdSswRQIhAI2S8kQycXGq5OsH4K7idP9fEnvDkjBz-zTRLs0fkW5wAiBxyedE9vfmpDgVEGJMmKj2nQ1btuQ8wN3Job4CSBEnEQ%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jul 08 16:41:38 volumio volumio[1292]: verbose: CURRENT POSITION 0 Jul 08 16:41:38 volumio volumio[1292]: info: CoreStateMachine::syncState stateService play Jul 08 16:41:38 volumio volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jul 08 16:41:38 volumio volumio[1292]: info: Received an update from plugin. extracting info from payload Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:39 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:39 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:39 volumio volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":9183,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Best of Verdi -150 minutes of Classical Music . HQ Recording","artist":"Classical Tunes","album":"YouTube","uri":"https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007297&ei=IS5taKXoIeuri9oP4-WJuQQ&ip=85.219.48.243&id=o-ABLZIojAy2undu4kp86uPV7so_1sfXcquQSzm6D2-jfW&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985697%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5q7knel&ms=au%2Crdu&mv=m&mvi=6&pl=21&rms=au%2Cau&initcwndbps=2438750&bui=AY1jyLOoJdE_McnLGPKIS-Lf8Xrxwf4bwm48ufM_U-T4NxUxlEKZfRSfzpRty8ww5MLf8L3wQXvF6kpy&spc=l3OVKVJSmTKY8rvRCWlVQVztmzmumeppGYH-v6Y3wU2zMyJKuh_DiA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=u5UVvSG18at-REuHBkmeCwoQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985446&fvip=1&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=yBOmySnhcLL7QA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgPxZV2QR9g3HUnGF666FGnDxizQzcCDlHmVmYQx8IsTYCICZGLXWU4sCBf-UFmPi1hFj6M6a6F49mr54B-rGaSoXX&sig=AJfQdSswRQIhAI2S8kQycXGq5OsH4K7idP9fEnvDkjBz-zTRLs0fkW5wAiBxyedE9vfmpDgVEGJMmKj2nQ1btuQ8wN3Job4CSBEnEQ%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jul 08 16:41:39 volumio volumio[1292]: verbose: CURRENT POSITION 0 Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::syncState stateService play Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jul 08 16:41:39 volumio volumio[1292]: info: Received an update from plugin. extracting info from payload Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:39 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:39 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:39 volumio volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":9183,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Best of Verdi -150 minutes of Classical Music . HQ Recording","artist":"Classical Tunes","album":"YouTube","uri":"https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007297&ei=IS5taKXoIeuri9oP4-WJuQQ&ip=85.219.48.243&id=o-ABLZIojAy2undu4kp86uPV7so_1sfXcquQSzm6D2-jfW&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985697%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5q7knel&ms=au%2Crdu&mv=m&mvi=6&pl=21&rms=au%2Cau&initcwndbps=2438750&bui=AY1jyLOoJdE_McnLGPKIS-Lf8Xrxwf4bwm48ufM_U-T4NxUxlEKZfRSfzpRty8ww5MLf8L3wQXvF6kpy&spc=l3OVKVJSmTKY8rvRCWlVQVztmzmumeppGYH-v6Y3wU2zMyJKuh_DiA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=u5UVvSG18at-REuHBkmeCwoQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985446&fvip=1&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=yBOmySnhcLL7QA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgPxZV2QR9g3HUnGF666FGnDxizQzcCDlHmVmYQx8IsTYCICZGLXWU4sCBf-UFmPi1hFj6M6a6F49mr54B-rGaSoXX&sig=AJfQdSswRQIhAI2S8kQycXGq5OsH4K7idP9fEnvDkjBz-zTRLs0fkW5wAiBxyedE9vfmpDgVEGJMmKj2nQ1btuQ8wN3Job4CSBEnEQ%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jul 08 16:41:39 volumio volumio[1292]: verbose: CURRENT POSITION 0 Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::syncState stateService play Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jul 08 16:41:39 volumio volumio[1292]: info: Received an update from plugin. extracting info from payload Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:39 volumio volumio[1292]: info: ------------------------------ 324ms Jul 08 16:41:39 volumio volumio[1292]: info: ------------------------------ 319ms Jul 08 16:41:39 volumio volumio[1292]: info: ------------------------------ 301ms Jul 08 16:41:39 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 249 milliseconds Jul 08 16:41:39 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 248 milliseconds Jul 08 16:41:39 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:39 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jul 08 16:41:39 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:39 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:39 volumio volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":9183,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Best of Verdi -150 minutes of Classical Music . HQ Recording","artist":"Classical Tunes","album":"YouTube","uri":"https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007297&ei=IS5taKXoIeuri9oP4-WJuQQ&ip=85.219.48.243&id=o-ABLZIojAy2undu4kp86uPV7so_1sfXcquQSzm6D2-jfW&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985697%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5q7knel&ms=au%2Crdu&mv=m&mvi=6&pl=21&rms=au%2Cau&initcwndbps=2438750&bui=AY1jyLOoJdE_McnLGPKIS-Lf8Xrxwf4bwm48ufM_U-T4NxUxlEKZfRSfzpRty8ww5MLf8L3wQXvF6kpy&spc=l3OVKVJSmTKY8rvRCWlVQVztmzmumeppGYH-v6Y3wU2zMyJKuh_DiA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=u5UVvSG18at-REuHBkmeCwoQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985446&fvip=1&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=yBOmySnhcLL7QA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgPxZV2QR9g3HUnGF666FGnDxizQzcCDlHmVmYQx8IsTYCICZGLXWU4sCBf-UFmPi1hFj6M6a6F49mr54B-rGaSoXX&sig=AJfQdSswRQIhAI2S8kQycXGq5OsH4K7idP9fEnvDkjBz-zTRLs0fkW5wAiBxyedE9vfmpDgVEGJMmKj2nQ1btuQ8wN3Job4CSBEnEQ%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jul 08 16:41:39 volumio volumio[1292]: verbose: CURRENT POSITION 0 Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::syncState stateService play Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jul 08 16:41:39 volumio volumio[1292]: info: Received an update from plugin. extracting info from payload Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:39 volumio volumio[1292]: info: ControllerMpd::pushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Jul 08 16:41:39 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Jul 08 16:41:39 volumio volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":996,"duration":9183,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Best of Verdi -150 minutes of Classical Music . HQ Recording","artist":"Classical Tunes","album":"YouTube","uri":"https://rr6---sn-8vq54voxn25po-h5qz.googlevideo.com/videoplayback?expire=1752007297&ei=IS5taKXoIeuri9oP4-WJuQQ&ip=85.219.48.243&id=o-ABLZIojAy2undu4kp86uPV7so_1sfXcquQSzm6D2-jfW&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751985697%2C&mh=on&mm=31%2C29&mn=sn-8vq54voxn25po-h5qz%2Csn-h5q7knel&ms=au%2Crdu&mv=m&mvi=6&pl=21&rms=au%2Cau&initcwndbps=2438750&bui=AY1jyLOoJdE_McnLGPKIS-Lf8Xrxwf4bwm48ufM_U-T4NxUxlEKZfRSfzpRty8ww5MLf8L3wQXvF6kpy&spc=l3OVKVJSmTKY8rvRCWlVQVztmzmumeppGYH-v6Y3wU2zMyJKuh_DiA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=u5UVvSG18at-REuHBkmeCwoQ&rqh=1&gir=yes&clen=151547957&dur=9183.061&lmt=1738161566355823&mt=1751985446&fvip=1&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=yBOmySnhcLL7QA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgPxZV2QR9g3HUnGF666FGnDxizQzcCDlHmVmYQx8IsTYCICZGLXWU4sCBf-UFmPi1hFj6M6a6F49mr54B-rGaSoXX&sig=AJfQdSswRQIhAI2S8kQycXGq5OsH4K7idP9fEnvDkjBz-zTRLs0fkW5wAiBxyedE9vfmpDgVEGJMmKj2nQ1btuQ8wN3Job4CSBEnEQ%3D%3D&pot=MpgB3eM_pVb0glTd37YpY0xibnc0mGb5T6pysB_w-7ARYNdnkMr2_71bJZDej0VgV2tbIjOPi6vtzHJ79iyr2nkgqcvQ0V2iZGBhhWMCumhbQuoYCeWGzcpu8Yv_-Va7aNwy0iRhYQzEs2mNhklU-mEqBYS9UyyhsVepNd4mZSudB4fKNuuO-ipKMIexZH-VFr4_KO_ih8U6uFk%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jul 08 16:41:39 volumio volumio[1292]: verbose: CURRENT POSITION 0 Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::syncState stateService play Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jul 08 16:41:39 volumio volumio[1292]: info: Received an update from plugin. extracting info from payload Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreStateMachine::pushState Jul 08 16:41:39 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Jul 08 16:41:39 volumio volumio[1292]: info: ------------------------------ 490ms Jul 08 16:41:39 volumio volumio[1292]: info: ------------------------------ 455ms Jul 08 16:41:51 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jul 08 16:41:51 volumio dbus-daemon[602]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.28' (uid=0 pid=1891 comm="timedatectl show --property=NTPSynchronized --valu") Jul 08 16:41:51 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jul 08 16:41:51 volumio dbus-daemon[602]: [system] Successfully activated service 'org.freedesktop.timedate1' Jul 08 16:41:51 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jul 08 16:41:51 volumio setdatetime-helper.sh[1890]: Time is not synchronized. Attempting to sync... Jul 08 16:41:51 volumio sudo[1899]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Tue, 08 Jul 2025 14:41:52 GMT#015' Jul 08 16:41:51 volumio sudo[1899]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jul 08 16:41:52 volumio setdatetime-helper.sh[1900]: Tue Jul 8 16:41:52 CEST 2025 Jul 08 16:41:52 volumio sudo[1899]: pam_unix(sudo:session): session closed for user root Jul 08 16:41:52 volumio setdatetime-helper.sh[1890]: Time synchronized successfully. Jul 08 16:41:52 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jul 08 16:41:52 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jul 08 16:41:53 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 08 16:41:53 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 08 16:41:53 volumio volumio[1292]: info: Preload queue cleared Jul 08 16:42:21 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Jul 08 16:42:53 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 08 16:42:53 volumio volumio[1292]: info: READ Jul 08 16:42:53 volumio volumio[1292]: Use XMLElement.setAttribute instead Jul 08 16:42:53 volumio volumio[1292]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 08 16:42:53 volumio volumio[1292]: TypeError: children[i].attr(...).value is not a function Jul 08 16:42:53 volumio volumio[1292]: at /volumio/app/plugins/music_service/webradio/index.js:286:47 Jul 08 16:42:53 volumio volumio[1292]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jul 08 16:42:53 volumio volumio[1292]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 08 16:42:57 volumio sudo[2124]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-07-08 16:41' Jul 08 16:42:57 volumio sudo[2124]: 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="4a70cb031e64a8e498efc3e29470650871ff7d54" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat May 31 04:09:10 UTC 2025" VOLUMIO_VERSION="4.005" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="f9bd4447a30d4b2c74b3880e7a50e48b"