Battery Drain on GrapheneOS (Pixel 4+7) #79
Description
I am experiencing extreme battery drain when using Snapcast on GrapheneOS (Pixel 7). This issue has also been confirmed on a Pixel 4 device running GrapheneOS.
The issue occurs primarily when I am outside and forget to close Snapcast on Android. The phone gets noticeably warm, and battery usage is significantly higher than expected.
Device & OS Information:
Device: Pixel 7 (Panther)
OS: GrapheneOS
OS Version: google/panther/panther:15/BP1A.250305.019/2025031400:user/release-keys
Developer Options Enabled: Yes
App Version: de.badaix.snapcast:2901, targetSdk 34
Logs & Observations:
Attached are logcat outputs showing some denied permissions related to network access (sysfs_net) and socket operations (tcp_socket). This might be causing unexpected behavior.
Reproduction Steps:
Open Snapcast (droidcast) on a Pixel 7 running GrapheneOS.
Leave the app running in the background (e.g., while going outside).
Observe increased battery usage and device warming over time.
How Can I Help Debug?
Let me know if there are specific logs, traces, or tests I can run to provide more insights. I’m happy to gather additional information.
Thanks for your work on Snapcast!
type: logcat
osVersion: google/panther/panther:15/BP1A.250305.019/2025031400:user/release-keys
flags: dev options enabled
package: de.badaix.snapcast:2901, targetSdk 34
buffers: main,system,crash,events,kernel
level: verbose
--------- beginning of events
03-20 14:06:25.230 25772 25772 I auditd : avc=type=1400 audit(0.0:119631): avc: denied { ioctl } for comm="libsnapclient.s" path="socket:[19388672]" dev="sockfs" ino=19388672 ioctlcmd=0x8927 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tclass=tcp_socket permissive=0 app=de.badaix.snapcast
03-20 14:06:25.230 25772 25772 I auditd : avc=type=1400 audit(0.0:119632): avc: denied { search } for comm="libsnapclient.s" name="net" dev="sysfs" ino=29952 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:object_r:sysfs_net:s0 tclass=dir permissive=0 app=de.badaix.snapcast
03-20 14:06:25.230 25772 25772 I auditd : avc=type=1400 audit(0.0:119633): avc: denied { ioctl } for comm="libsnapclient.s" path="socket:[19388672]" dev="sockfs" ino=19388672 ioctlcmd=0x8927 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tclass=tcp_socket permissive=0 app=de.badaix.snapcast
03-20 14:06:25.230 25772 25772 I auditd : avc=type=1400 audit(0.0:119634): avc: denied { search } for comm="libsnapclient.s" name="net" dev="sysfs" ino=29952 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:object_r:sysfs_net:s0 tclass=dir permissive=0 app=de.badaix.snapcast
03-20 14:06:25.234 25772 25772 I auditd : avc=type=1400 audit(0.0:119635): avc: denied { ioctl } for comm="libsnapclient.s" path="socket:[19388672]" dev="sockfs" ino=19388672 ioctlcmd=0x8927 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tclass=tcp_socket permissive=0 app=de.badaix.snapcast
03-20 14:06:25.234 25772 25772 I auditd : avc=type=1400 audit(0.0:119636): avc: denied { search } for comm="libsnapclient.s" name="net" dev="sysfs" ino=29952 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:object_r:sysfs_net:s0 tclass=dir permissive=0 app=de.badaix.snapcast
03-20 14:07:05.770 25772 25772 I auditd : avc=type=1400 audit(0.0:119661): avc: denied { ioctl } for comm="libsnapclient.s" path="socket:[19388724]" dev="sockfs" ino=19388724 ioctlcmd=0x8927 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tclass=tcp_socket permissive=0 app=de.badaix.snapcast
03-20 14:07:05.774 25772 25772 I auditd : avc=type=1400 audit(0.0:119662): avc: denied { search } for comm="libsnapclient.s" name="net" dev="sysfs" ino=29952 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:object_r:sysfs_net:s0 tclass=dir permissive=0 app=de.badaix.snapcast
03-20 14:07:05.774 25772 25772 I auditd : avc=type=1400 audit(0.0:119663): avc: denied { ioctl } for comm="libsnapclient.s" path="socket:[19388724]" dev="sockfs" ino=19388724 ioctlcmd=0x8927 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tclass=tcp_socket permissive=0 app=de.badaix.snapcast
03-20 14:07:05.774 25772 25772 I auditd : avc=type=1400 audit(0.0:119664): avc: denied { search } for comm="libsnapclient.s" name="net" dev="sysfs" ino=29952 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:object_r:sysfs_net:s0 tclass=dir permissive=0 app=de.badaix.snapcast
03-20 14:07:05.774 25772 25772 I auditd : avc=type=1400 audit(0.0:119665): avc: denied { ioctl } for comm="libsnapclient.s" path="socket:[19388724]" dev="sockfs" ino=19388724 ioctlcmd=0x8927 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tclass=tcp_socket permissive=0 app=de.badaix.snapcast
03-20 14:07:05.774 25772 25772 I auditd : avc=type=1400 audit(0.0:119666): avc: denied { search } for comm="libsnapclient.s" name="net" dev="sysfs" ino=29952 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:object_r:sysfs_net:s0 tclass=dir permissive=0 app=de.badaix.snapcast
03-20 14:10:03.067 17389 17389 I wm_on_create_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=performCreate,time=61ms]
03-20 14:10:03.071 17389 17389 I wm_on_start_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=handleStartActivity,time=3ms]
03-20 14:10:03.074 17389 17389 I wm_on_resume_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=RESUME_ACTIVITY,time=1ms]
03-20 14:10:03.081 17389 17389 I wm_on_top_resumed_gained_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=topStateChangedWhenResumed]
03-20 14:10:03.130 17389 17389 I viewroot_draw_event: [window=VRI[MainActivity],event=reportDrawFinished seqId=0]
03-20 14:10:06.758 17389 17389 I view_enqueue_input_event: [eventType=Motion - Cancel,action=de.badaix.snapcast/de.badaix.snapcast.MainActivity]
03-20 14:10:06.769 17389 17389 I wm_on_top_resumed_lost_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=topStateChangedWhenResumed]
03-20 14:10:08.521 17389 17389 I wm_on_paused_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=performPause,time=0ms]
03-20 14:10:08.918 17389 17389 I viewroot_draw_event: [window=VRI[MainActivity],event=Not drawing due to not visible. Reason=!mAppVisible && !mForceDecorViewVisibility]
03-20 14:10:08.920 17389 17389 I wm_on_stop_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=STOP_ACTIVITY_ITEM,time=1ms]
03-20 14:10:44.673 17389 17389 I wm_on_restart_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=performRestart,time=0ms]
03-20 14:10:44.674 17389 17389 I wm_on_start_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=handleStartActivity,time=1ms]
03-20 14:10:44.675 17389 17389 I wm_on_resume_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=RESUME_ACTIVITY,time=0ms]
03-20 14:10:44.675 17389 17389 I wm_on_top_resumed_gained_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=topWhenResuming]
03-20 14:10:44.699 17389 17389 I viewroot_draw_event: [window=VRI[MainActivity],event=Start draw after previous draw not visible]
03-20 14:10:44.703 17389 17389 I viewroot_draw_event: [window=VRI[MainActivity],event=reportDrawFinished seqId=0]
03-20 14:10:45.651 17389 17389 I view_enqueue_input_event: [eventType=Motion - Cancel,action=de.badaix.snapcast/de.badaix.snapcast.MainActivity]
03-20 14:10:45.655 17389 17389 I wm_on_top_resumed_lost_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=topStateChangedWhenResumed]
03-20 14:10:47.427 17389 17389 I wm_on_paused_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=performPause,time=1ms]
03-20 14:10:47.825 17389 17389 I viewroot_draw_event: [window=VRI[MainActivity],event=Not drawing due to not visible. Reason=!mAppVisible && !mForceDecorViewVisibility]
03-20 14:10:47.828 17389 17389 I wm_on_stop_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=STOP_ACTIVITY_ITEM,time=1ms]
03-20 14:15:30.704 17389 17389 I wm_on_destroy_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=performDestroy,time=10ms]
03-20 14:15:30.775 17389 17389 I wm_on_create_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=performCreate,time=51ms]
03-20 14:15:30.779 17389 17389 I wm_on_start_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=handleStartActivity,time=3ms]
03-20 14:15:30.781 17389 17389 I wm_on_resume_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=RESUME_ACTIVITY,time=1ms]
03-20 14:15:30.781 17389 17389 I wm_on_top_resumed_gained_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=topWhenResuming]
03-20 14:15:30.812 17389 17389 I viewroot_draw_event: [window=VRI[MainActivity],event=reportDrawFinished seqId=0]
03-20 14:15:32.018 17389 17389 I menu_item_selected: [Menu type where 0 is options and 1 is context=0,Menu item title=Settings…]
03-20 14:15:32.289 17389 17389 I viewroot_draw_event: [window=VRI[MainActivity],event=reportDrawFinished seqId=0]
03-20 14:15:36.909 17389 17389 I viewroot_draw_event: [window=VRI[PopupWindow:b3b8a03],event=reportDrawFinished seqId=0]
03-20 14:15:36.913 17389 17389 I viewroot_draw_event: [window=VRI[PopupWindow:b3b8a03],event=reportDrawFinished seqId=0]
03-20 14:15:39.955 17389 17389 I menu_item_selected: [Menu type where 0 is options and 1 is context=0,Menu item title=About…]
03-20 14:15:39.979 17389 17389 I wm_on_top_resumed_lost_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=topStateChangedWhenResumed]
03-20 14:15:39.982 17389 17389 I wm_on_paused_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=performPause,time=0ms]
--------- beginning of system
03-20 14:15:40.061 17389 17389 V ResourcesManager: The following library key has been added: ResourcesKey{ mHash=7407936e mResDir=null mSplitDirs=[] mOverlayDirs=[/product/overlay/NavigationBarModeGestural/NavigationBarModeGesturalOverlay.apk,/data/resource-cache/com.android.systemui-neutral-SrfN.frro,/data/resource-cache/com.android.systemui-accent-zBR9.frro,/data/resource-cache/com.android.systemui-dynamic-3ygS.frro] mLibDirs=[/product/app/TrichromeWebView/TrichromeWebView.apk,/product/app/TrichromeLibrary/TrichromeLibrary.apk,/system_ext/framework/androidx.window.extensions.jar] mDisplayId=0 mOverrideConfig=v35 mCompatInfo={420dpi always-compat} mLoaders=[]}
--------- switch to events
03-20 14:15:40.612 17389 17389 I wm_on_create_called: [Token=116095276,Component Name=de.badaix.snapcast.AboutActivity,Reason=performCreate,time=598ms]
03-20 14:15:40.613 17389 17389 I wm_on_start_called: [Token=116095276,Component Name=de.badaix.snapcast.AboutActivity,Reason=handleStartActivity,time=0ms]
03-20 14:15:40.613 17389 17389 I wm_on_resume_called: [Token=116095276,Component Name=de.badaix.snapcast.AboutActivity,Reason=RESUME_ACTIVITY,time=0ms]
03-20 14:15:40.622 17389 17389 I wm_on_top_resumed_gained_called: [Token=116095276,Component Name=de.badaix.snapcast.AboutActivity,Reason=topStateChangedWhenResumed]
03-20 14:15:40.723 17389 17389 I viewroot_draw_event: [window=VRI[AboutActivity],event=reportDrawFinished seqId=0]
03-20 14:15:41.250 17389 17389 I viewroot_draw_event: [window=VRI[MainActivity],event=Not drawing due to not visible. Reason=!mAppVisible && !mForceDecorViewVisibility]
03-20 14:15:41.252 17389 17389 I wm_on_stop_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=STOP_ACTIVITY_ITEM,time=0ms]
03-20 14:15:53.750 17389 17389 I view_enqueue_input_event: [eventType=Motion - Cancel,action=de.badaix.snapcast/de.badaix.snapcast.AboutActivity]
03-20 14:15:53.761 17389 17389 I wm_on_top_resumed_lost_called: [Token=116095276,Component Name=de.badaix.snapcast.AboutActivity,Reason=topStateChangedWhenResumed]
03-20 14:15:57.024 17389 17389 I wm_on_paused_called: [Token=116095276,Component Name=de.badaix.snapcast.AboutActivity,Reason=performPause,time=0ms]
03-20 14:15:58.144 17389 17389 I viewroot_draw_event: [window=VRI[AboutActivity],event=Not drawing due to not visible. Reason=!mAppVisible && !mForceDecorViewVisibility]
03-20 14:15:58.146 17389 17389 I wm_on_stop_called: [Token=116095276,Component Name=de.badaix.snapcast.AboutActivity,Reason=STOP_ACTIVITY_ITEM,time=0ms]
03-20 14:24:54.126 25772 25772 I auditd : avc=type=1400 audit(0.0:121081): avc: denied { ioctl } for comm="libsnapclient.s" path="socket:[19452049]" dev="sockfs" ino=19452049 ioctlcmd=0x8927 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tclass=tcp_socket permissive=0 app=de.badaix.snapcast
03-20 14:24:54.126 25772 25772 I auditd : avc=type=1400 audit(0.0:121082): avc: denied { search } for comm="libsnapclient.s" name="net" dev="sysfs" ino=29952 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:object_r:sysfs_net:s0 tclass=dir permissive=0 app=de.badaix.snapcast
03-20 14:24:54.126 25772 25772 I auditd : avc=type=1400 audit(0.0:121083): avc: denied { ioctl } for comm="libsnapclient.s" path="socket:[19452049]" dev="sockfs" ino=19452049 ioctlcmd=0x8927 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tclass=tcp_socket permissive=0 app=de.badaix.snapcast
03-20 14:24:54.126 25772 25772 I auditd : avc=type=1400 audit(0.0:121084): avc: denied { search } for comm="libsnapclient.s" name="net" dev="sysfs" ino=29952 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:object_r:sysfs_net:s0 tclass=dir permissive=0 app=de.badaix.snapcast
03-20 14:24:54.126 25772 25772 I auditd : avc=type=1400 audit(0.0:121085): avc: denied { ioctl } for comm="libsnapclient.s" path="socket:[19452049]" dev="sockfs" ino=19452049 ioctlcmd=0x8927 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tclass=tcp_socket permissive=0 app=de.badaix.snapcast
03-20 14:24:54.126 25772 25772 I auditd : avc=type=1400 audit(0.0:121086): avc: denied { search } for comm="libsnapclient.s" name="net" dev="sysfs" ino=29952 scontext=u:r:untrusted_app:s0:c205,c256,c512,c768 tcontext=u:object_r:sysfs_net:s0 tclass=dir permissive=0 app=de.badaix.snapcast
--------- beginning of main
03-20 14:36:29.017 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:30.052 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:31.013 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:32.023 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:33.051 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:34.012 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:35.032 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:36.053 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:37.033 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:38.038 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:39.070 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:40.033 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:41.043 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:42.003 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:43.031 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:44.046 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:45.011 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:46.036 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:47.011 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:48.017 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:49.051 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:50.012 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:51.022 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:52.051 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:53.011 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:54.030 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:55.050 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:56.032 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:57.035 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:58.071 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:36:59.032 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:00.041 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:01.003 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:02.033 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:03.046 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:04.011 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:05.034 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:06.011 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:07.016 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:08.051 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:09.011 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:10.021 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:11.051 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:12.010 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:13.028 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:14.051 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:15.016 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:16.034 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:17.071 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:18.031 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:19.040 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:20.002 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:21.031 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:22.046 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:23.010 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:24.030 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:25.011 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:26.014 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:27.051 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:28.010 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:29.020 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:30.051 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:31.012 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:32.027 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:33.049 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:34.012 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:35.034 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:36.070 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:37.031 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:38.005 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:39.018 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:40.048 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:41.007 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:42.025 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:43.048 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:44.023 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:45.021 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:46.061 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:47.020 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:48.030 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:49.061 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:50.014 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:51.040 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:52.057 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:53.020 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:54.044 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:55.003 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:56.039 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:57.048 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:58.009 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:37:59.039 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:00.053 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:01.015 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:02.039 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:03.002 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:04.022 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:05.059 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:06.019 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:07.027 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:08.059 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:09.018 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:10.035 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:11.057 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:12.020 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:13.042 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:14.004 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:15.039 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:16.047 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:17.009 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:18.038 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:19.054 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:20.014 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:21.041 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:22.059 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:23.021 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:24.060 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:25.019 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:26.027 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:27.059 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:28.019 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:29.033 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:30.058 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:31.018 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:32.043 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:33.002 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:34.039 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:35.046 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:36.008 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:37.040 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:38.052 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:39.014 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:40.039 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:41.059 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:42.022 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:43.058 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:44.019 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:45.033 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:46.066 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:47.026 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:48.042 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:49.004 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:50.029 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:51.051 17389 25776 D Main : [Info] (Stream) No chunks available
--------- switch to events
03-20 14:38:51.245 17389 17389 I wm_on_restart_called: [Token=116095276,Component Name=de.badaix.snapcast.AboutActivity,Reason=performRestart,time=0ms]
03-20 14:38:51.257 17389 17389 I wm_on_start_called: [Token=116095276,Component Name=de.badaix.snapcast.AboutActivity,Reason=handleStartActivity,time=12ms]
03-20 14:38:51.260 17389 17389 I wm_on_resume_called: [Token=116095276,Component Name=de.badaix.snapcast.AboutActivity,Reason=RESUME_ACTIVITY,time=0ms]
03-20 14:38:51.260 17389 17389 I wm_on_top_resumed_gained_called: [Token=116095276,Component Name=de.badaix.snapcast.AboutActivity,Reason=topWhenResuming]
03-20 14:38:51.276 17389 17389 I viewroot_draw_event: [window=VRI[AboutActivity],event=Start draw after previous draw not visible]
03-20 14:38:51.378 17389 17389 I viewroot_draw_event: [window=VRI[AboutActivity],event=reportDrawFinished seqId=0]
--------- switch to main
03-20 14:38:51.430 17389 17389 D InsetsController: hide(ime(), fromIme=false)
03-20 14:38:51.430 17389 17389 I ImeTracker: de.badaix.snapcast:46c785bd: onCancelled at PHASE_CLIENT_ALREADY_HIDDEN
03-20 14:38:52.012 17389 25776 D Main : [Info] (Stream) No chunks available
--------- switch to events
03-20 14:38:52.086 17389 17389 I view_enqueue_input_event: [eventType=Motion - Cancel,action=de.badaix.snapcast/de.badaix.snapcast.AboutActivity]
03-20 14:38:52.135 17389 17389 I wm_on_top_resumed_lost_called: [Token=116095276,Component Name=de.badaix.snapcast.AboutActivity,Reason=topStateChangedWhenResumed]
03-20 14:38:52.137 17389 17389 I wm_on_paused_called: [Token=116095276,Component Name=de.badaix.snapcast.AboutActivity,Reason=performPause,time=0ms]
03-20 14:38:52.147 17389 17389 I wm_on_restart_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=performRestart,time=0ms]
03-20 14:38:52.155 17389 17389 I wm_on_start_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=handleStartActivity,time=8ms]
03-20 14:38:52.157 17389 17389 I wm_on_resume_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=RESUME_ACTIVITY,time=1ms]
--------- switch to main
03-20 14:38:52.157 17389 8073 D RC : onConnecting
--------- switch to events
03-20 14:38:52.158 17389 17389 I wm_on_top_resumed_gained_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=topWhenResuming]
--------- switch to main
03-20 14:38:52.165 17389 8073 D TCP : Connecting to 192.168.2.3:1705
03-20 14:38:52.170 17389 8073 D RC : onConnected
03-20 14:38:52.170 17389 8075 D TCP : Sending: {"jsonrpc":"2.0","method":"Server.GetStatus","id":0}
03-20 14:38:52.178 17389 8073 D TCP : Received Message: '{"id":0,"jsonrpc":"2.0","result":{"server":{"groups":[{"clients":[{"config":{"instance":1,"latency":0,"name":"","volume":{"muted":false,"percent":100}},"connected":true,"host":{"arch":"aarch64","ip":"192.168.2.157","mac":"2c:cf:67:94:f6:31","name":"kamerspeaker","os":"Debian GNU/Linux 12 (bookworm)"},"id":"2c:cf:67:94:f6:31","lastSeen":{"sec":1742481530,"usec":74817},"snapclient":{"name":"Snapclient","protocolVersion":2,"version":"0.26.0"}}],"id":"41043ce9-0107-4b69-e8d0-37a7d81ba90f","muted":false,"name":"","stream_id":"TTS"},{"clients":[{"config":{"instance":1,"latency":0,"name":"","volume":{"muted":false,"percent":100}},"connected":true,"host":{"arch":"aarch64","ip":"192.168.2.155","mac":"d8:3a:dd:77:85:13","name":"theoppotter","os":"Debian GNU/Linux 12 (bookworm)"},"id":"d8:3a:dd:77:85:13","lastSeen":{"sec":1742481530,"usec":99432},"snapclient":{"name":"Snapclient","protocolVersion":2,"version":"0.26.0"}}],"id":"be047ca6-1dc6-1e50-ead6-1865a1bcf033","muted":false,"name":"","stream_id":"TTS"},{"clients":[{"config":{"instance":1,"latency":0,"name":"","volume":{"muted":false,"percent":100}},"connected":true,"host":{"arch":"arm64-v8a","ip":"192.168.2.7","mac":"00:00:00:00:00:00","name":"Pixel 7","os":"Android 15"},"id":"c1110699-2a4f-4533-b5bb-10fc4974e0f0","lastSeen":{"sec":1742481530,"usec":214231},"snapclient":{"name":"Snapclient","protocolVersion":2,"version":"0.29.0"}}],"id":"334306d7-cf4a-5f40-3e91-1788bf6b82a4","muted":false,"name":"","stream_id":"TTS"},{"clients":[{"config":{"instance":1,"latency":0,"name":"","volume":{"muted":false,"percent":100}},"connected":true,"host":{"arch":"aarch64","ip":"192.168.2.156","mac":"d8:3a:dd:77:82:a5","name":"miakiwi","os":"Debian GNU/Linux 11 (bullseye)"},"id":"d8:3a:dd:77:82:a5","lastSeen":{"sec":1742481530,"usec":322445},"snapclient":{"name":"Snapclient","protocolVersion":2,"version":"0.23.0"}}],"id":"a91ff76a-6a5b-c61e-2fd8-0e9f71b7860f","muted":false,"name":"","stream_id":"TTS"},{"clients":[{"config":{"instance":1,"latency":0,"name":"","volume":{"muted":false,"percent":100}},"connected":true,"host":{"arch":"arm64-v8a","ip":"192.168.2.154","mac":"00:00:00:00:00:00","name":"Redmi Note 7","os":"Android 14"},"id":"d74bc323-f025-46d6-ac7b-3f2dea531218","lastSeen":{"sec":1742481529,"usec":898597},"snapclient":{"name":"Snapclient","protocolVersion":2,"version":"0.29.0"}}],"id":"4bd480ea-b1f1-f7b4-4a19-e138108bc32c","muted":false,"name":"","stream_id":"TTS"},{"clients":[{"config":{"instance":1,"latency":0,"name":"","volume":{"muted":false,"percent":100}},"connected":false,"host":{"arch":"arm64-v8a","ip":"192.168.2.184","mac":"00:00:00:00:00:00","name":"Pixel 4","os":"Android 13"},"id":"24ff8b6c-de3c-425e-ad82-fd0fcdd6d5f4","lastSeen":{"sec":1740031176,"usec":520095},"snapclient":{"name":"Snapclient","protocolVersion":2,"version":"0.29.0"}}],"id":"9d8312a4-cd71-03e9-2d6d-2021d333469a","muted":false,"name":"","stream_id":"TTS"}],"server":{"host":{"arch":"x86_64","ip":"","mac":"","name":"star","os":"Debian GNU/Linux 12 (bookworm)"},"snapserver":{"controlProtocolVersion":1,"name":"Snapserver","protocolVersion":1,"version":"0.26.0"}},"streams":[{"id":"TTS","properties":{"canControl":false,"canGoNext":false,"canGoPrevious":false,"canPause":false,"canPlay":false,"canSeek":false},"status":"idle","uri":{"fragment":"","host":"0.0.0.0:4953","path":"","query":{"buffer":"2000","chunk_ms":"1","codec":"opus","mode":"server","name":"TTS","sampleformat":"48000:16:2"},"raw":"tcp://0.0.0.0:4953/?buffer=2000&chunk_ms=1&codec=opus&mode=server&name=TTS&sampleformat=48000:16:2","scheme":"tcp"}}]}}}'
03-20 14:38:52.178 17389 8073 D RC : Response to: Server.GetStatus
--------- switch to events
03-20 14:38:52.179 17389 17389 I viewroot_draw_event: [window=VRI[MainActivity],event=Start draw after previous draw not visible]
03-20 14:38:52.194 17389 17389 I viewroot_draw_event: [window=VRI[MainActivity],event=reportDrawFinished seqId=0]
--------- switch to main
03-20 14:38:52.206 17389 17389 W HWUI : Image decoding logging dropped!
03-20 14:38:52.288 17389 17389 D InsetsController: hide(ime(), fromIme=false)
03-20 14:38:52.288 17389 17389 I ImeTracker: de.badaix.snapcast:546c36f: onCancelled at PHASE_CLIENT_ALREADY_HIDDEN
03-20 14:38:52.724 17389 17389 D VRI[AboutActivity]: visibilityChanged oldVisibility=true newVisibility=false
--------- switch to events
03-20 14:38:52.744 17389 17389 I viewroot_draw_event: [window=VRI[AboutActivity],event=Not drawing due to not visible. Reason=!mAppVisible && !mForceDecorViewVisibility]
03-20 14:38:52.748 17389 17389 I wm_on_stop_called: [Token=116095276,Component Name=de.badaix.snapcast.AboutActivity,Reason=LIFECYCLER_STOP_ACTIVITY,time=0ms]
03-20 14:38:52.750 17389 17389 I wm_on_destroy_called: [Token=116095276,Component Name=de.badaix.snapcast.AboutActivity,Reason=performDestroy,time=0ms]
--------- switch to main
03-20 14:38:52.750 17389 17389 W WindowOnBackDispatcher: sendCancelIfRunning: isInProgress=false callback=android.view.ViewRootImpl$$ExternalSyntheticLambda13@a8b4133
03-20 14:38:52.769 17389 17389 D ViewRootImpl: Skipping stats log for color mode
03-20 14:38:53.051 17389 25776 D Main : [Info] (Stream) No chunks available
--------- switch to events
03-20 14:38:53.132 17389 17389 I wm_on_top_resumed_lost_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=topStateChangedWhenResumed]
03-20 14:38:53.135 17389 17389 I view_enqueue_input_event: [eventType=Motion - Cancel,action=de.badaix.snapcast/de.badaix.snapcast.MainActivity]
03-20 14:38:53.171 17389 17389 I wm_on_paused_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=performPause,time=0ms]
--------- switch to main
03-20 14:38:53.630 17389 17389 D VRI[MainActivity]: visibilityChanged oldVisibility=true newVisibility=false
--------- switch to events
03-20 14:38:53.648 17389 17389 I viewroot_draw_event: [window=VRI[MainActivity],event=Not drawing due to not visible. Reason=!mAppVisible && !mForceDecorViewVisibility]
03-20 14:38:53.651 17389 17389 I wm_on_stop_called: [Token=19151051,Component Name=de.badaix.snapcast.MainActivity,Reason=STOP_ACTIVITY_ITEM,time=1ms]
--------- switch to main
03-20 14:38:54.009 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:55.017 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:56.049 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:57.009 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:58.026 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:38:59.053 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:39:00.011 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:39:01.032 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:39:02.072 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:39:03.033 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:39:04.043 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:39:05.002 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:39:06.034 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:39:07.045 17389 25776 D Main : [Info] (Stream) No chunks available
03-20 14:39:08.006 17389 25776 D Main : [Info] (Stream) No chunks available