Jun 27 09:40:00 volumio volumio[1173]: info: [yt-cast-receiver] Player.play(): kqpVeKwpZSA @ 0s Jun 27 09:40:00 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:00 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:00 volumio volumio[1173]: info: [yt-cast-receiver] Player.stop() Jun 27 09:40:00 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:00 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:40:00 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:40:00 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:40:00 volumio volumio[1173]: info: [yt-cast-receiver] Player.play(): kqpVeKwpZSA @ 0s Jun 27 09:40:00 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:00 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:01 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:01 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:40:01 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:40:01 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 09:40:03 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 09:40:03 volumio volumio[1173]: info: Discovery: Getting this device information Jun 27 09:40:03 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:03 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:03 volumio volumio[1173]: verbose: New Socket.io Connection to 192.168.1.65:3000 from 192.168.1.9 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Jun 27 09:40:03 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:03 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 27 09:40:03 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 27 09:40:03 volumio volumio[1173]: info: [yt-cast-receiver] Player.play(): kqpVeKwpZSA @ 0s Jun 27 09:40:04 volumio mpd[1354]: ffmpeg/opus: Could not update timestamps for skipped samples. Jun 27 09:40:04 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:04 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:04 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:04 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:04 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:04 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:04 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:04 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:04 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:40:04 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:40:04 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 09:40:04 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:40:04 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:04 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:40:04 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:40:04 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 09:40:04 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:40:05 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:06 volumio mpd[1354]: player: played "https://rr5---sn-25ge7nsd.googlevideo.com/videoplayback?expire=1751031603&ei=00peaIDbGav2xN8PqsnKsAE&ip=82.64.168.45&id=o-AB-WmsjPIiNCUeXQPklcElsP4iIPJwcCDEj5T5cLBcbY&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751010003%2C&mh=Dy&mm=31%2C26&mn=sn-25ge7nsd%2Csn-4g5edn6k&ms=au%2Conr&mv=m&mvi=5&pl=22&rms=au%2Cau&ctier=A&pfa=5&gcr=fr&initcwndbps=2850000&hightc=yes&siu=1&bui=AY1jyLOp0pghOS6d1DfCMMevo6b5RPZZ6LVv7YTpT1K7ZztrmVvxkxdLzZhHfN76R8SUxF38Tw&spc=l3OVKXaamKfCMi7CQiDJaUSDaIC0A5lHG3uaEbUkmvi3duOBwQPbxi7CLCFs7CPK6qNo4vr9eSWN-1g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=cE0B9xg9_O7MvLKAprVKtW4Q&rqh=1&gir=yes&clen=6245328&dur=202.401&lmt=1714805641779565&mt=1751009566&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2318224&n=nhlT1fxOTu-nFg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgYTZAWw-UAF9o1-50DrpWaNlvIRHHfCmsx5kSUFzQW44CIQD-w8qNcUKgCD6u6Vj6bltvDk04d581jm9_rJ8L9TiN3g%3D%3D&sig=AJfQdSswRQIgKvtGNsAGdBiTCzy9Devgeul4ktPbZK8nrULFXzKajigCIQCHgwifs5FTl9_338PDjhUiyae61KvQY6OISNlTmMp7uA%3D%3D&pot=MpgBDR_VFArdW6MNI8TZdjoxZcLgTezmMmPRDKxJgk3CE00PcEaLKxsDiQ-AzZLMNBowf7V8npJaIxjeKfp0IKecxr6w0mfbT_LOX3vDHmZXXIGVUW21y0Xfi5Ii1P0BpoA28gbsEjV965ROu_VG0lwdwCTsHu_5kvDdGUCzZvsd9X1zgmwtZrTSjUqubBQ-Lm3x9l1xNDfDT8M%3D&cver=1.20250219.01.00" Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:06 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:40:06 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:40:06 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 09:40:06 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:40:06 volumio mpd[1354]: exception: No such song Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: [yt-cast-receiver] Player.next() Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:06 volumio sudo[1875]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 27 09:40:06 volumio sudo[1875]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 27 09:40:07 volumio sudo[1877]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 27 09:40:07 volumio sudo[1877]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 27 09:40:07 volumio sudo[1875]: pam_unix(sudo:session): session closed for user root Jun 27 09:40:07 volumio sudo[1877]: pam_unix(sudo:session): session closed for user root Jun 27 09:40:07 volumio mpd[1354]: ffmpeg/opus: Could not update timestamps for skipped samples. Jun 27 09:40:07 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:07 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:07 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:07 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:07 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:07 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:07 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:07 volumio volumio[1173]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.9 UA: Mozilla/5.0 (Linux; Android 14; RMX3834 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jun 27 09:40:07 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:40:07 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:40:07 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 09:40:07 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:40:08 volumio sudo[1882]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 27 09:40:08 volumio sudo[1882]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 27 09:40:08 volumio sudo[1882]: pam_unix(sudo:session): session closed for user root Jun 27 09:40:08 volumio sudo[1885]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 27 09:40:08 volumio sudo[1885]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 27 09:40:08 volumio sudo[1885]: pam_unix(sudo:session): session closed for user root Jun 27 09:40:08 volumio volumio[1173]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.9 UA: Mozilla/5.0 (Linux; Android 14; RMX3834 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jun 27 09:40:08 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 27 09:40:08 volumio volumio[1173]: info: CoreCommandRouter::volumioGetVisibleSources Jun 27 09:40:08 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 09:40:08 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:08 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 27 09:40:08 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 27 09:40:08 volumio volumio[1173]: info: Received Get System Info Jun 27 09:40:08 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 09:40:08 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 09:40:08 volumio volumio[1173]: info: Discovery: Getting this device information Jun 27 09:40:08 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:08 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 09:40:08 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:08 volumio volumio[1173]: info: Listing playlists Jun 27 09:40:08 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 27 09:40:08 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 27 09:40:08 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 27 09:40:09 volumio volumio[1173]: info: [yt-cast-receiver] Player.stop() Jun 27 09:40:09 volumio mpd[1354]: player: played "https://rr5---sn-25glenes.googlevideo.com/videoplayback?expire=1751031606&ei=1kpeaPLzM8uGvdIPlLqjgA4&ip=82.64.168.45&id=o-AMn84hwXHaS2eTJn5NABYIHIh8nESHZFb-4o1ja222vU&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751010006%2C&mh=Dy&mm=31%2C26&mn=sn-25glenes%2Csn-4g5lzne6&ms=au%2Conr&mv=m&mvi=5&pl=22&rms=au%2Cau&ctier=A&pfa=5&gcr=fr&initcwndbps=2831250&hightc=yes&siu=1&bui=AY1jyLPkSe6t5KC9Oh-NqHxgohdx9lptgnmS4VCQIhehYRZ4s8u6L0rQenV8MM0uUQCoihouEQ&spc=l3OVKdDuKF7hxmTKNdNKg7d2qfihHZUd5PGj44aFSkS8B9DJpDM63e2bUzFZaf1dQBRLyiyGLThLCVA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=TheQwmTRHjtXFM183Eb2ju4Q&rqh=1&gir=yes&clen=6245328&dur=202.401&lmt=1714805641779565&mt=1751009810&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2318224&n=vINrvge_rWQH9A&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAPnV8JFzMMNjRh8buQMrL6-tGJKE4QuMkrKjJbE-DygHAiAzFCKtFxGp0AWHFBlg_FOkcoKzVRxNNvN_wCvOW5f-xA%3D%3D&sig=AJfQdSswRQIgE458oD8PAesLJnFflBRxKDFYzX5OR2DR2rnkfjXX0Z8CIQCr8xsLJOsAwbsbVHWk5ZpRwFpbqIH14hiAaHDyJxmdHw%3D%3D&pot=MpgBDR_VFArdW6MNI8TZdjoxZcLgTezmMmPRDKxJgk3CE00PcEaLKxsDiQ-AzZLMNBowf7V8npJaIxjeKfp0IKecxr6w0mfbT_LOX3vDHmZXXIGVUW21y0Xfi5Ii1P0BpoA28gbsEjV965ROu_VG0lwdwCTsHu_5kvDdGUCzZvsd9X1zgmwtZrTSjUqubBQ-Lm3x9l1xNDfDT8M%3D&cver=1.20250219.01.00" Jun 27 09:40:09 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:09 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:09 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:09 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:09 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:40:09 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:40:09 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 09:40:09 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:40:09 volumio volumio[1173]: info: [yt-cast-receiver] Player.play(): yECMX9QfKtE @ 0s Jun 27 09:40:09 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:09 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:09 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 27 09:40:09 volumio volumio[1173]: info: Received Get System Info Jun 27 09:40:09 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 09:40:09 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 09:40:09 volumio volumio[1173]: info: Discovery: Getting this device information Jun 27 09:40:09 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:09 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 09:40:10 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 27 09:40:10 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 27 09:40:10 volumio volumio[1173]: info: Received Get System Info Jun 27 09:40:10 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 09:40:10 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 09:40:10 volumio volumio[1173]: info: Discovery: Getting this device information Jun 27 09:40:10 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:10 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:10 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:11 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:11 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:11 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:40:11 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:11 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:40:11 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:40:11 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 09:40:11 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:40:11 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:11 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:40:11 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:40:11 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:40:11 volumio volumio[1173]: info: CoreCommandRouter::volumioVolatilePlay Jun 27 09:40:11 volumio volumio[1173]: info: CoreStateMachine::volatilePlay Jun 27 09:40:11 volumio volumio[1173]: info: [yt-cast-receiver] Player.resume() Jun 27 09:40:11 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:11 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:40:11 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:40:11 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:40:18 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 27 09:40:26 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 27 09:40:26 volumio volumio[1173]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 27 09:40:26 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 27 09:40:26 volumio volumio[1173]: info: Received Get System Version Jun 27 09:40:26 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 27 09:40:26 volumio volumio[1173]: info: Received Get System Info Jun 27 09:40:26 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 09:40:26 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 09:40:26 volumio volumio[1173]: info: Discovery: Getting this device information Jun 27 09:40:26 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:26 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 09:40:33 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 09:40:33 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 09:40:33 volumio volumio[1173]: info: Discovery: Getting this device information Jun 27 09:40:33 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:40:33 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 09:40:35 volumio kernel: usb 1-1.1: USB disconnect, device number 7 Jun 27 09:40:35 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 27 09:40:35 volumio dbus-daemon[696]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.28' (uid=0 pid=1995 comm="timedatectl show --property=NTPSynchronized --valu") Jun 27 09:40:35 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 27 09:40:35 volumio dbus-daemon[696]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 27 09:40:35 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 27 09:40:35 volumio setdatetime-helper.sh[1994]: Time is not synchronized. Attempting to sync... Jun 27 09:40:35 volumio sudo[2003]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Fri, 27 Jun 2025 07:40:36 GMT#015' Jun 27 09:40:35 volumio sudo[2003]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 27 09:40:36 volumio setdatetime-helper.sh[2004]: Fri Jun 27 09:40:36 CEST 2025 Jun 27 09:40:36 volumio sudo[2003]: pam_unix(sudo:session): session closed for user root Jun 27 09:40:36 volumio setdatetime-helper.sh[1994]: Time synchronized successfully. Jun 27 09:40:36 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 27 09:40:36 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 27 09:40:36 volumio kernel: usb 1-1.3: new high-speed USB device number 8 using xhci_hcd Jun 27 09:40:37 volumio kernel: usb 1-1.3: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.54 Jun 27 09:40:37 volumio kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jun 27 09:40:37 volumio kernel: usb 1-1.3: Product: SMSL USB AUDIO Jun 27 09:40:37 volumio kernel: usb 1-1.3: Manufacturer: SMSL Jun 27 09:40:37 volumio kernel: hid-generic 0003:152A:85DD.0003: hiddev96,hidraw0: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.3/input3 Jun 27 09:40:41 volumio (udev-worker)[1632]: pcmC5D0p: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 28. Jun 27 09:40:48 volumio volumio[1173]: error: error Jun 27 09:40:53 volumio kernel: usb 1-1.3: USB disconnect, device number 8 Jun 27 09:40:54 volumio kernel: usb 1-1.2: new high-speed USB device number 9 using xhci_hcd Jun 27 09:40:54 volumio kernel: usb 1-1.2: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.54 Jun 27 09:40:54 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jun 27 09:40:54 volumio kernel: usb 1-1.2: Product: SMSL USB AUDIO Jun 27 09:40:54 volumio kernel: usb 1-1.2: Manufacturer: SMSL Jun 27 09:40:54 volumio kernel: hid-generic 0003:152A:85DD.0004: hiddev96,hidraw0: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.2/input3 Jun 27 09:41:03 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 09:41:03 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 09:41:03 volumio volumio[1173]: info: Discovery: Getting this device information Jun 27 09:41:03 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:03 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 09:41:05 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Jun 27 09:41:16 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:16 volumio sudo[2150]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 27 09:41:16 volumio sudo[2150]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 27 09:41:16 volumio sudo[2150]: pam_unix(sudo:session): session closed for user root Jun 27 09:41:16 volumio sudo[2153]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 27 09:41:16 volumio sudo[2153]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 27 09:41:16 volumio sudo[2153]: pam_unix(sudo:session): session closed for user root Jun 27 09:41:16 volumio volumio[1173]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.9 UA: Mozilla/5.0 (Linux; Android 14; RMX3834 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jun 27 09:41:17 volumio sudo[2160]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 27 09:41:17 volumio sudo[2160]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 27 09:41:17 volumio sudo[2160]: pam_unix(sudo:session): session closed for user root Jun 27 09:41:17 volumio sudo[2158]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 27 09:41:17 volumio sudo[2158]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 27 09:41:17 volumio sudo[2158]: pam_unix(sudo:session): session closed for user root Jun 27 09:41:17 volumio volumio[1173]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.9 UA: Mozilla/5.0 (Linux; Android 14; RMX3834 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jun 27 09:41:17 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 27 09:41:17 volumio volumio[1173]: info: CoreCommandRouter::volumioGetVisibleSources Jun 27 09:41:17 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 09:41:17 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:17 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 27 09:41:17 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 27 09:41:17 volumio volumio[1173]: info: Received Get System Info Jun 27 09:41:17 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 09:41:17 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 09:41:17 volumio volumio[1173]: info: Discovery: Getting this device information Jun 27 09:41:17 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:17 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 09:41:17 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:17 volumio volumio[1173]: info: Listing playlists Jun 27 09:41:17 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 27 09:41:17 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 27 09:41:17 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 27 09:41:19 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 27 09:41:19 volumio volumio[1173]: info: Received Get System Info Jun 27 09:41:19 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 09:41:19 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 09:41:19 volumio volumio[1173]: info: Discovery: Getting this device information Jun 27 09:41:19 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:19 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 09:41:19 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 27 09:41:20 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 27 09:41:20 volumio volumio[1173]: info: Received Get System Info Jun 27 09:41:20 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 09:41:20 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 09:41:20 volumio volumio[1173]: info: Discovery: Getting this device information Jun 27 09:41:20 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:20 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 09:41:21 volumio volumio[1173]: info: CoreCommandRouter::volumioGetQueue Jun 27 09:41:21 volumio volumio[1173]: info: CoreStateMachine::getQueue Jun 27 09:41:21 volumio volumio[1173]: info: CorePlayQueue::getQueue Jun 27 09:41:24 volumio volumio[1173]: info: CoreCommandRouter::volumioPlay Jun 27 09:41:24 volumio volumio[1173]: verbose: UNSET VOLATILE: Service: ytcr Jun 27 09:41:24 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:41:24 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:24 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 09:41:24 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:24 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:41:24 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:24 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:24 volumio volumio[1173]: info: [yt-cast-receiver] Player.stop() Jun 27 09:41:24 volumio volumio[1173]: info: CoreStateMachine::play index 4 Jun 27 09:41:24 volumio volumio[1173]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 09:41:24 volumio volumio[1173]: info: CoreStateMachine::stop Jun 27 09:41:24 volumio volumio[1173]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 09:41:24 volumio volumio[1173]: info: CoreStateMachine::updateTrackBlock Jun 27 09:41:24 volumio volumio[1173]: info: CorePlayQueue::getTrackBlock Jun 27 09:41:24 volumio volumio[1173]: info: CoreStateMachine::stPlaybackTimer Jun 27 09:41:24 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:24 volumio volumio[1173]: info: CorePlayQueue::getTrack 0 Jun 27 09:41:24 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 09:41:24 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:24 volumio volumio[1173]: info: CoreStateMachine::serviceStop Jun 27 09:41:24 volumio volumio[1173]: info: CorePlayQueue::getTrack 0 Jun 27 09:41:24 volumio volumio[1173]: info: CoreCommandRouter::serviceStop Jun 27 09:41:24 volumio volumio[1173]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 27 09:41:24 volumio volumio[1173]: info: ControllerMpd::stop Jun 27 09:41:24 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand stop Jun 27 09:41:24 volumio mpd[1354]: player: played "https://rr3---sn-25ge7nsd.googlevideo.com/videoplayback?expire=1751031611&ei=20peaPr_DamJvdIPqPX2qA4&ip=82.64.168.45&id=o-AGpLOW4tsFzE_kdcMTyWQVBGMIfOkoLdzDHuD2X-vwT-&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751010011%2C&mh=_m&mm=31%2C26&mn=sn-25ge7nsd%2Csn-4g5edndr&ms=au%2Conr&mv=m&mvi=3&pl=22&rms=au%2Cau&ctier=A&pfa=5&gcr=fr&initcwndbps=2850000&hightc=yes&siu=1&bui=AY1jyLNXIPd-l8FwCSJzzQJCmziaPbobV5JvbmvDGAtZhaE7JA9LSf0Qi2dvlR3_Ya_lctm8vw&spc=l3OVKeYam8GOUza9I7XbQ79R_wYKylrmAVZnmxAStpxSzWw9oBwSRb6-3ajzZl9MoHmUVpPp7i9JchQ&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=SiyCdydKD6j5ChZUq2Nem8sQ&rqh=1&gir=yes&clen=7690604&dur=238.842&lmt=1685059036441625&mt=1751009566&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2318224&n=buKpUPuiSYzV0Q&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAOdZkp7CQe9jhTYheupyqcWqSjoVsd3BhB0wpLLxOZlnAiBsfivtrNFILSAJtkrHv6SWaGuIbhAs2PpjAvNWF_EYIw%3D%3D&sig=AJfQdSswRAIgUSWcRq6uZFFirCPvKH4v80j-2shvHs_SmNetoTcRDRICICajJNLACMxE765o_q3t-JuniCvEjN44z5jPgUM5Hvi5&pot=MpgBDR_VFArdW6MNI8TZdjoxZcLgTezmMmPRDKxJgk3CE00PcEaLKxsDiQ-AzZLMNBowf7V8npJaIxjeKfp0IKecxr6w0mfbT_LOX3vDHmZXXIGVUW21y0Xfi5Ii1P0BpoA28gbsEjV965ROu_VG0lwdwCTsHu_5kvDdGUCzZvsd9X1zgmwtZrTSjUqubBQ-Lm3x9l1xNDfDT8M%3D&cver=1.20250219.01.00" Jun 27 09:41:24 volumio volumio[1173]: info: Jun 27 09:41:24 volumio volumio[1173]: ---------------------------- MPD announces state update: player Jun 27 09:41:24 volumio volumio[1173]: info: sendMpdCommand stop took 84 milliseconds Jun 27 09:41:24 volumio volumio[1173]: info: ControllerMpd::getState Jun 27 09:41:24 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand status Jun 27 09:41:24 volumio volumio[1173]: info: CoreStateMachine::play index undefined Jun 27 09:41:24 volumio volumio[1173]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 09:41:24 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:24 volumio volumio[1173]: info: CoreStateMachine::startPlaybackTimer Jun 27 09:41:24 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:24 volumio volumio[1173]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22EK_LN3XEcnw%22%2C%22playlistId%22%3A%22RDCLAK5uy_ntcUiXwCotEquRenyHqwAhPnj9Fs7M6x8%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A4%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Lou%20Bega%20-%20Mambo%20No.%205%20(A%20Little%20Bit%20of...)%22%2C%22artist%22%3A%22Lou%20Bega%20Official%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FEK_LN3XEcnw%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLAXA94-qDYAH6ay-VwcZI7M1e3ykQ%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22EK_LN3XEcnw%22%2C%22playlistId%22%3A%22RDCLAK5uy_ntcUiXwCotEquRenyHqwAhPnj9Fs7M6x8%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A4%7D%7D%7D Jun 27 09:41:24 volumio volumio[1173]: info: [youtube2] InnertubeLoader: creating Innertube instance... Jun 27 09:41:24 volumio volumio[1173]: info: sendMpdCommand status took 67 milliseconds Jun 27 09:41:24 volumio volumio[1173]: verbose: ControllerMpd::parseState Jun 27 09:41:24 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 09:41:24 volumio volumio[1173]: info: Jun 27 09:41:24 volumio volumio[1173]: ---------------------------- MPD announces state update: player Jun 27 09:41:24 volumio volumio[1173]: info: ControllerMpd::getState Jun 27 09:41:24 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand status Jun 27 09:41:24 volumio volumio[1173]: info: Jun 27 09:41:24 volumio volumio[1173]: ---------------------------- MPD announces state update: player Jun 27 09:41:24 volumio volumio[1173]: info: ControllerMpd::getState Jun 27 09:41:24 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand status Jun 27 09:41:24 volumio volumio[1173]: info: sendMpdCommand playlistinfo took 12 milliseconds Jun 27 09:41:24 volumio volumio[1173]: info: sendMpdCommand status took 14 milliseconds Jun 27 09:41:24 volumio volumio[1173]: info: sendMpdCommand status took 12 milliseconds Jun 27 09:41:24 volumio volumio[1173]: verbose: ControllerMpd::parseTrackInfo Jun 27 09:41:24 volumio volumio[1173]: verbose: ControllerMpd::parseState Jun 27 09:41:24 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 09:41:24 volumio volumio[1173]: verbose: ControllerMpd::parseState Jun 27 09:41:24 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 09:41:24 volumio volumio[1173]: info: ControllerMpd::pushState Jun 27 09:41:24 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:41:24 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:24 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:24 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 09:41:24 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:24 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:24 volumio volumio[1173]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Jun 27 09:41:25 volumio volumio[1173]: info: ------------------------------ 135ms Jun 27 09:41:25 volumio volumio[1173]: info: sendMpdCommand playlistinfo took 40 milliseconds Jun 27 09:41:25 volumio volumio[1173]: info: sendMpdCommand playlistinfo took 43 milliseconds Jun 27 09:41:25 volumio volumio[1173]: verbose: ControllerMpd::parseTrackInfo Jun 27 09:41:25 volumio volumio[1173]: verbose: ControllerMpd::parseTrackInfo Jun 27 09:41:25 volumio volumio[1173]: info: ControllerMpd::pushState Jun 27 09:41:25 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:41:25 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:25 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:25 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:25 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:25 volumio volumio[1173]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Jun 27 09:41:25 volumio volumio[1173]: info: ControllerMpd::pushState Jun 27 09:41:25 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:41:25 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:25 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:25 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:25 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:25 volumio volumio[1173]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Jun 27 09:41:25 volumio volumio[1173]: info: ------------------------------ 148ms Jun 27 09:41:25 volumio volumio[1173]: info: ------------------------------ 144ms Jun 27 09:41:25 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:25 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:30 volumio volumio[1173]: info: [youtube2] InnertubeLoader: obtaining po_token by visitorData... Jun 27 09:41:30 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 27 09:41:30 volumio volumio[1173]: info: CoreCommandRouter::volumioPlay Jun 27 09:41:30 volumio volumio[1173]: info: CoreStateMachine::play index undefined Jun 27 09:41:30 volumio volumio[1173]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 09:41:30 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:30 volumio volumio[1173]: info: CoreStateMachine::startPlaybackTimer Jun 27 09:41:30 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:30 volumio volumio[1173]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22EK_LN3XEcnw%22%2C%22playlistId%22%3A%22RDCLAK5uy_ntcUiXwCotEquRenyHqwAhPnj9Fs7M6x8%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A4%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Lou%20Bega%20-%20Mambo%20No.%205%20(A%20Little%20Bit%20of...)%22%2C%22artist%22%3A%22Lou%20Bega%20Official%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FEK_LN3XEcnw%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLAXA94-qDYAH6ay-VwcZI7M1e3ykQ%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22EK_LN3XEcnw%22%2C%22playlistId%22%3A%22RDCLAK5uy_ntcUiXwCotEquRenyHqwAhPnj9Fs7M6x8%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A4%7D%7D%7D Jun 27 09:41:31 volumio volumio[1173]: info: [youtube2] InnertubeLoader: obtained po_token (expires in 43200 seconds) Jun 27 09:41:31 volumio volumio[1173]: info: [youtube2] InnertubeLoader: re-create Innertube instance with po_token Jun 27 09:41:31 volumio volumio[1173]: info: [youtube2] InnertubeLoader: creating Innertube instance with po_token... Jun 27 09:41:33 volumio volumio[1173]: info: [youtube2] InnertubeLoader: going to refresh po_token in 43100 seconds Jun 27 09:41:34 volumio volumio[1173]: warn: [youtube2] Error getting stream with default client in VideoModel.getInfo(EK_LN3XEcnw): No valid URL to decipher - retry with 'WEB_EMBEDDED' client. Jun 27 09:41:34 volumio volumio[1173]: warn: [youtube2] Error getting stream with default client in VideoModel.getInfo(EK_LN3XEcnw): No valid URL to decipher - retry with 'WEB_EMBEDDED' client. Jun 27 09:41:34 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:34 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand stop Jun 27 09:41:34 volumio volumio[1173]: info: sendMpdCommand stop took 7 milliseconds Jun 27 09:41:34 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand clear Jun 27 09:41:34 volumio volumio[1173]: info: sendMpdCommand clear took 0 milliseconds Jun 27 09:41:34 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-25glenlr.googlevideo.com/videoplayback?expire=1751031694&ei=LkteaKLEMrmJ9fgPzMrGmQw&ip=82.64.168.45&id=o-AHUw22vqowUoCjhf8mfw-NpP8kGeGpC06XbU4jc1zILQ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751010094%2C&mh=iH&mm=31%2C26&mn=sn-25glenlr%2Csn-4g5e6nzz&ms=au%2Conr&mv=m&mvi=1&pl=22&rms=au%2Cau&initcwndbps=2831250&bui=AY1jyLM8fq3WJLcV5YxusH4worAOX01rMewXcSVaORKD1dl8s6simzsEQJR18ECApi6FM514NH7gZguY&spc=l3OVKdysMSnW1sXlqj_C8WTLLD5ql6HXivwVJ5JxTGDmSA8SZGkKcQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=NcVM1Er88rDHY1RGZFyvXq4Q&rqh=1&gir=yes&clen=3640663&dur=221.341&lmt=1728289679592830&mt=1751009810&fvip=5&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=fRi7SFF3nFTYIQ&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=APaTxxMwRQIgP_zcYNDoQB5rKkdhTuySE7HdUPg8S9EB7j7DM3IcssACIQC7PK7_T_oMfEqRE3ncm6Pws-DDUsMVRnqvaRRinBoAyA%3D%3D&sig=AJfQdSswRAIgBTYzJM5W4hdSoYkVLc-iwdVukhoBRjLzBTpLMdscLvACIGhmSqg3b1Hpjb1RjW8JHx16LYajSW-kc5lKzOAOYkcO&pot=MpgBeTpcVl_ViXR5Bl6pEQa-P3eykd-M0KkbXtYSQerG5020tZGDfDblpYgL5RArcynbTBESBqfkAGYCnMSW2y0tU7SUoAgsKe5Xp1ZNJVcQXE9qIGVcNz66fTIg4reo4KW1aQIYlo-71MJKUCiRFh_hK3A7WcG5208woTBPbUt5XSAE6ND1uYBKkT2FYyTlI6uxH6yWhxwQrl8%3D&cver=1.20250219.01.00&t.YouTube" Jun 27 09:41:34 volumio volumio[1173]: info: Jun 27 09:41:34 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:34 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:34 volumio volumio[1173]: info: Jun 27 09:41:34 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:34 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:34 volumio volumio[1173]: info: Jun 27 09:41:34 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:34 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:34 volumio volumio[1173]: info: Jun 27 09:41:34 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:34 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:34 volumio volumio[1173]: info: sendMpdCommand addid "https://rr1---sn-25glenlr.googlevideo.com/videoplayback?expire=1751031694&ei=LkteaKLEMrmJ9fgPzMrGmQw&ip=82.64.168.45&id=o-AHUw22vqowUoCjhf8mfw-NpP8kGeGpC06XbU4jc1zILQ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751010094%2C&mh=iH&mm=31%2C26&mn=sn-25glenlr%2Csn-4g5e6nzz&ms=au%2Conr&mv=m&mvi=1&pl=22&rms=au%2Cau&initcwndbps=2831250&bui=AY1jyLM8fq3WJLcV5YxusH4worAOX01rMewXcSVaORKD1dl8s6simzsEQJR18ECApi6FM514NH7gZguY&spc=l3OVKdysMSnW1sXlqj_C8WTLLD5ql6HXivwVJ5JxTGDmSA8SZGkKcQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=NcVM1Er88rDHY1RGZFyvXq4Q&rqh=1&gir=yes&clen=3640663&dur=221.341&lmt=1728289679592830&mt=1751009810&fvip=5&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=fRi7SFF3nFTYIQ&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=APaTxxMwRQIgP_zcYNDoQB5rKkdhTuySE7HdUPg8S9EB7j7DM3IcssACIQC7PK7_T_oMfEqRE3ncm6Pws-DDUsMVRnqvaRRinBoAyA%3D%3D&sig=AJfQdSswRAIgBTYzJM5W4hdSoYkVLc-iwdVukhoBRjLzBTpLMdscLvACIGhmSqg3b1Hpjb1RjW8JHx16LYajSW-kc5lKzOAOYkcO&pot=MpgBeTpcVl_ViXR5Bl6pEQa-P3eykd-M0KkbXtYSQerG5020tZGDfDblpYgL5RArcynbTBESBqfkAGYCnMSW2y0tU7SUoAgsKe5Xp1ZNJVcQXE9qIGVcNz66fTIg4reo4KW1aQIYlo-71MJKUCiRFh_hK3A7WcG5208woTBPbUt5XSAE6ND1uYBKkT2FYyTlI6uxH6yWhxwQrl8%3D&cver=1.20250219.01.00&t.YouTube" took 5 milliseconds Jun 27 09:41:34 volumio volumio[1173]: info: ------------------------------ 4ms Jun 27 09:41:34 volumio volumio[1173]: info: ------------------------------ 3ms Jun 27 09:41:34 volumio volumio[1173]: verbose: MPD COMMAND [object Object] Jun 27 09:41:34 volumio volumio[1173]: verbose: MPD COMMAND [object Object] Jun 27 09:41:34 volumio volumio[1173]: verbose: MPD COMMAND [object Object] Jun 27 09:41:34 volumio volumio[1173]: info: Jun 27 09:41:34 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:34 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:34 volumio volumio[1173]: info: Jun 27 09:41:34 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:34 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:34 volumio volumio[1173]: info: Jun 27 09:41:34 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:34 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:34 volumio volumio[1173]: info: ------------------------------ 8ms Jun 27 09:41:34 volumio volumio[1173]: info: ------------------------------ 7ms Jun 27 09:41:34 volumio volumio[1173]: info: ------------------------------ 3ms Jun 27 09:41:34 volumio volumio[1173]: info: ------------------------------ 3ms Jun 27 09:41:34 volumio volumio[1173]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 27 09:41:34 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand play Jun 27 09:41:34 volumio volumio[1173]: info: Jun 27 09:41:34 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:34 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:34 volumio volumio[1173]: info: Jun 27 09:41:34 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:34 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:34 volumio volumio[1173]: info: ------------------------------ 6ms Jun 27 09:41:34 volumio volumio[1173]: info: sendMpdCommand play took 4 milliseconds Jun 27 09:41:34 volumio volumio[1173]: info: ------------------------------ 3ms Jun 27 09:41:34 volumio volumio[1173]: info: ------------------------------ 8ms Jun 27 09:41:34 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 09:41:34 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 09:41:34 volumio volumio[1173]: info: Discovery: Getting this device information Jun 27 09:41:34 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:34 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 09:41:34 volumio volumio[1173]: verbose: New Socket.io Connection to 192.168.1.65:3000 from 192.168.1.9 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Jun 27 09:41:34 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:34 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 27 09:41:34 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand stop Jun 27 09:41:35 volumio mpd[1354]: player: played "https://rr1---sn-25glenlr.googlevideo.com/videoplayback?expire=1751031694&ei=LkteaKLEMrmJ9fgPzMrGmQw&ip=82.64.168.45&id=o-AHUw22vqowUoCjhf8mfw-NpP8kGeGpC06XbU4jc1zILQ&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751010094%2C&mh=iH&mm=31%2C26&mn=sn-25glenlr%2Csn-4g5e6nzz&ms=au%2Conr&mv=m&mvi=1&pl=22&rms=au%2Cau&initcwndbps=2831250&bui=AY1jyLM8fq3WJLcV5YxusH4worAOX01rMewXcSVaORKD1dl8s6simzsEQJR18ECApi6FM514NH7gZguY&spc=l3OVKdysMSnW1sXlqj_C8WTLLD5ql6HXivwVJ5JxTGDmSA8SZGkKcQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=NcVM1Er88rDHY1RGZFyvXq4Q&rqh=1&gir=yes&clen=3640663&dur=221.341&lmt=1728289679592830&mt=1751009810&fvip=5&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=fRi7SFF3nFTYIQ&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=APaTxxMwRQIgP_zcYNDoQB5rKkdhTuySE7HdUPg8S9EB7j7DM3IcssACIQC7PK7_T_oMfEqRE3ncm6Pws-DDUsMVRnqvaRRinBoAyA%3D%3D&sig=AJfQdSswRAIgBTYzJM5W4hdSoYkVLc-iwdVukhoBRjLzBTpLMdscLvACIGhmSqg3b1Hpjb1RjW8JHx16LYajSW-kc5lKzOAOYkcO&pot=MpgBeTpcVl_ViXR5Bl6pEQa-P3eykd-M0KkbXtYSQerG5020tZGDfDblpYgL5RArcynbTBESBqfkAGYCnMSW2y0tU7SUoAgsKe5Xp1ZNJVcQXE9qIGVcNz66fTIg4reo4KW1aQIYlo-71MJKUCiRFh_hK3A7WcG5208woTBPbUt5XSAE6ND1uYBKkT2FYyTlI6uxH6yWhxwQrl8%3D&cver=1.20250219.01.00&t.YouTube" Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces state update: player Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand stop took 100 milliseconds Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::getState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand status Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand clear Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:35 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand status took 1 milliseconds Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand clear took 1 milliseconds Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-25glenlr.googlevideo.com/videoplayback?expire=1751031694&ei=LkteaIaeNp75vdIPm-Xm-AU&ip=82.64.168.45&id=o-AJuHmO8Qo5zWNp_IkPFYs-hWu7DgAg20N6FAqifxBlWt&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751010094%2C&mh=iH&mm=31%2C29&mn=sn-25glenlr%2Csn-25ge7nsk&ms=au%2Crdu&mv=m&mvi=1&pl=22&rms=au%2Cau&initcwndbps=2801250&bui=AY1jyLMi2BMG-HXR0Iaw8dyQyP62eyBj5po4eMcJGA0DFIRwvuDacHE5RCvsTNnG_8s6biTnKNn2XFAo&spc=l3OVKUdKV6-pnKtQtq_WA_ZzSsCjnyqklKZxRe8ab2ka_dIbKV0zNQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1wKwe1UiiHJFL0g7R4jsJ9gQ&rqh=1&gir=yes&clen=3640663&dur=221.341&lmt=1728289679592830&mt=1751009566&fvip=4&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=E8zAJuGIi2kp8g&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=APaTxxMwRAIgJ-cQm8C1dk8BouGwHV5Ooqjx4VkO3A-MEaWdVAX20ZUCIGL2aaCNBEVP_kWL5mkOFxOWY77qeM0aYY7IAtyZRSdW&sig=AJfQdSswRgIhAOQRdX-o0BKOmjBWC7hqiprQ19LV_WRgIjnb_wEgqhVjAiEAh8DK_5DBS_xQ3UQeG0jKfKDSJZaGJj5o-gXYVkr6GUM%3D&pot=MpgBeTpcVl_ViXR5Bl6pEQa-P3eykd-M0KkbXtYSQerG5020tZGDfDblpYgL5RArcynbTBESBqfkAGYCnMSW2y0tU7SUoAgsKe5Xp1ZNJVcQXE9qIGVcNz66fTIg4reo4KW1aQIYlo-71MJKUCiRFh_hK3A7WcG5208woTBPbUt5XSAE6ND1uYBKkT2FYyTlI6uxH6yWhxwQrl8%3D&cver=1.20250219.01.00&t.YouTube" Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces state update: player Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::getState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand status Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces state update: player Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::getState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand status Jun 27 09:41:35 volumio volumio[1173]: error: updateQueue error: null Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:35 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 5ms Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand addid "https://rr1---sn-25glenlr.googlevideo.com/videoplayback?expire=1751031694&ei=LkteaIaeNp75vdIPm-Xm-AU&ip=82.64.168.45&id=o-AJuHmO8Qo5zWNp_IkPFYs-hWu7DgAg20N6FAqifxBlWt&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751010094%2C&mh=iH&mm=31%2C29&mn=sn-25glenlr%2Csn-25ge7nsk&ms=au%2Crdu&mv=m&mvi=1&pl=22&rms=au%2Cau&initcwndbps=2801250&bui=AY1jyLMi2BMG-HXR0Iaw8dyQyP62eyBj5po4eMcJGA0DFIRwvuDacHE5RCvsTNnG_8s6biTnKNn2XFAo&spc=l3OVKUdKV6-pnKtQtq_WA_ZzSsCjnyqklKZxRe8ab2ka_dIbKV0zNQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1wKwe1UiiHJFL0g7R4jsJ9gQ&rqh=1&gir=yes&clen=3640663&dur=221.341&lmt=1728289679592830&mt=1751009566&fvip=4&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=E8zAJuGIi2kp8g&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=APaTxxMwRAIgJ-cQm8C1dk8BouGwHV5Ooqjx4VkO3A-MEaWdVAX20ZUCIGL2aaCNBEVP_kWL5mkOFxOWY77qeM0aYY7IAtyZRSdW&sig=AJfQdSswRgIhAOQRdX-o0BKOmjBWC7hqiprQ19LV_WRgIjnb_wEgqhVjAiEAh8DK_5DBS_xQ3UQeG0jKfKDSJZaGJj5o-gXYVkr6GUM%3D&pot=MpgBeTpcVl_ViXR5Bl6pEQa-P3eykd-M0KkbXtYSQerG5020tZGDfDblpYgL5RArcynbTBESBqfkAGYCnMSW2y0tU7SUoAgsKe5Xp1ZNJVcQXE9qIGVcNz66fTIg4reo4KW1aQIYlo-71MJKUCiRFh_hK3A7WcG5208woTBPbUt5XSAE6ND1uYBKkT2FYyTlI6uxH6yWhxwQrl8%3D&cver=1.20250219.01.00&t.YouTube" took 3 milliseconds Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand status took 2 milliseconds Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand status took 2 milliseconds Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseTrackInfo Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseState Jun 27 09:41:35 volumio volumio[1173]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jun 27 09:41:35 volumio volumio[1173]: verbose: MPD COMMAND [object Object] Jun 27 09:41:35 volumio volumio[1173]: verbose: MPD COMMAND [object Object] Jun 27 09:41:35 volumio volumio[1173]: verbose: MPD COMMAND [object Object] Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:35 volumio volumio[1173]: 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} Jun 27 09:41:35 volumio volumio[1173]: verbose: CURRENT POSITION 4 Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState stateService stop Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState currentStatus stop Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: No code Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:35 volumio volumio[1173]: 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} Jun 27 09:41:35 volumio volumio[1173]: verbose: CURRENT POSITION 4 Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState stateService stop Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState currentStatus stop Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: No code Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 19ms Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 37ms Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 37ms Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:35 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:35 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:35 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 40ms Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 4ms Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 3ms Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand play Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:35 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces system playlist update Jun 27 09:41:35 volumio volumio[1173]: info: Ignoring MPD Status Update Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 13ms Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand play took 13 milliseconds Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 12ms Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 12ms Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:35 volumio mpd[1354]: ffmpeg/opus: Could not update timestamps for skipped samples. Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces state update: player Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::getState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand status Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces state update: player Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::getState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand status Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces state update: player Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces state update: player Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::getState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand status Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand status took 3 milliseconds Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::getState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand status Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces state update: player Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::getState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand status Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand status took 5 milliseconds Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand status took 4 milliseconds Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand status took 4 milliseconds Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand status took 2 milliseconds Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseTrackInfo Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:41:35 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:35 volumio volumio[1173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Lou Bega - Mambo No. 5 (A Little Bit of...)","artist":"LouBegaVEVO","album":"YouTube","uri":"https://rr1---sn-25glenlr.googlevideo.com/videoplayback?expire=1751031694&ei=LkteaIaeNp75vdIPm-Xm-AU&ip=82.64.168.45&id=o-AJuHmO8Qo5zWNp_IkPFYs-hWu7DgAg20N6FAqifxBlWt&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751010094%2C&mh=iH&mm=31%2C29&mn=sn-25glenlr%2Csn-25ge7nsk&ms=au%2Crdu&mv=m&mvi=1&pl=22&rms=au%2Cau&initcwndbps=2801250&bui=AY1jyLMi2BMG-HXR0Iaw8dyQyP62eyBj5po4eMcJGA0DFIRwvuDacHE5RCvsTNnG_8s6biTnKNn2XFAo&spc=l3OVKUdKV6-pnKtQtq_WA_ZzSsCjnyqklKZxRe8ab2ka_dIbKV0zNQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1wKwe1UiiHJFL0g7R4jsJ9gQ&rqh=1&gir=yes&clen=3640663&dur=221.341&lmt=1728289679592830&mt=1751009566&fvip=4&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=E8zAJuGIi2kp8g&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=APaTxxMwRAIgJ-cQm8C1dk8BouGwHV5Ooqjx4VkO3A-MEaWdVAX20ZUCIGL2aaCNBEVP_kWL5mkOFxOWY77qeM0aYY7IAtyZRSdW&sig=AJfQdSswRgIhAOQRdX-o0BKOmjBWC7hqiprQ19LV_WRgIjnb_wEgqhVjAiEAh8DK_5DBS_xQ3UQeG0jKfKDSJZaGJj5o-gXYVkr6GUM%3D&pot=MpgBeTpcVl_ViXR5Bl6pEQa-P3eykd-M0KkbXtYSQerG5020tZGDfDblpYgL5RArcynbTBESBqfkAGYCnMSW2y0tU7SUoAgsKe5Xp1ZNJVcQXE9qIGVcNz66fTIg4reo4KW1aQIYlo-71MJKUCiRFh_hK3A7WcG5208woTBPbUt5XSAE6ND1uYBKkT2FYyTlI6uxH6yWhxwQrl8%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 27 09:41:35 volumio volumio[1173]: verbose: CURRENT POSITION 4 Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState stateService play Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState currentStatus stop Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 11ms Jun 27 09:41:35 volumio volumio[1173]: info: Jun 27 09:41:35 volumio volumio[1173]: ---------------------------- MPD announces state update: player Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::getState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand status Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand status took 1 milliseconds Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseTrackInfo Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseTrackInfo Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseTrackInfo Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseTrackInfo Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseState Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:41:35 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:35 volumio volumio[1173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Lou Bega - Mambo No. 5 (A Little Bit of...)","artist":"LouBegaVEVO","album":"YouTube","uri":"https://rr1---sn-25glenlr.googlevideo.com/videoplayback?expire=1751031694&ei=LkteaIaeNp75vdIPm-Xm-AU&ip=82.64.168.45&id=o-AJuHmO8Qo5zWNp_IkPFYs-hWu7DgAg20N6FAqifxBlWt&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751010094%2C&mh=iH&mm=31%2C29&mn=sn-25glenlr%2Csn-25ge7nsk&ms=au%2Crdu&mv=m&mvi=1&pl=22&rms=au%2Cau&initcwndbps=2801250&bui=AY1jyLMi2BMG-HXR0Iaw8dyQyP62eyBj5po4eMcJGA0DFIRwvuDacHE5RCvsTNnG_8s6biTnKNn2XFAo&spc=l3OVKUdKV6-pnKtQtq_WA_ZzSsCjnyqklKZxRe8ab2ka_dIbKV0zNQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1wKwe1UiiHJFL0g7R4jsJ9gQ&rqh=1&gir=yes&clen=3640663&dur=221.341&lmt=1728289679592830&mt=1751009566&fvip=4&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=E8zAJuGIi2kp8g&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=APaTxxMwRAIgJ-cQm8C1dk8BouGwHV5Ooqjx4VkO3A-MEaWdVAX20ZUCIGL2aaCNBEVP_kWL5mkOFxOWY77qeM0aYY7IAtyZRSdW&sig=AJfQdSswRgIhAOQRdX-o0BKOmjBWC7hqiprQ19LV_WRgIjnb_wEgqhVjAiEAh8DK_5DBS_xQ3UQeG0jKfKDSJZaGJj5o-gXYVkr6GUM%3D&pot=MpgBeTpcVl_ViXR5Bl6pEQa-P3eykd-M0KkbXtYSQerG5020tZGDfDblpYgL5RArcynbTBESBqfkAGYCnMSW2y0tU7SUoAgsKe5Xp1ZNJVcQXE9qIGVcNz66fTIg4reo4KW1aQIYlo-71MJKUCiRFh_hK3A7WcG5208woTBPbUt5XSAE6ND1uYBKkT2FYyTlI6uxH6yWhxwQrl8%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 27 09:41:35 volumio volumio[1173]: verbose: CURRENT POSITION 4 Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState stateService play Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState currentStatus play Jun 27 09:41:35 volumio volumio[1173]: info: Received an update from plugin. extracting info from payload Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:41:35 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:35 volumio volumio[1173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Lou Bega - Mambo No. 5 (A Little Bit of...)","artist":"LouBegaVEVO","album":"YouTube","uri":"https://rr1---sn-25glenlr.googlevideo.com/videoplayback?expire=1751031694&ei=LkteaIaeNp75vdIPm-Xm-AU&ip=82.64.168.45&id=o-AJuHmO8Qo5zWNp_IkPFYs-hWu7DgAg20N6FAqifxBlWt&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751010094%2C&mh=iH&mm=31%2C29&mn=sn-25glenlr%2Csn-25ge7nsk&ms=au%2Crdu&mv=m&mvi=1&pl=22&rms=au%2Cau&initcwndbps=2801250&bui=AY1jyLMi2BMG-HXR0Iaw8dyQyP62eyBj5po4eMcJGA0DFIRwvuDacHE5RCvsTNnG_8s6biTnKNn2XFAo&spc=l3OVKUdKV6-pnKtQtq_WA_ZzSsCjnyqklKZxRe8ab2ka_dIbKV0zNQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1wKwe1UiiHJFL0g7R4jsJ9gQ&rqh=1&gir=yes&clen=3640663&dur=221.341&lmt=1728289679592830&mt=1751009566&fvip=4&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=E8zAJuGIi2kp8g&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=APaTxxMwRAIgJ-cQm8C1dk8BouGwHV5Ooqjx4VkO3A-MEaWdVAX20ZUCIGL2aaCNBEVP_kWL5mkOFxOWY77qeM0aYY7IAtyZRSdW&sig=AJfQdSswRgIhAOQRdX-o0BKOmjBWC7hqiprQ19LV_WRgIjnb_wEgqhVjAiEAh8DK_5DBS_xQ3UQeG0jKfKDSJZaGJj5o-gXYVkr6GUM%3D&pot=MpgBeTpcVl_ViXR5Bl6pEQa-P3eykd-M0KkbXtYSQerG5020tZGDfDblpYgL5RArcynbTBESBqfkAGYCnMSW2y0tU7SUoAgsKe5Xp1ZNJVcQXE9qIGVcNz66fTIg4reo4KW1aQIYlo-71MJKUCiRFh_hK3A7WcG5208woTBPbUt5XSAE6ND1uYBKkT2FYyTlI6uxH6yWhxwQrl8%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 27 09:41:35 volumio volumio[1173]: verbose: CURRENT POSITION 4 Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState stateService play Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState currentStatus play Jun 27 09:41:35 volumio volumio[1173]: info: Received an update from plugin. extracting info from payload Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:41:35 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:35 volumio volumio[1173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Lou Bega - Mambo No. 5 (A Little Bit of...)","artist":"LouBegaVEVO","album":"YouTube","uri":"https://rr1---sn-25glenlr.googlevideo.com/videoplayback?expire=1751031694&ei=LkteaIaeNp75vdIPm-Xm-AU&ip=82.64.168.45&id=o-AJuHmO8Qo5zWNp_IkPFYs-hWu7DgAg20N6FAqifxBlWt&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751010094%2C&mh=iH&mm=31%2C29&mn=sn-25glenlr%2Csn-25ge7nsk&ms=au%2Crdu&mv=m&mvi=1&pl=22&rms=au%2Cau&initcwndbps=2801250&bui=AY1jyLMi2BMG-HXR0Iaw8dyQyP62eyBj5po4eMcJGA0DFIRwvuDacHE5RCvsTNnG_8s6biTnKNn2XFAo&spc=l3OVKUdKV6-pnKtQtq_WA_ZzSsCjnyqklKZxRe8ab2ka_dIbKV0zNQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1wKwe1UiiHJFL0g7R4jsJ9gQ&rqh=1&gir=yes&clen=3640663&dur=221.341&lmt=1728289679592830&mt=1751009566&fvip=4&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=E8zAJuGIi2kp8g&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=APaTxxMwRAIgJ-cQm8C1dk8BouGwHV5Ooqjx4VkO3A-MEaWdVAX20ZUCIGL2aaCNBEVP_kWL5mkOFxOWY77qeM0aYY7IAtyZRSdW&sig=AJfQdSswRgIhAOQRdX-o0BKOmjBWC7hqiprQ19LV_WRgIjnb_wEgqhVjAiEAh8DK_5DBS_xQ3UQeG0jKfKDSJZaGJj5o-gXYVkr6GUM%3D&pot=MpgBeTpcVl_ViXR5Bl6pEQa-P3eykd-M0KkbXtYSQerG5020tZGDfDblpYgL5RArcynbTBESBqfkAGYCnMSW2y0tU7SUoAgsKe5Xp1ZNJVcQXE9qIGVcNz66fTIg4reo4KW1aQIYlo-71MJKUCiRFh_hK3A7WcG5208woTBPbUt5XSAE6ND1uYBKkT2FYyTlI6uxH6yWhxwQrl8%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 27 09:41:35 volumio volumio[1173]: verbose: CURRENT POSITION 4 Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState stateService play Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState currentStatus play Jun 27 09:41:35 volumio volumio[1173]: info: Received an update from plugin. extracting info from payload Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:41:35 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:35 volumio volumio[1173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Lou Bega - Mambo No. 5 (A Little Bit of...)","artist":"LouBegaVEVO","album":"YouTube","uri":"https://rr1---sn-25glenlr.googlevideo.com/videoplayback?expire=1751031694&ei=LkteaIaeNp75vdIPm-Xm-AU&ip=82.64.168.45&id=o-AJuHmO8Qo5zWNp_IkPFYs-hWu7DgAg20N6FAqifxBlWt&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751010094%2C&mh=iH&mm=31%2C29&mn=sn-25glenlr%2Csn-25ge7nsk&ms=au%2Crdu&mv=m&mvi=1&pl=22&rms=au%2Cau&initcwndbps=2801250&bui=AY1jyLMi2BMG-HXR0Iaw8dyQyP62eyBj5po4eMcJGA0DFIRwvuDacHE5RCvsTNnG_8s6biTnKNn2XFAo&spc=l3OVKUdKV6-pnKtQtq_WA_ZzSsCjnyqklKZxRe8ab2ka_dIbKV0zNQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1wKwe1UiiHJFL0g7R4jsJ9gQ&rqh=1&gir=yes&clen=3640663&dur=221.341&lmt=1728289679592830&mt=1751009566&fvip=4&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=E8zAJuGIi2kp8g&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=APaTxxMwRAIgJ-cQm8C1dk8BouGwHV5Ooqjx4VkO3A-MEaWdVAX20ZUCIGL2aaCNBEVP_kWL5mkOFxOWY77qeM0aYY7IAtyZRSdW&sig=AJfQdSswRgIhAOQRdX-o0BKOmjBWC7hqiprQ19LV_WRgIjnb_wEgqhVjAiEAh8DK_5DBS_xQ3UQeG0jKfKDSJZaGJj5o-gXYVkr6GUM%3D&pot=MpgBeTpcVl_ViXR5Bl6pEQa-P3eykd-M0KkbXtYSQerG5020tZGDfDblpYgL5RArcynbTBESBqfkAGYCnMSW2y0tU7SUoAgsKe5Xp1ZNJVcQXE9qIGVcNz66fTIg4reo4KW1aQIYlo-71MJKUCiRFh_hK3A7WcG5208woTBPbUt5XSAE6ND1uYBKkT2FYyTlI6uxH6yWhxwQrl8%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 27 09:41:35 volumio volumio[1173]: verbose: CURRENT POSITION 4 Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState stateService play Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState currentStatus play Jun 27 09:41:35 volumio volumio[1173]: info: Received an update from plugin. extracting info from payload Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 60ms Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 59ms Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 59ms Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 57ms Jun 27 09:41:35 volumio volumio[1173]: info: sendMpdCommand playlistinfo took 50 milliseconds Jun 27 09:41:35 volumio volumio[1173]: verbose: ControllerMpd::parseTrackInfo Jun 27 09:41:35 volumio volumio[1173]: info: ControllerMpd::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Jun 27 09:41:35 volumio volumio[1173]: info: CorePlayQueue::getTrack 4 Jun 27 09:41:35 volumio volumio[1173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Lou Bega - Mambo No. 5 (A Little Bit of...)","artist":"LouBegaVEVO","album":"YouTube","uri":"https://rr1---sn-25glenlr.googlevideo.com/videoplayback?expire=1751031694&ei=LkteaIaeNp75vdIPm-Xm-AU&ip=82.64.168.45&id=o-AJuHmO8Qo5zWNp_IkPFYs-hWu7DgAg20N6FAqifxBlWt&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1751010094%2C&mh=iH&mm=31%2C29&mn=sn-25glenlr%2Csn-25ge7nsk&ms=au%2Crdu&mv=m&mvi=1&pl=22&rms=au%2Cau&initcwndbps=2801250&bui=AY1jyLMi2BMG-HXR0Iaw8dyQyP62eyBj5po4eMcJGA0DFIRwvuDacHE5RCvsTNnG_8s6biTnKNn2XFAo&spc=l3OVKUdKV6-pnKtQtq_WA_ZzSsCjnyqklKZxRe8ab2ka_dIbKV0zNQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1wKwe1UiiHJFL0g7R4jsJ9gQ&rqh=1&gir=yes&clen=3640663&dur=221.341&lmt=1728289679592830&mt=1751009566&fvip=4&keepalive=yes&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=E8zAJuGIi2kp8g&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=APaTxxMwRAIgJ-cQm8C1dk8BouGwHV5Ooqjx4VkO3A-MEaWdVAX20ZUCIGL2aaCNBEVP_kWL5mkOFxOWY77qeM0aYY7IAtyZRSdW&sig=AJfQdSswRgIhAOQRdX-o0BKOmjBWC7hqiprQ19LV_WRgIjnb_wEgqhVjAiEAh8DK_5DBS_xQ3UQeG0jKfKDSJZaGJj5o-gXYVkr6GUM%3D&pot=MpgBeTpcVl_ViXR5Bl6pEQa-P3eykd-M0KkbXtYSQerG5020tZGDfDblpYgL5RArcynbTBESBqfkAGYCnMSW2y0tU7SUoAgsKe5Xp1ZNJVcQXE9qIGVcNz66fTIg4reo4KW1aQIYlo-71MJKUCiRFh_hK3A7WcG5208woTBPbUt5XSAE6ND1uYBKkT2FYyTlI6uxH6yWhxwQrl8%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 27 09:41:35 volumio volumio[1173]: verbose: CURRENT POSITION 4 Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState stateService play Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::syncState currentStatus play Jun 27 09:41:35 volumio volumio[1173]: info: Received an update from plugin. extracting info from payload Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreStateMachine::pushState Jun 27 09:41:35 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Jun 27 09:41:35 volumio volumio[1173]: info: ------------------------------ 62ms Jun 27 09:41:36 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:37 volumio sudo[2224]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 27 09:41:37 volumio sudo[2224]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 27 09:41:37 volumio sudo[2224]: pam_unix(sudo:session): session closed for user root Jun 27 09:41:37 volumio sudo[2226]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 27 09:41:37 volumio sudo[2226]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 27 09:41:37 volumio sudo[2226]: pam_unix(sudo:session): session closed for user root Jun 27 09:41:37 volumio volumio[1173]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.9 UA: Mozilla/5.0 (Linux; Android 14; RMX3834 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jun 27 09:41:37 volumio sudo[2231]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 27 09:41:37 volumio sudo[2231]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 27 09:41:37 volumio sudo[2231]: pam_unix(sudo:session): session closed for user root Jun 27 09:41:37 volumio sudo[2233]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 27 09:41:37 volumio sudo[2233]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 27 09:41:37 volumio sudo[2233]: pam_unix(sudo:session): session closed for user root Jun 27 09:41:38 volumio volumio[1173]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.9 UA: Mozilla/5.0 (Linux; Android 14; RMX3834 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jun 27 09:41:38 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 27 09:41:38 volumio volumio[1173]: info: CoreCommandRouter::volumioGetVisibleSources Jun 27 09:41:38 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 09:41:38 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:38 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 27 09:41:38 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 27 09:41:38 volumio volumio[1173]: info: Received Get System Info Jun 27 09:41:38 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 09:41:38 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 09:41:38 volumio volumio[1173]: info: Discovery: Getting this device information Jun 27 09:41:38 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:38 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 09:41:38 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:38 volumio volumio[1173]: info: Listing playlists Jun 27 09:41:38 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 27 09:41:38 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 27 09:41:38 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 27 09:41:38 volumio volumio[1173]: error: error Jun 27 09:41:39 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 27 09:41:39 volumio volumio[1173]: info: Received Get System Info Jun 27 09:41:39 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 09:41:39 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 09:41:39 volumio volumio[1173]: info: Discovery: Getting this device information Jun 27 09:41:39 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:39 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 09:41:39 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 27 09:41:40 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 27 09:41:40 volumio volumio[1173]: info: Received Get System Info Jun 27 09:41:40 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 09:41:40 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 09:41:40 volumio volumio[1173]: info: Discovery: Getting this device information Jun 27 09:41:40 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Jun 27 09:41:40 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 09:41:41 volumio volumio[1173]: info: CoreCommandRouter::volumioGetQueue Jun 27 09:41:41 volumio volumio[1173]: info: CoreStateMachine::getQueue Jun 27 09:41:41 volumio volumio[1173]: info: CorePlayQueue::getQueue Jun 27 09:41:42 volumio (udev-worker)[1633]: pcmC5D0p: Spawned process '/bin/bash -c '/usr/local/bin/volumio usbdetach'' [2033] is taking longer than 59s to complete Jun 27 09:41:42 volumio systemd-udevd[365]: pcmC5D0p: Worker [1633] processing SEQNUM=2448 is taking a long time Jun 27 09:41:42 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 27 09:41:42 volumio dbus-daemon[696]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.30' (uid=0 pid=2264 comm="timedatectl show --property=NTPSynchronized --valu") Jun 27 09:41:42 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 27 09:41:43 volumio dbus-daemon[696]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 27 09:41:43 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 27 09:41:43 volumio setdatetime-helper.sh[2263]: Time is not synchronized. Attempting to sync... Jun 27 09:41:43 volumio sudo[2274]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Fri, 27 Jun 2025 07:41:43 GMT#015' Jun 27 09:41:43 volumio sudo[2274]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 27 09:41:43 volumio setdatetime-helper.sh[2275]: Fri Jun 27 09:41:43 CEST 2025 Jun 27 09:41:43 volumio setdatetime-helper.sh[2263]: Time synchronized successfully. Jun 27 09:41:43 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 27 09:41:43 volumio sudo[2274]: pam_unix(sudo:session): session closed for user root Jun 27 09:41:43 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 27 09:41:43 volumio systemd-journald[341]: Time jumped backwards, rotating. Jun 27 09:41:44 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 27 09:41:44 volumio volumio[1173]: info: Preload queue cleared Jun 27 09:41:47 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 27 09:41:47 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 27 09:41:48 volumio volumio[1173]: Use XMLElement.setAttribute instead Jun 27 09:41:48 volumio volumio[1173]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 27 09:41:48 volumio volumio[1173]: TypeError: children[i].attr(...).value is not a function Jun 27 09:41:48 volumio volumio[1173]: at /volumio/app/plugins/music_service/webradio/index.js:428:46 Jun 27 09:41:48 volumio volumio[1173]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jun 27 09:41:48 volumio volumio[1173]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 27 09:41:48 volumio sudo[2301]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-27 09:40' Jun 27 09:41:48 volumio sudo[2301]: 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"