Apr 12 10:43:01 volumio volumio[4674]: info: [ytcr] Innertube support service: result: {"status":"started","server":{"address":"127.0.0.1","port":43363}} Apr 12 10:43:01 volumio volumio[4674]: info: [ytcr] Innertube support service running at http://127.0.0.1:43363 Apr 12 10:43:05 volumio volumio[4674]: info: [ytcr] Obtained session PO token using visitorData (expires in 43199 seconds) Apr 12 10:43:05 volumio volumio[4674]: info: [ytcr] Going to refresh session PO token in 43099 seconds Apr 12 10:43:05 volumio volumio[4674]: info: [ytcr] Obtained PO token for video #nsz79iv_5h0: MlxLslwd90s1D0v3RReZRMyVaGvwZboND-5lozkgJqEkgqfsQi6DF5XaxssQhILotlHXETm2ux-jRwEfvTUehVZy4HRK6EWzEVTiuacrubsjmqUdyQJCbjcUTy_1Ng== Apr 12 10:43:05 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:06 volumio volumio[4674]: info: [ytcr] (nsz79iv_5h0) fetching player data using ANDROID_VR client... Apr 12 10:43:06 volumio volumio[4674]: info: [ytcr] (Bên Ấy Em Có Ai Rồi Remix (Ver Chuẩn Tiktok) | TVk x Lê Gia Quân - Bên Ấy Em Có Ai Rồi Thôi Thì Thôi) validating stream URL "https://rr1---sn-8qj-i5ods.googlevideo.com/videoplayback?expire=1775986986&ei=yhTbaZz8CtjFy_sPlc__4A4&ip=123.18.126.233&id=o-ANMmj4XKkbPEXaSQfTkwWy9OF_TQdjQe1A-5NUbKAVJ8&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1775965386%2C&mh=72&mm=31%2C29&mn=sn-8qj-i5ods%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=23&rms=au%2Cau&initcwndbps=2917500&siu=1&bui=AUUZDGLDwBoTYSOg6C6WS-4AWtjVOLVb3moJQ2lY6i1bGWCtyAURVygQznJhNR1O7BwblJnlow&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4801500&dur=302.661&lmt=1774889557513165&mt=1775965262&fvip=5&keepalive=yes&fexp=51565115%2C51565682&c=ANDROID_VR&txp=5532534&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AHEqNM4wRAIgNP4cvzWNp5B7fPM33VhkUHKdtAByvHisoltpBQQmxYkCIBtf1bRvQZ7Nt--SbI7P-Nb51yxQywcNzFJVb8nwIi28&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgHsxGyrYaCj-kRQekaZbZQx-qpX6x2Le-GwGoTc-b2n0CIQDjvGfaH1sVHXi87NlaKIJ8EWDazUX6b2hTMUDmXbY9Yg%3D%3D&pot=MlxLslwd90s1D0v3RReZRMyVaGvwZboND-5lozkgJqEkgqfsQi6DF5XaxssQhILotlHXETm2ux-jRwEfvTUehVZy4HRK6EWzEVTiuacrubsjmqUdyQJCbjcUTy_1Ng%3D%3D"... Apr 12 10:43:06 volumio volumio[4674]: info: [ytcr] (Bên Ấy Em Có Ai Rồi Remix (Ver Chuẩn Tiktok) | TVk x Lê Gia Quân - Bên Ấy Em Có Ai Rồi Thôi Thì Thôi) stream validated in 0.071s. Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:06 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:07 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:07 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:07 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:07 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 10:43:07 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 12 10:43:07 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:07 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:07 volumio volumio[4674]: info: Ignoring MPD Status Update Apr 12 10:43:07 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:07 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:07 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:07 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:07 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:07 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 36 Apr 12 10:43:07 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:07 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:07 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:07 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:07 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 36 Apr 12 10:43:12 volumio volumio[4674]: info: [yt-cast-receiver] Player.setVolume(): Apr 12 10:43:12 volumio volumio[4674]: { level: 41, muted: false } Apr 12 10:43:12 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:12 volumio volumio[4674]: info: VolumeController::SetAlsaVolume41 Apr 12 10:43:12 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:12 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:12 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:12 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:12 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:12 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:12 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:12 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:12 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41 Apr 12 10:43:12 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 36 Apr 12 10:43:12 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 41 Apr 12 10:43:12 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:43:12 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 41 Apr 12 10:43:12 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41 Apr 12 10:43:12 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:12 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:12 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41 Apr 12 10:43:13 volumio volumio[4674]: info: [yt-cast-receiver] Player.setVolume(): Apr 12 10:43:13 volumio volumio[4674]: { level: 46, muted: false } Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: VolumeController::SetAlsaVolume46 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 41 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 46 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:43:13 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 46 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: [yt-cast-receiver] Player.setVolume(): Apr 12 10:43:13 volumio volumio[4674]: { level: 51, muted: false } Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: VolumeController::SetAlsaVolume51 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 46 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 51 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:43:13 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 51 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51 Apr 12 10:43:13 volumio volumio[4674]: info: [yt-cast-receiver] Player.setVolume(): Apr 12 10:43:13 volumio volumio[4674]: { level: 56, muted: false } Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: VolumeController::SetAlsaVolume56 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 51 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 56 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:43:13 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 56 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56 Apr 12 10:43:13 volumio volumio[4674]: info: [yt-cast-receiver] Player.setVolume(): Apr 12 10:43:13 volumio volumio[4674]: { level: 61, muted: false } Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: VolumeController::SetAlsaVolume61 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 56 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 61 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:43:13 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 61 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: [yt-cast-receiver] Player.setVolume(): Apr 12 10:43:13 volumio volumio[4674]: { level: 66, muted: false } Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: VolumeController::SetAlsaVolume66 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 61 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 66 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:43:13 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 66 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: [yt-cast-receiver] Player.setVolume(): Apr 12 10:43:13 volumio volumio[4674]: { level: 71, muted: false } Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: VolumeController::SetAlsaVolume71 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 71 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 66 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 71 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:43:13 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 71 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 71 Apr 12 10:43:13 volumio volumio[4674]: info: [yt-cast-receiver] Player.setVolume(): Apr 12 10:43:13 volumio volumio[4674]: { level: 76, muted: false } Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 71 Apr 12 10:43:13 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 71 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: VolumeController::SetAlsaVolume76 Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:13 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:14 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:14 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:14 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:14 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:14 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:14 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:14 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:14 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:14 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:14 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76 Apr 12 10:43:14 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 71 Apr 12 10:43:14 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 76 Apr 12 10:43:14 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:43:14 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 76 Apr 12 10:43:14 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76 Apr 12 10:43:14 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76 Apr 12 10:43:14 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:14 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:14 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:14 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:14 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:14 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:14 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:14 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:14 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76 Apr 12 10:43:14 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76 Apr 12 10:43:14 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:14 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:14 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:14 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:14 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76 Apr 12 10:43:15 volumio volumio[4674]: info: [yt-cast-receiver] Player.setVolume(): Apr 12 10:43:15 volumio volumio[4674]: { level: 36, muted: false } Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:15 volumio volumio[4674]: info: VolumeController::SetAlsaVolume36 Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:15 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 36 Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 76 Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 36 Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:43:15 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 36 Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 36 Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 36 Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 36 Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 36 Apr 12 10:43:15 volumio volumio[4674]: info: [yt-cast-receiver] Player.setVolume(): Apr 12 10:43:15 volumio volumio[4674]: { level: 31, muted: false } Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:15 volumio volumio[4674]: info: VolumeController::SetAlsaVolume31 Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:15 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31 Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 36 Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 31 Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:43:15 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 31 Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31 Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31 Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31 Apr 12 10:43:15 volumio volumio[4674]: info: [yt-cast-receiver] Player.setVolume(): Apr 12 10:43:15 volumio volumio[4674]: { level: 26, muted: false } Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:15 volumio volumio[4674]: info: VolumeController::SetAlsaVolume26 Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:15 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31 Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 31 Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 26 Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:43:15 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 26 Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:15 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:15 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Apr 12 10:43:16 volumio volumio[4674]: info: [yt-cast-receiver] Player.setVolume(): Apr 12 10:43:16 volumio volumio[4674]: { level: 51, muted: false } Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:16 volumio volumio[4674]: info: VolumeController::SetAlsaVolume51 Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:16 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51 Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 26 Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 51 Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:43:16 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 51 Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51 Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51 Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51 Apr 12 10:43:16 volumio volumio[4674]: info: [yt-cast-receiver] Player.setVolume(): Apr 12 10:43:16 volumio volumio[4674]: { level: 56, muted: false } Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:16 volumio volumio[4674]: info: VolumeController::SetAlsaVolume56 Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:16 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51 Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56 Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 51 Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 56 Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:43:16 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 56 Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56 Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56 Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56 Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56 Apr 12 10:43:16 volumio volumio[4674]: info: [yt-cast-receiver] Player.setVolume(): Apr 12 10:43:16 volumio volumio[4674]: { level: 61, muted: false } Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:16 volumio volumio[4674]: info: VolumeController::SetAlsaVolume61 Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:16 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61 Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 56 Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 61 Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:43:16 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 61 Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61 Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61 Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61 Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:43:16 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:43:16 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61 Apr 12 10:43:18 volumio volumio[4674]: SPOTIFY: SETTING SPOTIFY VOLUME 61 Apr 12 10:43:18 volumio volumio[4674]: info: Sending Spotify command with payload to local API: /player/volume Apr 12 10:43:18 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 12 10:43:24 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 12 10:43:31 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 12 10:43:44 volumio volumio[4674]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/ytmusic/volumio/bookworm/amd64 Apr 12 10:43:44 volumio volumio5-onboarding[1695]: time=2026-04-12T10:43:44.752+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 10:43:48 volumio volumio[4674]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/ytmusic/volumio/bookworm/amd64 Apr 12 10:43:48 volumio volumio[4674]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesYouTube Music Apr 12 10:43:48 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 12 10:43:48 volumio volumio[4674]: Cannot find translation for source Mixcloud Apr 12 10:43:48 volumio volumio[4674]: Cannot find translation for source YouTube2 Apr 12 10:43:48 volumio volumio[4674]: Cannot find translation for source Spotify Apr 12 10:43:48 volumio volumio[4674]: info: [ytmusic] (AutoplayManager) Disabled Apr 12 10:43:48 volumio volumio[4674]: info: [ytmusic] Innertube support service: Stopping service... Apr 12 10:43:48 volumio volumio[4674]: info: [ytmusic] Innertube support service: Received SIGTERM Apr 12 10:43:48 volumio volumio[4674]: info: [ytmusic] Innertube support service: Process closed with code 0 Apr 12 10:43:48 volumio volumio[4674]: info: [ytmusic] Innertube support service: Stopped Apr 12 10:43:48 volumio volumio5-onboarding[1695]: time=2026-04-12T10:43:48.644+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 10:43:48 volumio volumio5-onboarding[1695]: time=2026-04-12T10:43:48.650+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 10:43:48 volumio volumio5-onboarding[1695]: time=2026-04-12T10:43:48.710+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 10:43:48 volumio volumio[4674]: info: An error occurred installing the plugin. Rolling back config Apr 12 10:43:48 volumio volumio[4674]: info: Plugin folders cleanup Apr 12 10:43:48 volumio volumio[4674]: info: Scanning into folder /volumio/app/plugins/ Apr 12 10:43:48 volumio volumio[4674]: info: Scanning category audio_interface Apr 12 10:43:48 volumio volumio[4674]: info: Scanning category miscellanea Apr 12 10:43:48 volumio volumio[4674]: info: Scanning category music_service Apr 12 10:43:48 volumio volumio[4674]: info: Scanning category plugins.json Apr 12 10:43:48 volumio volumio[4674]: info: Scanning category system_controller Apr 12 10:43:48 volumio volumio[4674]: info: Scanning category user_interface Apr 12 10:43:48 volumio volumio[4674]: info: Scanning into folder /data/plugins/ Apr 12 10:43:48 volumio volumio[4674]: info: Scanning category music_service Apr 12 10:43:48 volumio volumio[4674]: info: Scanning category system_hardware Apr 12 10:43:48 volumio volumio[4674]: info: Plugin folders cleanup completed Apr 12 10:43:48 volumio volumio[4674]: info: Error: Error Apr 12 10:43:48 volumio volumio[4674]: info: Error: Error Apr 12 10:43:48 volumio volumio[4674]: info: Folder /data/temp removed Apr 12 10:43:48 volumio volumio[4674]: info: Folder /tmp/plugins removed Apr 12 10:43:48 volumio volumio[4674]: info: Folder /tmp/downloaded_plugin.zip removed Apr 12 10:43:48 volumio volumio[4674]: info: Folder /tmp/downloaded_plugin.zip removed Apr 12 10:44:09 volumio volumio[4674]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/ytmusic/volumio/bookworm/amd64 Apr 12 10:44:09 volumio volumio5-onboarding[1695]: time=2026-04-12T10:44:09.152+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 10:44:11 volumio volumio[4674]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/ytmusic/volumio/bookworm/amd64 Apr 12 10:44:11 volumio volumio[4674]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesYouTube Music Apr 12 10:44:11 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 12 10:44:11 volumio volumio[4674]: Cannot find translation for source Mixcloud Apr 12 10:44:11 volumio volumio[4674]: Cannot find translation for source YouTube2 Apr 12 10:44:11 volumio volumio[4674]: Cannot find translation for source Spotify Apr 12 10:44:11 volumio volumio5-onboarding[1695]: time=2026-04-12T10:44:11.630+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 10:44:11 volumio volumio5-onboarding[1695]: time=2026-04-12T10:44:11.637+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 10:44:11 volumio volumio5-onboarding[1695]: time=2026-04-12T10:44:11.698+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 10:44:11 volumio volumio[4674]: info: An error occurred installing the plugin. Rolling back config Apr 12 10:44:11 volumio volumio[4674]: info: Plugin folders cleanup Apr 12 10:44:11 volumio volumio[4674]: info: Scanning into folder /volumio/app/plugins/ Apr 12 10:44:11 volumio volumio[4674]: info: Scanning category audio_interface Apr 12 10:44:11 volumio volumio[4674]: info: Scanning category miscellanea Apr 12 10:44:11 volumio volumio[4674]: info: Scanning category music_service Apr 12 10:44:11 volumio volumio[4674]: info: Scanning category plugins.json Apr 12 10:44:11 volumio volumio[4674]: info: Scanning category system_controller Apr 12 10:44:11 volumio volumio[4674]: info: Scanning category user_interface Apr 12 10:44:11 volumio volumio[4674]: info: Scanning into folder /data/plugins/ Apr 12 10:44:11 volumio volumio[4674]: info: Scanning category music_service Apr 12 10:44:11 volumio volumio[4674]: info: Scanning category system_hardware Apr 12 10:44:11 volumio volumio[4674]: info: Plugin folders cleanup completed Apr 12 10:44:11 volumio volumio[4674]: info: Error: Error Apr 12 10:44:11 volumio volumio[4674]: info: Error: Error Apr 12 10:44:11 volumio volumio[4674]: info: Folder /data/temp removed Apr 12 10:44:11 volumio volumio[4674]: info: Folder /tmp/plugins removed Apr 12 10:44:11 volumio volumio[4674]: info: Folder /tmp/downloaded_plugin.zip removed Apr 12 10:44:11 volumio volumio[4674]: info: Folder /tmp/downloaded_plugin.zip removed Apr 12 10:44:17 volumio volumio[4674]: info: VolumeController::SetAlsaVolume44 Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:44:17 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:17 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 44 Apr 12 10:44:17 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 61 Apr 12 10:44:17 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 44 Apr 12 10:44:17 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:44:17 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 44 Apr 12 10:44:17 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 44 Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:17 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 44 Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:17 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 44 Apr 12 10:44:17 volumio volumio[4674]: info: VolumeController::SetAlsaVolume36 Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:44:17 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:17 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 36 Apr 12 10:44:17 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 44 Apr 12 10:44:17 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 36 Apr 12 10:44:17 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:44:17 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 36 Apr 12 10:44:17 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 36 Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:17 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 36 Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:17 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:17 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 36 Apr 12 10:44:18 volumio volumio[4674]: SPOTIFY: SETTING SPOTIFY VOLUME 36 Apr 12 10:44:18 volumio volumio[4674]: info: Sending Spotify command with payload to local API: /player/volume Apr 12 10:44:22 volumio volumio[4674]: info: VolumeController::SetAlsaVolume28 Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:44:22 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:22 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 28 Apr 12 10:44:22 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 36 Apr 12 10:44:22 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 28 Apr 12 10:44:22 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:44:22 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 28 Apr 12 10:44:22 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 28 Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:22 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 28 Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:22 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 28 Apr 12 10:44:22 volumio volumio[4674]: info: VolumeController::SetAlsaVolume17 Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:44:22 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:22 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Apr 12 10:44:22 volumio volumio[4674]: SPOTIFY: SPOTIFY VOLUME 28 Apr 12 10:44:22 volumio volumio[4674]: SPOTIFY: VOLUMIO VOLUME 17 Apr 12 10:44:22 volumio volumio[4674]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 12 10:44:22 volumio volumio[4674]: info: Setting Spotify Volume from Volumio: 17 Apr 12 10:44:22 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:22 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::volumioGetState Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::servicePushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreStateMachine::pushState Apr 12 10:44:22 volumio volumio[4674]: info: CoreCommandRouter::volumioPushState Apr 12 10:44:22 volumio volumio[4674]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Apr 12 10:44:24 volumio volumio[4674]: SPOTIFY: SETTING SPOTIFY VOLUME 17 Apr 12 10:44:24 volumio volumio[4674]: info: Sending Spotify command with payload to local API: /player/volume Apr 12 10:44:26 volumio go-librespot[4905]: time="2026-04-12T10:44:26+07:00" level=warning msg="failed connecting to accesspoint, retrying" error="failed performing keyexchange: failed reading APResponseMessage message: failed reading message length: EOF" Apr 12 10:44:27 volumio go-librespot[4905]: time="2026-04-12T10:44:27+07:00" level=debug msg="connected to ap-gew4.spotify.com:80" Apr 12 10:44:28 volumio go-librespot[4905]: time="2026-04-12T10:44:28+07:00" level=debug msg="completed keyexchange" Apr 12 10:44:28 volumio go-librespot[4905]: time="2026-04-12T10:44:28+07:00" level=debug msg="completed challenge" Apr 12 10:44:28 volumio go-librespot[4905]: time="2026-04-12T10:44:28+07:00" level=warning msg="failed connecting to accesspoint, retrying" error="failed authenticating: accesspoint login failed: TravelRestriction " Apr 12 10:44:28 volumio go-librespot[4905]: time="2026-04-12T10:44:28+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 12 10:44:29 volumio go-librespot[4905]: time="2026-04-12T10:44:29+07:00" level=debug msg="completed keyexchange" Apr 12 10:44:29 volumio go-librespot[4905]: time="2026-04-12T10:44:29+07:00" level=debug msg="completed challenge" Apr 12 10:44:29 volumio go-librespot[4905]: time="2026-04-12T10:44:29+07:00" level=warning msg="failed connecting to accesspoint, retrying" error="failed authenticating: accesspoint login failed: TravelRestriction " Apr 12 10:44:29 volumio go-librespot[4905]: time="2026-04-12T10:44:29+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Apr 12 10:44:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 12 10:44:29 volumio volumio[4674]: error: Failed to send command to Spotify local API: /player/volume: Error: socket hang up Apr 12 10:44:29 volumio volumio[4674]: error: Failed to send command to Spotify local API: /player/volume: Error: socket hang up Apr 12 10:44:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 12 10:44:29 volumio volumio[4674]: error: Failed to send command to Spotify local API: /player/volume: Error: socket hang up Apr 12 10:44:29 volumio volumio[4674]: error: Failed to send command to Spotify local API: /player/volume: Error: socket hang up Apr 12 10:44:29 volumio volumio[4674]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 12 10:44:29 volumio volumio[4674]: Error: socket hang up Apr 12 10:44:29 volumio volumio[4674]: at connResetException (node:internal/errors:720:14) Apr 12 10:44:29 volumio volumio[4674]: at Socket.socketOnEnd (node:_http_client:519:23) Apr 12 10:44:29 volumio volumio[4674]: at Socket.emit (node:events:526:35) Apr 12 10:44:29 volumio volumio[4674]: at endReadableNT (node:internal/streams/readable:1376:12) Apr 12 10:44:29 volumio volumio[4674]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Apr 12 10:44:29 volumio volumio[4674]: code: 'ECONNRESET', Apr 12 10:44:29 volumio volumio[4674]: response: undefined Apr 12 10:44:29 volumio volumio[4674]: } Apr 12 10:44:29 volumio volumio[4674]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 12 10:44:29 volumio sudo[7843]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-12 10:43' Apr 12 10:44:29 volumio sudo[7843]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"