Jul 05 11:56:03 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:56:03 volumio-2 volumio[1046]: info: Listing playlists Jul 05 11:56:03 volumio-2 volumio[1046]: info: Listing playlists Jul 05 11:56:04 volumio-2 volumio[1046]: info: Discovery: Remote connection error: 192.168.88.191 Jul 05 11:56:06 volumio-2 nmbd[878]: [2025/07/05 11:56:06.436572, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jul 05 11:56:06 volumio-2 nmbd[878]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.88.184 for name WORKGROUP<1d>. Jul 05 11:56:06 volumio-2 nmbd[878]: This response was from IP 192.168.88.30, reporting an IP address of 192.168.88.30. Jul 05 11:56:11 volumio-2 systemd[1]: systemd-timedated.service: Deactivated successfully. Jul 05 11:56:12 volumio-2 volumio[1046]: info: Discovery: Remote connection error: 192.168.88.191 Jul 05 11:56:12 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:56:15 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 11:56:15 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 11:56:15 volumio-2 volumio[1046]: info: Discovery: Getting this device information Jul 05 11:56:15 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:56:15 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 11:56:16 volumio-2 volumio[1046]: verbose: New Socket.io Connection to 192.168.88.184:3000 from 192.168.88.124 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Jul 05 11:56:16 volumio-2 volumio[1046]: verbose: New Socket.io Connection to 192.168.88.184:3000 from 192.168.88.124 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Jul 05 11:56:20 volumio-2 volumio[1046]: info: Discovery: Remote connection error: 192.168.88.191 Jul 05 11:56:22 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:56:22 volumio-2 volumio[1046]: info: Listing playlists Jul 05 11:56:22 volumio-2 volumio[1046]: info: Listing playlists Jul 05 11:56:27 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 11:56:27 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 11:56:27 volumio-2 volumio[1046]: info: Discovery: Getting this device information Jul 05 11:56:27 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:56:27 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 11:56:28 volumio-2 volumio[1046]: info: Discovery: Remote connection error: 192.168.88.191 Jul 05 11:56:32 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:56:36 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 11:56:36 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 11:56:36 volumio-2 volumio[1046]: info: Discovery: Getting this device information Jul 05 11:56:36 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:56:36 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 11:56:37 volumio-2 volumio[1046]: info: Discovery: Remote connection error: 192.168.88.191 Jul 05 11:56:42 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:56:42 volumio-2 volumio[1046]: info: Listing playlists Jul 05 11:56:42 volumio-2 volumio[1046]: info: Listing playlists Jul 05 11:56:45 volumio-2 volumio[1046]: info: Discovery: Remote connection error: 192.168.88.191 Jul 05 11:56:47 volumio-2 volumio[1046]: verbose: New Socket.io Connection to 192.168.88.184 from 192.168.88.124 UA: Mozilla/5.0 (Linux; Android 15; SM-A556B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.63 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jul 05 11:56:47 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:56:47 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 05 11:56:47 volumio-2 volumio[1046]: info: Listing playlists Jul 05 11:56:47 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetQueue Jul 05 11:56:47 volumio-2 volumio[1046]: info: CoreStateMachine::getQueue Jul 05 11:56:47 volumio-2 volumio[1046]: info: CorePlayQueue::getQueue Jul 05 11:56:47 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetVisibleSources Jul 05 11:56:47 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPlay Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreStateMachine::play index 0 Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreStateMachine::stop Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreStateMachine::stPlaybackTimer Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreStateMachine::updateTrackBlock Jul 05 11:56:52 volumio-2 volumio[1046]: info: CorePlayQueue::getTrackBlock Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:56:52 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 3 Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreStateMachine::serviceStop Jul 05 11:56:52 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 3 Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreCommandRouter::serviceStop Jul 05 11:56:52 volumio-2 volumio[1046]: info: [1751709412501] ControllerWebradio::stop Jul 05 11:56:52 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 11:56:52 volumio-2 volumio[1046]: info: Jul 05 11:56:52 volumio-2 volumio[1046]: ---------------------------- MPD announces state update: player Jul 05 11:56:52 volumio-2 volumio[1046]: info: sendMpdCommand stop took 25 milliseconds Jul 05 11:56:52 volumio-2 volumio[1046]: info: ControllerMpd::getState Jul 05 11:56:52 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreStateMachine::play index undefined Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:56:52 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreStateMachine::startPlaybackTimer Jul 05 11:56:52 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:56:52 volumio-2 volumio[1046]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22Le%20migliori%20canzoni%20di%20Zucchero%20-%20Il%20Meglio%20dei%20Zucchero%20album%20completo%20-%20Zucchero%20live%22%2C%22artist%22%3A%22italian%20musical%20song%22%2C%22album%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FM746dEbrsIk%2Fsddefault.jpg%3Fsqp%3D-oaymwEWCJADEOEBIAQqCghqEJQEGHgg6AJIWg%26rs%3DAMzJL3mtRC8WAaDhg0P6A2M6pcp1ixG3yw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22M746dEbrsIk%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_UGC%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22M746dEbrsIk%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_UGC%22%7D%7D%7D Jul 05 11:56:52 volumio-2 volumio[1046]: info: [ytmusic] InnertubeLoader: creating Innertube instance... Jul 05 11:56:52 volumio-2 volumio[1046]: info: sendMpdCommand status took 104 milliseconds Jul 05 11:56:52 volumio-2 volumio[1046]: verbose: ControllerMpd::parseState Jul 05 11:56:52 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:56:52 volumio-2 volumio[1046]: info: Jul 05 11:56:52 volumio-2 volumio[1046]: ---------------------------- MPD announces state update: player Jul 05 11:56:52 volumio-2 volumio[1046]: info: ControllerMpd::getState Jul 05 11:56:52 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:56:52 volumio-2 volumio[1046]: info: Jul 05 11:56:52 volumio-2 volumio[1046]: ---------------------------- MPD announces state update: player Jul 05 11:56:52 volumio-2 volumio[1046]: info: ControllerMpd::getState Jul 05 11:56:52 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:56:52 volumio-2 volumio[1046]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 05 11:56:52 volumio-2 volumio[1046]: info: sendMpdCommand status took 4 milliseconds Jul 05 11:56:52 volumio-2 volumio[1046]: info: sendMpdCommand status took 3 milliseconds Jul 05 11:56:52 volumio-2 volumio[1046]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:56:52 volumio-2 volumio[1046]: verbose: ControllerMpd::parseState Jul 05 11:56:52 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:56:52 volumio-2 volumio[1046]: verbose: ControllerMpd::parseState Jul 05 11:56:52 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:56:52 volumio-2 volumio[1046]: info: ControllerMpd::pushState Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreCommandRouter::servicePushState Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:56:52 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:56:52 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:56:52 volumio-2 volumio[1046]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd Jul 05 11:56:52 volumio-2 volumio[1046]: info: ------------------------------ 135ms Jul 05 11:56:52 volumio-2 volumio[1046]: info: sendMpdCommand playlistinfo took 23 milliseconds Jul 05 11:56:52 volumio-2 volumio[1046]: info: sendMpdCommand playlistinfo took 23 milliseconds Jul 05 11:56:52 volumio-2 volumio[1046]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:56:52 volumio-2 volumio[1046]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:56:52 volumio-2 volumio[1046]: info: ControllerMpd::pushState Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreCommandRouter::servicePushState Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:56:52 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:56:52 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:56:52 volumio-2 volumio[1046]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd Jul 05 11:56:52 volumio-2 volumio[1046]: info: ControllerMpd::pushState Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreCommandRouter::servicePushState Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:56:52 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:56:52 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:56:52 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:56:52 volumio-2 volumio[1046]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd Jul 05 11:56:52 volumio-2 volumio[1046]: info: ------------------------------ 68ms Jul 05 11:56:52 volumio-2 volumio[1046]: info: ------------------------------ 68ms Jul 05 11:56:53 volumio-2 volumio[1046]: info: Discovery: Remote connection error: 192.168.88.191 Jul 05 11:56:54 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:56:54 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:56:57 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPlay Jul 05 11:56:57 volumio-2 volumio[1046]: info: CoreStateMachine::play index undefined Jul 05 11:56:57 volumio-2 volumio[1046]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 11:56:57 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:56:57 volumio-2 volumio[1046]: info: CoreStateMachine::startPlaybackTimer Jul 05 11:56:57 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:56:57 volumio-2 volumio[1046]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22Le%20migliori%20canzoni%20di%20Zucchero%20-%20Il%20Meglio%20dei%20Zucchero%20album%20completo%20-%20Zucchero%20live%22%2C%22artist%22%3A%22italian%20musical%20song%22%2C%22album%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FM746dEbrsIk%2Fsddefault.jpg%3Fsqp%3D-oaymwEWCJADEOEBIAQqCghqEJQEGHgg6AJIWg%26rs%3DAMzJL3mtRC8WAaDhg0P6A2M6pcp1ixG3yw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22M746dEbrsIk%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_UGC%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22M746dEbrsIk%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_UGC%22%7D%7D%7D Jul 05 11:57:01 volumio-2 volumio[1046]: info: Discovery: Remote connection error: 192.168.88.191 Jul 05 11:57:03 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:57:03 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:57:03 volumio-2 volumio[1046]: info: Listing playlists Jul 05 11:57:03 volumio-2 volumio[1046]: info: Listing playlists Jul 05 11:57:09 volumio-2 volumio[1046]: info: Discovery: Remote connection error: 192.168.88.191 Jul 05 11:57:17 volumio-2 volumio[1046]: info: [ytmusic] InnertubeLoader: obtaining po_token by visitorData... Jul 05 11:57:17 volumio-2 systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jul 05 11:57:17 volumio-2 dbus-daemon[493]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.77' (uid=0 pid=10102 comm="timedatectl show --property=NTPSynchronized --valu") Jul 05 11:57:17 volumio-2 systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jul 05 11:57:17 volumio-2 dbus-daemon[493]: [system] Successfully activated service 'org.freedesktop.timedate1' Jul 05 11:57:17 volumio-2 systemd[1]: Started systemd-timedated.service - Time & Date Service. Jul 05 11:57:17 volumio-2 setdatetime-helper.sh[10101]: Time is already synchronized. Jul 05 11:57:17 volumio-2 systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jul 05 11:57:17 volumio-2 systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jul 05 11:57:17 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:57:17 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:57:20 volumio-2 volumio[1046]: info: Discovery: Remote connection error: 192.168.88.191 Jul 05 11:57:22 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:57:22 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:57:22 volumio-2 volumio[1046]: info: [ytmusic] InnertubeLoader: obtained po_token (expires in 43200 seconds) Jul 05 11:57:22 volumio-2 volumio[1046]: info: [ytmusic] InnertubeLoader: re-create Innertube instance with po_token Jul 05 11:57:22 volumio-2 volumio[1046]: info: [ytmusic] InnertubeLoader: creating Innertube instance with po_token... Jul 05 11:57:22 volumio-2 volumio[1046]: info: Listing playlists Jul 05 11:57:22 volumio-2 volumio[1046]: info: Listing playlists Jul 05 11:57:29 volumio-2 volumio[1046]: info: Discovery: Remote connection error: 192.168.88.191 Jul 05 11:57:37 volumio-2 volumio[1046]: info: [ytmusic] InnertubeLoader: going to refresh po_token in 43100 seconds Jul 05 11:57:37 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:57:37 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:57:37 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 11:57:37 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 11:57:37 volumio-2 volumio[1046]: info: Discovery: Getting this device information Jul 05 11:57:37 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:57:37 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:57:37 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 11:57:38 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:57:38 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 11:57:38 volumio-2 volumio[1046]: info: sendMpdCommand stop took 8 milliseconds Jul 05 11:57:38 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 11:57:38 volumio-2 volumio[1046]: info: sendMpdCommand clear took 1 milliseconds Jul 05 11:57:38 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-q5u5nugx5h-ha5s.googlevideo.com/videoplayback?expire=1751731057&ei=EfdoaPGGLd_Ki9oP4YXIqAI&ip=46.11.145.124&id=o-AOfhDpE12SF00SeuXff4P7b1Wiwnmbi_tuhITZyp-g95&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751709457%2C&mh=H5&mm=31%2C29&mn=sn-q5u5nugx5h-ha5s%2Csn-hpa7zn6z&ms=au%2Crdu&mv=m&mvi=2&pl=25&rms=au%2Cau&initcwndbps=3302500&bui=AY1jyLNhifYTowA8_Vw93OJ_fVW1pULYgmCv7NVveQDxVxViZOYS7xMsp1WXxfWziaCCsAzSNKe951hg&spc=l3OVKdMcj7pN0J8kzjSO6mdFlkO5gTjgLXd2g0cSwKtrbtUkjt7Wy6PLmgsJKqMXvY4&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=dnXu-aEtgpJm-TpVSFYq7IwQ&rqh=1&gir=yes&clen=88100944&dur=5504.941&lmt=1751188848028080&mt=1751709166&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5432534&n=CqVmP7UeELvoQg&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=APaTxxMwRQIhAKt46hs7h1mUYnl4hXWjFjQSagJ1yxE07OIwzpM9Lx8hAiB5e2aeJ2INHZWLdkCq6ls_W2biWlsy7CEvshwRyQ84eQ%3D%3D&sig=AJfQdSswRgIhANMxRBl-HXxgFSKw4YLetO5FzRT6gmcgYN3I0qS90oGkAiEAu4l6nbAW6Ifsy9SISOCtfkQ7chs-M1SRJzplfBdtumY%3D&pot=MpgBds5FW6Fi3SJ28pb6fONz-U14i_33L-j8HqugjeuJLEk1sjtyXWFXQVk-aWR3KSz3v2IuM4WlI6gpnXVsRhBNXUo51Ff6r5fWWxsrTvdaVDDbBKa3zdyLCUO-Y90LCZ6ZSMNMfu_yHKdR3LLnVJ36iEHTqP3F07jhtLyWeTLYh6Kbs6UXJH8s_dlSwszwvXIIZ8VNHX4xGsc%3D&cver=1.20250219.01.00&t.YouTube" Jul 05 11:57:38 volumio-2 volumio[1046]: info: Jul 05 11:57:38 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:38 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:38 volumio-2 volumio[1046]: info: Jul 05 11:57:38 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:38 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:38 volumio-2 volumio[1046]: info: Jul 05 11:57:38 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:38 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:38 volumio-2 volumio[1046]: info: Jul 05 11:57:38 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:38 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:38 volumio-2 volumio[1046]: info: sendMpdCommand addid "https://rr2---sn-q5u5nugx5h-ha5s.googlevideo.com/videoplayback?expire=1751731057&ei=EfdoaPGGLd_Ki9oP4YXIqAI&ip=46.11.145.124&id=o-AOfhDpE12SF00SeuXff4P7b1Wiwnmbi_tuhITZyp-g95&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751709457%2C&mh=H5&mm=31%2C29&mn=sn-q5u5nugx5h-ha5s%2Csn-hpa7zn6z&ms=au%2Crdu&mv=m&mvi=2&pl=25&rms=au%2Cau&initcwndbps=3302500&bui=AY1jyLNhifYTowA8_Vw93OJ_fVW1pULYgmCv7NVveQDxVxViZOYS7xMsp1WXxfWziaCCsAzSNKe951hg&spc=l3OVKdMcj7pN0J8kzjSO6mdFlkO5gTjgLXd2g0cSwKtrbtUkjt7Wy6PLmgsJKqMXvY4&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=dnXu-aEtgpJm-TpVSFYq7IwQ&rqh=1&gir=yes&clen=88100944&dur=5504.941&lmt=1751188848028080&mt=1751709166&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5432534&n=CqVmP7UeELvoQg&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=APaTxxMwRQIhAKt46hs7h1mUYnl4hXWjFjQSagJ1yxE07OIwzpM9Lx8hAiB5e2aeJ2INHZWLdkCq6ls_W2biWlsy7CEvshwRyQ84eQ%3D%3D&sig=AJfQdSswRgIhANMxRBl-HXxgFSKw4YLetO5FzRT6gmcgYN3I0qS90oGkAiEAu4l6nbAW6Ifsy9SISOCtfkQ7chs-M1SRJzplfBdtumY%3D&pot=MpgBds5FW6Fi3SJ28pb6fONz-U14i_33L-j8HqugjeuJLEk1sjtyXWFXQVk-aWR3KSz3v2IuM4WlI6gpnXVsRhBNXUo51Ff6r5fWWxsrTvdaVDDbBKa3zdyLCUO-Y90LCZ6ZSMNMfu_yHKdR3LLnVJ36iEHTqP3F07jhtLyWeTLYh6Kbs6UXJH8s_dlSwszwvXIIZ8VNHX4xGsc%3D&cver=1.20250219.01.00&t.YouTube" took 5 milliseconds Jul 05 11:57:38 volumio-2 volumio[1046]: info: ------------------------------ 5ms Jul 05 11:57:38 volumio-2 volumio[1046]: info: ------------------------------ 4ms Jul 05 11:57:38 volumio-2 volumio[1046]: verbose: MPD COMMAND [object Object] Jul 05 11:57:38 volumio-2 volumio[1046]: verbose: MPD COMMAND [object Object] Jul 05 11:57:38 volumio-2 volumio[1046]: info: Jul 05 11:57:38 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:38 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:38 volumio-2 volumio[1046]: info: Jul 05 11:57:38 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:38 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:38 volumio-2 volumio[1046]: info: Jul 05 11:57:38 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:38 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:38 volumio-2 volumio[1046]: info: ------------------------------ 10ms Jul 05 11:57:38 volumio-2 volumio[1046]: info: ------------------------------ 9ms Jul 05 11:57:38 volumio-2 volumio[1046]: info: ------------------------------ 5ms Jul 05 11:57:38 volumio-2 volumio[1046]: info: ------------------------------ 4ms Jul 05 11:57:38 volumio-2 volumio[1046]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 05 11:57:38 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand play Jul 05 11:57:38 volumio-2 volumio[1046]: info: Jul 05 11:57:38 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:38 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:38 volumio-2 volumio[1046]: info: Jul 05 11:57:38 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:38 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:38 volumio-2 volumio[1046]: info: ------------------------------ 7ms Jul 05 11:57:38 volumio-2 volumio[1046]: info: sendMpdCommand play took 4 milliseconds Jul 05 11:57:38 volumio-2 volumio[1046]: info: ------------------------------ 5ms Jul 05 11:57:38 volumio-2 volumio[1046]: info: ------------------------------ 3ms Jul 05 11:57:39 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 11:57:39 volumio-2 volumio[1046]: info: Jul 05 11:57:39 volumio-2 volumio[1046]: ---------------------------- MPD announces state update: player Jul 05 11:57:39 volumio-2 volumio[1046]: info: sendMpdCommand stop took 6 milliseconds Jul 05 11:57:39 volumio-2 volumio[1046]: info: ControllerMpd::getState Jul 05 11:57:39 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:57:39 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 11:57:39 volumio-2 volumio[1046]: info: Jul 05 11:57:39 volumio-2 volumio[1046]: ---------------------------- MPD announces state update: player Jul 05 11:57:39 volumio-2 volumio[1046]: info: ControllerMpd::getState Jul 05 11:57:39 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:57:39 volumio-2 volumio[1046]: info: Jul 05 11:57:39 volumio-2 volumio[1046]: ---------------------------- MPD announces state update: player Jul 05 11:57:39 volumio-2 volumio[1046]: info: ControllerMpd::getState Jul 05 11:57:39 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:57:39 volumio-2 volumio[1046]: info: Jul 05 11:57:39 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:39 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:39 volumio-2 volumio[1046]: info: sendMpdCommand status took 6 milliseconds Jul 05 11:57:39 volumio-2 volumio[1046]: info: sendMpdCommand clear took 7 milliseconds Jul 05 11:57:39 volumio-2 volumio[1046]: info: sendMpdCommand status took 5 milliseconds Jul 05 11:57:39 volumio-2 volumio[1046]: info: sendMpdCommand status took 3 milliseconds Jul 05 11:57:39 volumio-2 volumio[1046]: verbose: ControllerMpd::parseState Jul 05 11:57:39 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:57:39 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-q5u5nugx5h-ha5s.googlevideo.com/videoplayback?expire=1751731058&ei=EfdoaKjDOrr0p-oP7Y3nyQ8&ip=46.11.145.124&id=o-AG1SZQSZ5GNa0MDN1Ecx-Wt36C470AhJ6g9wHdRn09DJ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751709457%2C&mh=H5&mm=31%2C29&mn=sn-q5u5nugx5h-ha5s%2Csn-hpa7zn6z&ms=au%2Crdu&mv=m&mvi=2&pl=25&rms=au%2Cau&initcwndbps=2948750&bui=AY1jyLOWi0LVyFsY3gxnztmzAU_jrGC8zCgVFITiCIPj_acv7MJmk_pPaDy6U11FTMpJe_38DJMc20Yl&spc=l3OVKX4Bh6sU6cEJ2cYY2GMM9Vu_uxht9bI5IKsQouLeVN7glXhehOvCqGWkCHicDpk&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=AYN4QZQ8QQF5Nd4jIBdTRLAQ&rqh=1&gir=yes&clen=88100944&dur=5504.941&lmt=1751188848028080&mt=1751708931&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5432534&n=I5qxW3YKQxxjMA&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=APaTxxMwRQIhAM98vY1tpdHO3DuWzgettQl2xltzxqP9A5wtXiAtqvLLAiBQtN7IvtBSsfHhw_qHRsCHAk18FaVovBIiTwUNEcX5pA%3D%3D&sig=AJfQdSswRQIgGNL-MdklBqg-zc1bh0uHcxFjFX81cw-9P3sYLxA5_wkCIQCb6McUw3DKUyn1Ui4gpwEbYLAsKvXAgODS-2AT3C0-uA%3D%3D&pot=MpgBds5FW6Fi3SJ28pb6fONz-U14i_33L-j8HqugjeuJLEk1sjtyXWFXQVk-aWR3KSz3v2IuM4WlI6gpnXVsRhBNXUo51Ff6r5fWWxsrTvdaVDDbBKa3zdyLCUO-Y90LCZ6ZSMNMfu_yHKdR3LLnVJ36iEHTqP3F07jhtLyWeTLYh6Kbs6UXJH8s_dlSwszwvXIIZ8VNHX4xGsc%3D&cver=1.20250219.01.00&t.YouTube" Jul 05 11:57:39 volumio-2 volumio[1046]: verbose: ControllerMpd::parseState Jul 05 11:57:39 volumio-2 volumio[1046]: verbose: ControllerMpd::parseState Jul 05 11:57:39 volumio-2 volumio[1046]: info: ControllerMpd::pushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreCommandRouter::servicePushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:57:39 volumio-2 volumio[1046]: 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 05 11:57:39 volumio-2 volumio[1046]: verbose: CURRENT POSITION 0 Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreStateMachine::syncState stateService stop Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: No code Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: ControllerMpd::pushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreCommandRouter::servicePushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:57:39 volumio-2 volumio[1046]: 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 05 11:57:39 volumio-2 volumio[1046]: verbose: CURRENT POSITION 0 Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreStateMachine::syncState stateService stop Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: No code Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:39 volumio-2 volumio[1046]: info: ------------------------------ 94ms Jul 05 11:57:39 volumio-2 volumio[1046]: info: ------------------------------ 94ms Jul 05 11:57:39 volumio-2 volumio[1046]: info: Jul 05 11:57:39 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:39 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:39 volumio-2 volumio[1046]: info: Jul 05 11:57:39 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:39 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:39 volumio-2 volumio[1046]: error: updateQueue error: null Jul 05 11:57:39 volumio-2 volumio[1046]: info: Jul 05 11:57:39 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:39 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:39 volumio-2 volumio[1046]: info: ------------------------------ 98ms Jul 05 11:57:39 volumio-2 volumio[1046]: info: sendMpdCommand playlistinfo took 95 milliseconds Jul 05 11:57:39 volumio-2 volumio[1046]: info: sendMpdCommand addid "https://rr2---sn-q5u5nugx5h-ha5s.googlevideo.com/videoplayback?expire=1751731058&ei=EfdoaKjDOrr0p-oP7Y3nyQ8&ip=46.11.145.124&id=o-AG1SZQSZ5GNa0MDN1Ecx-Wt36C470AhJ6g9wHdRn09DJ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751709457%2C&mh=H5&mm=31%2C29&mn=sn-q5u5nugx5h-ha5s%2Csn-hpa7zn6z&ms=au%2Crdu&mv=m&mvi=2&pl=25&rms=au%2Cau&initcwndbps=2948750&bui=AY1jyLOWi0LVyFsY3gxnztmzAU_jrGC8zCgVFITiCIPj_acv7MJmk_pPaDy6U11FTMpJe_38DJMc20Yl&spc=l3OVKX4Bh6sU6cEJ2cYY2GMM9Vu_uxht9bI5IKsQouLeVN7glXhehOvCqGWkCHicDpk&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=AYN4QZQ8QQF5Nd4jIBdTRLAQ&rqh=1&gir=yes&clen=88100944&dur=5504.941&lmt=1751188848028080&mt=1751708931&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5432534&n=I5qxW3YKQxxjMA&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=APaTxxMwRQIhAM98vY1tpdHO3DuWzgettQl2xltzxqP9A5wtXiAtqvLLAiBQtN7IvtBSsfHhw_qHRsCHAk18FaVovBIiTwUNEcX5pA%3D%3D&sig=AJfQdSswRQIgGNL-MdklBqg-zc1bh0uHcxFjFX81cw-9P3sYLxA5_wkCIQCb6McUw3DKUyn1Ui4gpwEbYLAsKvXAgODS-2AT3C0-uA%3D%3D&pot=MpgBds5FW6Fi3SJ28pb6fONz-U14i_33L-j8HqugjeuJLEk1sjtyXWFXQVk-aWR3KSz3v2IuM4WlI6gpnXVsRhBNXUo51Ff6r5fWWxsrTvdaVDDbBKa3zdyLCUO-Y90LCZ6ZSMNMfu_yHKdR3LLnVJ36iEHTqP3F07jhtLyWeTLYh6Kbs6UXJH8s_dlSwszwvXIIZ8VNHX4xGsc%3D&cver=1.20250219.01.00&t.YouTube" took 94 milliseconds Jul 05 11:57:39 volumio-2 volumio[1046]: info: ------------------------------ 5ms Jul 05 11:57:39 volumio-2 volumio[1046]: info: ------------------------------ 4ms Jul 05 11:57:39 volumio-2 volumio[1046]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:57:39 volumio-2 volumio[1046]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jul 05 11:57:39 volumio-2 volumio[1046]: verbose: MPD COMMAND [object Object] Jul 05 11:57:39 volumio-2 volumio[1046]: verbose: MPD COMMAND [object Object] Jul 05 11:57:39 volumio-2 volumio[1046]: info: ------------------------------ 108ms Jul 05 11:57:39 volumio-2 volumio[1046]: info: Jul 05 11:57:39 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:39 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:39 volumio-2 volumio[1046]: info: Jul 05 11:57:39 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:39 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:39 volumio-2 volumio[1046]: info: Jul 05 11:57:39 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:39 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:39 volumio-2 volumio[1046]: info: ------------------------------ 30ms Jul 05 11:57:39 volumio-2 volumio[1046]: info: ------------------------------ 24ms Jul 05 11:57:39 volumio-2 volumio[1046]: info: ------------------------------ 23ms Jul 05 11:57:39 volumio-2 volumio[1046]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 05 11:57:39 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand play Jul 05 11:57:39 volumio-2 volumio[1046]: info: Jul 05 11:57:39 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:39 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:39 volumio-2 volumio[1046]: info: Jul 05 11:57:39 volumio-2 volumio[1046]: ---------------------------- MPD announces system playlist update Jul 05 11:57:39 volumio-2 volumio[1046]: info: Ignoring MPD Status Update Jul 05 11:57:39 volumio-2 volumio[1046]: info: ------------------------------ 6ms Jul 05 11:57:39 volumio-2 volumio[1046]: info: sendMpdCommand play took 5 milliseconds Jul 05 11:57:39 volumio-2 volumio[1046]: info: ------------------------------ 4ms Jul 05 11:57:39 volumio-2 volumio[1046]: info: ------------------------------ 3ms Jul 05 11:57:40 volumio-2 volumio[1046]: info: Jul 05 11:57:40 volumio-2 volumio[1046]: ---------------------------- MPD announces state update: player Jul 05 11:57:40 volumio-2 volumio[1046]: info: ControllerMpd::getState Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:57:40 volumio-2 volumio[1046]: info: Jul 05 11:57:40 volumio-2 volumio[1046]: ---------------------------- MPD announces state update: player Jul 05 11:57:40 volumio-2 volumio[1046]: info: ControllerMpd::getState Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:57:40 volumio-2 volumio[1046]: info: Jul 05 11:57:40 volumio-2 volumio[1046]: ---------------------------- MPD announces state update: player Jul 05 11:57:40 volumio-2 volumio[1046]: info: ControllerMpd::getState Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:57:40 volumio-2 volumio[1046]: info: sendMpdCommand status took 16 milliseconds Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::parseState Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:57:40 volumio-2 volumio[1046]: info: Jul 05 11:57:40 volumio-2 volumio[1046]: ---------------------------- MPD announces state update: player Jul 05 11:57:40 volumio-2 volumio[1046]: info: ControllerMpd::getState Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:57:40 volumio-2 volumio[1046]: info: Jul 05 11:57:40 volumio-2 volumio[1046]: ---------------------------- MPD announces state update: player Jul 05 11:57:40 volumio-2 volumio[1046]: info: ControllerMpd::getState Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:57:40 volumio-2 volumio[1046]: info: sendMpdCommand status took 19 milliseconds Jul 05 11:57:40 volumio-2 volumio[1046]: info: sendMpdCommand status took 17 milliseconds Jul 05 11:57:40 volumio-2 volumio[1046]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 05 11:57:40 volumio-2 volumio[1046]: info: sendMpdCommand status took 3 milliseconds Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::parseState Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::parseState Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::parseState Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:57:40 volumio-2 volumio[1046]: info: ControllerMpd::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::servicePushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5505,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Le migliori canzoni di Zucchero - Il Meglio dei Zucchero album completo - Zucchero live","artist":"italian musical song","album":null,"uri":"https://rr2---sn-q5u5nugx5h-ha5s.googlevideo.com/videoplayback?expire=1751731058&ei=EfdoaKjDOrr0p-oP7Y3nyQ8&ip=46.11.145.124&id=o-AG1SZQSZ5GNa0MDN1Ecx-Wt36C470AhJ6g9wHdRn09DJ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751709457%2C&mh=H5&mm=31%2C29&mn=sn-q5u5nugx5h-ha5s%2Csn-hpa7zn6z&ms=au%2Crdu&mv=m&mvi=2&pl=25&rms=au%2Cau&initcwndbps=2948750&bui=AY1jyLOWi0LVyFsY3gxnztmzAU_jrGC8zCgVFITiCIPj_acv7MJmk_pPaDy6U11FTMpJe_38DJMc20Yl&spc=l3OVKX4Bh6sU6cEJ2cYY2GMM9Vu_uxht9bI5IKsQouLeVN7glXhehOvCqGWkCHicDpk&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=AYN4QZQ8QQF5Nd4jIBdTRLAQ&rqh=1&gir=yes&clen=88100944&dur=5504.941&lmt=1751188848028080&mt=1751708931&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5432534&n=I5qxW3YKQxxjMA&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=APaTxxMwRQIhAM98vY1tpdHO3DuWzgettQl2xltzxqP9A5wtXiAtqvLLAiBQtN7IvtBSsfHhw_qHRsCHAk18FaVovBIiTwUNEcX5pA%3D%3D&sig=AJfQdSswRQIgGNL-MdklBqg-zc1bh0uHcxFjFX81cw-9P3sYLxA5_wkCIQCb6McUw3DKUyn1Ui4gpwEbYLAsKvXAgODS-2AT3C0-uA%3D%3D&pot=MpgBds5FW6Fi3SJ28pb6fONz-U14i_33L-j8HqugjeuJLEk1sjtyXWFXQVk-aWR3KSz3v2IuM4WlI6gpnXVsRhBNXUo51Ff6r5fWWxsrTvdaVDDbBKa3zdyLCUO-Y90LCZ6ZSMNMfu_yHKdR3LLnVJ36iEHTqP3F07jhtLyWeTLYh6Kbs6UXJH8s_dlSwszwvXIIZ8VNHX4xGsc%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: CURRENT POSITION 0 Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::syncState stateService play Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::syncState currentStatus stop Jul 05 11:57:40 volumio-2 volumio[1046]: info: ------------------------------ 28ms Jul 05 11:57:40 volumio-2 volumio[1046]: info: Jul 05 11:57:40 volumio-2 volumio[1046]: ---------------------------- MPD announces state update: player Jul 05 11:57:40 volumio-2 volumio[1046]: info: ControllerMpd::getState Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand status Jul 05 11:57:40 volumio-2 volumio[1046]: info: sendMpdCommand status took 8 milliseconds Jul 05 11:57:40 volumio-2 volumio[1046]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 05 11:57:40 volumio-2 volumio[1046]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 05 11:57:40 volumio-2 volumio[1046]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::parseState Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:57:40 volumio-2 volumio[1046]: info: ControllerMpd::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::servicePushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5505,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Le migliori canzoni di Zucchero - Il Meglio dei Zucchero album completo - Zucchero live","artist":"italian musical song","album":null,"uri":"https://rr2---sn-q5u5nugx5h-ha5s.googlevideo.com/videoplayback?expire=1751731058&ei=EfdoaKjDOrr0p-oP7Y3nyQ8&ip=46.11.145.124&id=o-AG1SZQSZ5GNa0MDN1Ecx-Wt36C470AhJ6g9wHdRn09DJ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751709457%2C&mh=H5&mm=31%2C29&mn=sn-q5u5nugx5h-ha5s%2Csn-hpa7zn6z&ms=au%2Crdu&mv=m&mvi=2&pl=25&rms=au%2Cau&initcwndbps=2948750&bui=AY1jyLOWi0LVyFsY3gxnztmzAU_jrGC8zCgVFITiCIPj_acv7MJmk_pPaDy6U11FTMpJe_38DJMc20Yl&spc=l3OVKX4Bh6sU6cEJ2cYY2GMM9Vu_uxht9bI5IKsQouLeVN7glXhehOvCqGWkCHicDpk&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=AYN4QZQ8QQF5Nd4jIBdTRLAQ&rqh=1&gir=yes&clen=88100944&dur=5504.941&lmt=1751188848028080&mt=1751708931&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5432534&n=I5qxW3YKQxxjMA&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=APaTxxMwRQIhAM98vY1tpdHO3DuWzgettQl2xltzxqP9A5wtXiAtqvLLAiBQtN7IvtBSsfHhw_qHRsCHAk18FaVovBIiTwUNEcX5pA%3D%3D&sig=AJfQdSswRQIgGNL-MdklBqg-zc1bh0uHcxFjFX81cw-9P3sYLxA5_wkCIQCb6McUw3DKUyn1Ui4gpwEbYLAsKvXAgODS-2AT3C0-uA%3D%3D&pot=MpgBds5FW6Fi3SJ28pb6fONz-U14i_33L-j8HqugjeuJLEk1sjtyXWFXQVk-aWR3KSz3v2IuM4WlI6gpnXVsRhBNXUo51Ff6r5fWWxsrTvdaVDDbBKa3zdyLCUO-Y90LCZ6ZSMNMfu_yHKdR3LLnVJ36iEHTqP3F07jhtLyWeTLYh6Kbs6UXJH8s_dlSwszwvXIIZ8VNHX4xGsc%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: CURRENT POSITION 0 Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::syncState stateService play Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:57:40 volumio-2 volumio[1046]: info: Received an update from plugin. extracting info from payload Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: ControllerMpd::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::servicePushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5505,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Le migliori canzoni di Zucchero - Il Meglio dei Zucchero album completo - Zucchero live","artist":"italian musical song","album":null,"uri":"https://rr2---sn-q5u5nugx5h-ha5s.googlevideo.com/videoplayback?expire=1751731058&ei=EfdoaKjDOrr0p-oP7Y3nyQ8&ip=46.11.145.124&id=o-AG1SZQSZ5GNa0MDN1Ecx-Wt36C470AhJ6g9wHdRn09DJ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751709457%2C&mh=H5&mm=31%2C29&mn=sn-q5u5nugx5h-ha5s%2Csn-hpa7zn6z&ms=au%2Crdu&mv=m&mvi=2&pl=25&rms=au%2Cau&initcwndbps=2948750&bui=AY1jyLOWi0LVyFsY3gxnztmzAU_jrGC8zCgVFITiCIPj_acv7MJmk_pPaDy6U11FTMpJe_38DJMc20Yl&spc=l3OVKX4Bh6sU6cEJ2cYY2GMM9Vu_uxht9bI5IKsQouLeVN7glXhehOvCqGWkCHicDpk&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=AYN4QZQ8QQF5Nd4jIBdTRLAQ&rqh=1&gir=yes&clen=88100944&dur=5504.941&lmt=1751188848028080&mt=1751708931&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5432534&n=I5qxW3YKQxxjMA&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=APaTxxMwRQIhAM98vY1tpdHO3DuWzgettQl2xltzxqP9A5wtXiAtqvLLAiBQtN7IvtBSsfHhw_qHRsCHAk18FaVovBIiTwUNEcX5pA%3D%3D&sig=AJfQdSswRQIgGNL-MdklBqg-zc1bh0uHcxFjFX81cw-9P3sYLxA5_wkCIQCb6McUw3DKUyn1Ui4gpwEbYLAsKvXAgODS-2AT3C0-uA%3D%3D&pot=MpgBds5FW6Fi3SJ28pb6fONz-U14i_33L-j8HqugjeuJLEk1sjtyXWFXQVk-aWR3KSz3v2IuM4WlI6gpnXVsRhBNXUo51Ff6r5fWWxsrTvdaVDDbBKa3zdyLCUO-Y90LCZ6ZSMNMfu_yHKdR3LLnVJ36iEHTqP3F07jhtLyWeTLYh6Kbs6UXJH8s_dlSwszwvXIIZ8VNHX4xGsc%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: CURRENT POSITION 0 Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::syncState stateService play Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:57:40 volumio-2 volumio[1046]: info: Received an update from plugin. extracting info from payload Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: ControllerMpd::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::servicePushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5505,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Le migliori canzoni di Zucchero - Il Meglio dei Zucchero album completo - Zucchero live","artist":"italian musical song","album":null,"uri":"https://rr2---sn-q5u5nugx5h-ha5s.googlevideo.com/videoplayback?expire=1751731058&ei=EfdoaKjDOrr0p-oP7Y3nyQ8&ip=46.11.145.124&id=o-AG1SZQSZ5GNa0MDN1Ecx-Wt36C470AhJ6g9wHdRn09DJ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751709457%2C&mh=H5&mm=31%2C29&mn=sn-q5u5nugx5h-ha5s%2Csn-hpa7zn6z&ms=au%2Crdu&mv=m&mvi=2&pl=25&rms=au%2Cau&initcwndbps=2948750&bui=AY1jyLOWi0LVyFsY3gxnztmzAU_jrGC8zCgVFITiCIPj_acv7MJmk_pPaDy6U11FTMpJe_38DJMc20Yl&spc=l3OVKX4Bh6sU6cEJ2cYY2GMM9Vu_uxht9bI5IKsQouLeVN7glXhehOvCqGWkCHicDpk&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=AYN4QZQ8QQF5Nd4jIBdTRLAQ&rqh=1&gir=yes&clen=88100944&dur=5504.941&lmt=1751188848028080&mt=1751708931&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5432534&n=I5qxW3YKQxxjMA&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=APaTxxMwRQIhAM98vY1tpdHO3DuWzgettQl2xltzxqP9A5wtXiAtqvLLAiBQtN7IvtBSsfHhw_qHRsCHAk18FaVovBIiTwUNEcX5pA%3D%3D&sig=AJfQdSswRQIgGNL-MdklBqg-zc1bh0uHcxFjFX81cw-9P3sYLxA5_wkCIQCb6McUw3DKUyn1Ui4gpwEbYLAsKvXAgODS-2AT3C0-uA%3D%3D&pot=MpgBds5FW6Fi3SJ28pb6fONz-U14i_33L-j8HqugjeuJLEk1sjtyXWFXQVk-aWR3KSz3v2IuM4WlI6gpnXVsRhBNXUo51Ff6r5fWWxsrTvdaVDDbBKa3zdyLCUO-Y90LCZ6ZSMNMfu_yHKdR3LLnVJ36iEHTqP3F07jhtLyWeTLYh6Kbs6UXJH8s_dlSwszwvXIIZ8VNHX4xGsc%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: CURRENT POSITION 0 Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::syncState stateService play Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:57:40 volumio-2 volumio[1046]: info: Received an update from plugin. extracting info from payload Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: ------------------------------ 109ms Jul 05 11:57:40 volumio-2 volumio[1046]: info: ------------------------------ 108ms Jul 05 11:57:40 volumio-2 volumio[1046]: info: ------------------------------ 94ms Jul 05 11:57:40 volumio-2 volumio[1046]: info: sendMpdCommand status took 85 milliseconds Jul 05 11:57:40 volumio-2 volumio[1046]: info: sendMpdCommand playlistinfo took 83 milliseconds Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::parseState Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:57:40 volumio-2 volumio[1046]: info: ControllerMpd::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::servicePushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5505,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Le migliori canzoni di Zucchero - Il Meglio dei Zucchero album completo - Zucchero live","artist":"italian musical song","album":null,"uri":"https://rr2---sn-q5u5nugx5h-ha5s.googlevideo.com/videoplayback?expire=1751731058&ei=EfdoaKjDOrr0p-oP7Y3nyQ8&ip=46.11.145.124&id=o-AG1SZQSZ5GNa0MDN1Ecx-Wt36C470AhJ6g9wHdRn09DJ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751709457%2C&mh=H5&mm=31%2C29&mn=sn-q5u5nugx5h-ha5s%2Csn-hpa7zn6z&ms=au%2Crdu&mv=m&mvi=2&pl=25&rms=au%2Cau&initcwndbps=2948750&bui=AY1jyLOWi0LVyFsY3gxnztmzAU_jrGC8zCgVFITiCIPj_acv7MJmk_pPaDy6U11FTMpJe_38DJMc20Yl&spc=l3OVKX4Bh6sU6cEJ2cYY2GMM9Vu_uxht9bI5IKsQouLeVN7glXhehOvCqGWkCHicDpk&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=AYN4QZQ8QQF5Nd4jIBdTRLAQ&rqh=1&gir=yes&clen=88100944&dur=5504.941&lmt=1751188848028080&mt=1751708931&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5432534&n=I5qxW3YKQxxjMA&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=APaTxxMwRQIhAM98vY1tpdHO3DuWzgettQl2xltzxqP9A5wtXiAtqvLLAiBQtN7IvtBSsfHhw_qHRsCHAk18FaVovBIiTwUNEcX5pA%3D%3D&sig=AJfQdSswRQIgGNL-MdklBqg-zc1bh0uHcxFjFX81cw-9P3sYLxA5_wkCIQCb6McUw3DKUyn1Ui4gpwEbYLAsKvXAgODS-2AT3C0-uA%3D%3D&pot=MpgBds5FW6Fi3SJ28pb6fONz-U14i_33L-j8HqugjeuJLEk1sjtyXWFXQVk-aWR3KSz3v2IuM4WlI6gpnXVsRhBNXUo51Ff6r5fWWxsrTvdaVDDbBKa3zdyLCUO-Y90LCZ6ZSMNMfu_yHKdR3LLnVJ36iEHTqP3F07jhtLyWeTLYh6Kbs6UXJH8s_dlSwszwvXIIZ8VNHX4xGsc%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: CURRENT POSITION 0 Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::syncState stateService play Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:57:40 volumio-2 volumio[1046]: info: Received an update from plugin. extracting info from payload Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: ------------------------------ 121ms Jul 05 11:57:40 volumio-2 volumio[1046]: info: sendMpdCommand playlistinfo took 55 milliseconds Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: ControllerMpd::parseTrackInfo Jul 05 11:57:40 volumio-2 volumio[1046]: info: ControllerMpd::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::servicePushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CorePlayQueue::getTrack 0 Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5505,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Le migliori canzoni di Zucchero - Il Meglio dei Zucchero album completo - Zucchero live","artist":"italian musical song","album":null,"uri":"https://rr2---sn-q5u5nugx5h-ha5s.googlevideo.com/videoplayback?expire=1751731058&ei=EfdoaKjDOrr0p-oP7Y3nyQ8&ip=46.11.145.124&id=o-AG1SZQSZ5GNa0MDN1Ecx-Wt36C470AhJ6g9wHdRn09DJ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751709457%2C&mh=H5&mm=31%2C29&mn=sn-q5u5nugx5h-ha5s%2Csn-hpa7zn6z&ms=au%2Crdu&mv=m&mvi=2&pl=25&rms=au%2Cau&initcwndbps=2948750&bui=AY1jyLOWi0LVyFsY3gxnztmzAU_jrGC8zCgVFITiCIPj_acv7MJmk_pPaDy6U11FTMpJe_38DJMc20Yl&spc=l3OVKX4Bh6sU6cEJ2cYY2GMM9Vu_uxht9bI5IKsQouLeVN7glXhehOvCqGWkCHicDpk&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=AYN4QZQ8QQF5Nd4jIBdTRLAQ&rqh=1&gir=yes&clen=88100944&dur=5504.941&lmt=1751188848028080&mt=1751708931&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5432534&n=I5qxW3YKQxxjMA&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=APaTxxMwRQIhAM98vY1tpdHO3DuWzgettQl2xltzxqP9A5wtXiAtqvLLAiBQtN7IvtBSsfHhw_qHRsCHAk18FaVovBIiTwUNEcX5pA%3D%3D&sig=AJfQdSswRQIgGNL-MdklBqg-zc1bh0uHcxFjFX81cw-9P3sYLxA5_wkCIQCb6McUw3DKUyn1Ui4gpwEbYLAsKvXAgODS-2AT3C0-uA%3D%3D&pot=MpgBds5FW6Fi3SJ28pb6fONz-U14i_33L-j8HqugjeuJLEk1sjtyXWFXQVk-aWR3KSz3v2IuM4WlI6gpnXVsRhBNXUo51Ff6r5fWWxsrTvdaVDDbBKa3zdyLCUO-Y90LCZ6ZSMNMfu_yHKdR3LLnVJ36iEHTqP3F07jhtLyWeTLYh6Kbs6UXJH8s_dlSwszwvXIIZ8VNHX4xGsc%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jul 05 11:57:40 volumio-2 volumio[1046]: verbose: CURRENT POSITION 0 Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::syncState stateService play Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::syncState currentStatus play Jul 05 11:57:40 volumio-2 volumio[1046]: info: Received an update from plugin. extracting info from payload Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreStateMachine::pushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioPushState Jul 05 11:57:40 volumio-2 volumio[1046]: info: ------------------------------ 168ms Jul 05 11:57:40 volumio-2 volumio[1046]: info: Discovery: Remote connection error: 192.168.88.191 Jul 05 11:57:47 volumio-2 volumio[1046]: info: CoreCommandRouter::volumioGetState Jul 05 11:57:47 volumio-2 systemd[1]: systemd-timedated.service: Deactivated successfully. Jul 05 11:57:48 volumio-2 volumio[1046]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 11:57:48 volumio-2 volumio[1046]: TypeError: fetch failed Jul 05 11:57:48 volumio-2 volumio[1046]: at HTTPClient.fetch (/data/plugins/music_service/ytmusic/node_modules/undici/index.js:112:15) Jul 05 11:57:48 volumio-2 volumio[1046]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jul 05 11:57:48 volumio-2 volumio[1046]: at async HTTPClient.fetch (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:8350:22) Jul 05 11:57:48 volumio-2 volumio[1046]: at async Actions.stats (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:26251:12) Jul 05 11:57:48 volumio-2 volumio[1046]: at async TrackInfo.addToWatchHistory (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:23293:12) { Jul 05 11:57:48 volumio-2 volumio[1046]: cause: ConnectTimeoutError: Connect Timeout Error Jul 05 11:57:48 volumio-2 volumio[1046]: at onConnectTimeout (/data/plugins/music_service/youtube2/node_modules/undici/lib/core/connect.js:186:24) Jul 05 11:57:48 volumio-2 volumio[1046]: at /data/plugins/music_service/youtube2/node_modules/undici/lib/core/connect.js:133:46 Jul 05 11:57:48 volumio-2 volumio[1046]: at Immediate._onImmediate (/data/plugins/music_service/youtube2/node_modules/undici/lib/core/connect.js:174:9) Jul 05 11:57:48 volumio-2 volumio[1046]: at process.processImmediate (node:internal/timers:478:21) { Jul 05 11:57:48 volumio-2 volumio[1046]: code: 'UND_ERR_CONNECT_TIMEOUT' Jul 05 11:57:48 volumio-2 volumio[1046]: } Jul 05 11:57:48 volumio-2 volumio[1046]: } Jul 05 11:57:48 volumio-2 volumio[1046]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 11:57:49 volumio-2 sudo[10196]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-07-05 11:56' Jul 05 11:57:49 volumio-2 sudo[10196]: 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="f9454895cc8e2f1971c705a815a7226e021e37d7" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1fc282af1865fae9b40239cedf2cc17c112eef0d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Jun 28 16:48:46 UTC 2025" VOLUMIO_VERSION="4.014" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="1b557e4869cd2eea14f4113140ecea1c"