XFA:CmsSender - Error

pitoco02 · August 7, 2024, 9:30pm

Guys i got like 5 devices with the same error in the status:

Android 11: R312 (white label)

The android stops displaying images for a while and gets this message
Can anyone explain to me why?

XFA:CmsSender

{“CUSTOM_DATA”:{},“APP_VERSION_CODE”:312,“IS_SILENT”:false,“ANDROID_VERSION”:“11”,“LOGCAT”:“08-07 18:09:45.936 D/Event (10399): No subscribers registered for event class t3.e\n08-07 18:09:45.936 D/Event (10399): No subscribers registered for event class s2.f\n08-07 18:09:45.959 I/ActivityTaskManager( 524): START u0 {flg=0x10008000 cmp=com.signage.jaesggaklo/uk.org.xibo.player.Player} from uid 10072\n08-07 18:09:45.960 W/ActivityTaskManager( 524): Background activity start for com.signage.jaesggaklo allowed because SYSTEM_ALERT_WINDOW permission is granted.\n08-07 18:09:45.979 I/ACRA (10422): Sending report /data/user/0/com.signage.jaesggaklo/app_ACRA-approved/2024-08-07T18:08:00.125-03:00-IS_SILENT.stacktrace\n08-07 18:09:46.009 E/DisplayIdentification( 308): Display identification data has unknown format.\n08-07 18:09:46.047 W/System.err(10422): java.io.IOException: Resource not found: "org/joda/time/tz/data/ZoneInfoMap" ClassLoader: dalvik.system.PathClassLoader[DexPathList[[zip file "/data/app/~~2ZB5YBFhAw5jSNff5lJQ9Q==/com.signage.jaesggaklo-4_hdUvXyG_hzI5L2_n6F7g==/base.apk"],nativeLibraryDirectories=[/data/app/~~2ZB5YBFhAw5jSNff5lJQ9Q==/com.signage.jaesggaklo-4_hdUvXyG_hzI5L2_n6F7g==/lib/arm, /system/lib, /system_ext/lib]]]\n08-07 18:09:46.047 W/System.err(10422): \tat l3.e.e(ZoneInfoProvider.java:77)\n08-07 18:09:46.047 W/System.err(10422): \tat l3.e.(ZoneInfoProvider.java:16)\n08-07 18:09:46.047 W/System.err(10422): \tat org.joda.time.DateTimeZone.p(DateTimeZone.java:121)\n08-07 18:09:46.047 W/System.err(10422): \tat org.joda.time.DateTimeZone.g(DateTimeZone.java:33)\n08-07 18:09:46.047 W/System.err(10422): \tat org.joda.time.DateTimeZone.h(DateTimeZone.java:31)\n08-07 18:09:46.047 W/System.err(10422): \tat org.joda.time.chrono.ISOChronology.Y(ISOChronology.java:1)\n08-07 18:09:46.047 W/System.err(10422): \tat org.joda.time.LocalDateTime.(LocalDateTime.java:9)\n08-07 18:09:46.047 W/System.err(10422): \tat r3.e.a(LogStatus.java:7)\n08-07 18:09:46.047 W/System.err(10422): \tat r3.d.run(LogMessage.java:127)\n08-07 18:09:46.047 W/System.err(10422): \tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)\n08-07 18:09:46.047 W/System.err(10422): \tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)\n08-07 18:09:46.047 W/System.err(10422): \tat java.lang.Thread.run(Thread.java:923)\n08-07 18:09:46.134 D/NsdService( 524): New client listening to asynchronous messages\n08-07 18:09:46.134 D/NsdService( 524): New client, channel: com.android.internal.util.AsyncChannel@cb4ca2e messenger: android.os.Messenger@c2849cf\n08-07 18:09:46.231 I/TetheringManager(10399): registerTetheringEventCallback:com.signage.jaesggaklo\n08-07 18:09:46.284 I/ActivityManager( 524): Killing 2730:com.android.chrome/u0a69 (adj 999): empty for 13649s\n08-07 18:09:46.322 D/ConnectivityService( 524): ConnectivityService NetworkRequestInfo binderDied(NetworkRequest [ TRACK_DEFAULT id=3428, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 10069 AdministratorUids: RequestorUid: 10069 RequestorPackageName: com.android.chrome] ], android.os.BinderProxy@776b563)\n08-07 18:09:46.323 D/ConnectivityService( 524): releasing NetworkRequest [ TRACK_DEFAULT id=3428, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 10069 AdministratorUids: RequestorUid: 10069 RequestorPackageName: com.android.chrome] ] (release request)\n08-07 18:09:46.323 D/ConnectivityService( 524): ConnectivityService NetworkRequestInfo binderDied(NetworkRequest [ TRACK_DEFAULT id=3430, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 10069 AdministratorUids: RequestorUid: 10069 RequestorPackageName: com.android.chrome] ], android.os.BinderProxy@6619560)\n08-07 18:09:46.323 D/ConnectivityService( 524): ConnectivityService NetworkRequestInfo binderDied(NetworkRequest [ LISTEN id=3431, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&FOREGROUND Uid: 10069 AdministratorUids: RequestorUid: 10069 RequestorPackageName: com.android.chrome] ], android.os.BinderProxy@b500a19)\n08-07 18:09:46.323 D/ConnectivityService( 524): ConnectivityService NetworkRequestInfo binderDied(NetworkRequest [ LISTEN id=3429, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&FOREGROUND Uid: 10069 AdministratorUids: RequestorUid: 10069 RequestorPackageName: com.android.chrome] ], android.os.BinderProxy@c7e1ade)\n08-07 18:09:46.324 D/ConnectivityService( 524): releasing NetworkRequest [ TRACK_DEFAULT id=3430, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 10069 AdministratorUids: RequestorUid: 10069 RequestorPackageName: com.android.chrome] ] (release request)\n08-07 18:09:46.324 I/Zygote ( 367): Process 2730 exited due to signal 9 (Killed)\n08-07 18:09:46.332 I/libprocessgroup( 524): Successfully killed process cgroup uid 10069 pid 2730 in 45ms\n08-07 18:09:50.112 E/TaskPersister( 524): File error accessing recents directory (directory doesn’t exist?).\n08-07 18:09:50.918 I/jaesggaklo:acr(10422): Waiting for a blocking GC ProfileSaver\n08-07 18:09:50.934 I/jaesggaklo:acr(10422): WaitForGcToComplete blocked ProfileSaver on ClassLinker for 16.653ms\n08-07 18:09:50.941 I/jaesggaklo:acr(10422): WaitForGcToComplete blocked RunEmptyCheckpoint on ProfileSaver for 6.666ms\n08-07 18:10:19.611 I/Thread-80( 3368): type=1400 audit(0.0:31465): avc: denied { call } for scontext=u:r:gmscore_app:s0:c512,c768 tcontext=u:r:hal_memtrack_default:s0 tclass=binder permissive=1 app=com.google.android.gms\n08-07 18:11:06.684 I/[185839.251995@0] cec( 0): bad iniator with self 0x0\n08-07 18:11:18.836 D/DhcpClient( 931): Received packet: 00:e0:9a:36:0e:89 NAK, reason (none)\n08-07 18:11:18.838 D/DhcpClient( 931): Received packet: 00:e0:9a:36:0e:89 ACK: your new IP /192.168.8.1, netmask /255.255.240.0, gateways [/192.168.0.254] DNS servers: /192.168.0.30 , lease time 691200\n08-07 18:11:18.956 D/DhcpClient( 931): Received packet: 00:e0:9a:36:0e:89 OFFER, ip /192.168.8.1, mask /255.255.240.0, DNS servers: /192.168.0.30 , gateways [/192.168.0.254] lease time 691200, domain kiarroz.local\n08-07 18:11:18.960 D/DhcpClient( 931): Received packet: 00:e0:9a:36:0e:89 ACK: your new IP /192.168.8.1, netmask /255.255.240.0, gateways [/192.168.0.254] DNS servers: /192.168.0.30 , lease time 691200\n08-07 18:11:19.474 D/DhcpClient( 931): Received packet: 00:e0:9a:36:0e:89 OFFER, ip /192.168.101.253, mask /255.255.255.0, DNS servers: /1.1.1.1 , gateways [/192.168.101.1] lease time 600, domain null\n08-07 18:11:22.756 I/[185839.369526@0] cec( 0): bad iniator with self 0x0\n08-07 18:11:31.749 I/[185855.441940@0] cec( 0): bad iniator with self 0x0\n08-07 18:11:35.887 I/[185864.434613@0] cec( 0): bad iniator with self 0x0\n08-07 18:12:06.366 I/[185868.573218@0] cec( 0): bad iniator with self 0x0\n08-07 18:13:05.648 I/Finsky (29037): [5490] lqe.run(181): Stats for Executor: BlockingExecutor pyb@bc940b0[Running, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 108]\n08-07 18:13:05.650 I/Finsky (29037): [5490] lqe.run(181): Stats for Executor: LightweightExecutor pyb@e865b29[Running, pool size = 3, active threads = 0, queued tasks = 0, completed tasks = 445]\n08-07 18:13:05.846 I/Finsky (29037): [5490] lqe.run(181): Stats for Executor: bgExecutor pyb@9b17eae[Running, pool size = 4, active threads = 0, queued tasks = 0, completed tasks = 1699]\n08-07 18:14:20.279 I/UsageStatsService( 524): User[0] Flushing usage stats to disk\n08-07 18:15:19.691 I/Thread-81( 3368): type=1400 audit(0.0:31466): avc: denied { call } for scontext=u:r:gmscore_app:s0:c512,c768 tcontext=u:r:hal_memtrack_default:s0 tclass=binder permissive=1 app=com.google.android.gms\n08-07 18:15:19.697 I/[185899.051696@2] cec( 0): bad iniator with self 0x0\n08-07 18:18:00.175 I/nage.jaesggaklo(10399): type=1400 audit(0.0:31467): avc: denied { search } for name="/" dev="dm-1" ino=2 scontext=u:r:untrusted_app_27:s0:c72,c256,c512,c768 tcontext=u:object_r:unlabeled:s0 tclass=dir permissive=1 trawcon="u:object_r:product_file:s0" app=com.signage.jaesggaklo\n08-07 18:18:00.175 I/nage.jaesggaklo(10399): type=1400 audit(0.0:31468): avc: denied { getattr } for path="/product/overlay/GoogleExtServicesConfigOverlay.apk" dev="dm-1" ino=104 scontext=u:r:untrusted_app_27:s0:c72,c256,c512,c768 tcontext=u:object_r:unlabeled:s0 tclass=file permissive=1 trawcon="u:object_r:product_file:s0" app=com.signage.jaesggaklo\n08-07 18:18:00.178 D/KeyguardClockSwitch( 828): Updating clock: 1818\n08-07 18:18:00.179 W/ActivityManager( 524): Foreground service started from background can not have location/camera/microphone access: service com.teamviewer.host.market/com.teamviewer.host.application.NetworkServiceHost\n08-07 18:18:00.183 W/ActivityManager( 524): Background start not allowed: service Intent { cmp=com.signage.jaesggaklo/uk.org.xibo.xmds.LicenceService } to com.signage.jaesggaklo/uk.org.xibo.xmds.LicenceService from pid=10399 uid=10072 pkg=com.signage.jaesggaklo startFg?=false\n08-07 18:18:00.184 D/AndroidRuntime(10399): Shutting down VM\n--------- beginning of crash\n08-07 18:18:00.185 E/AndroidRuntime(10399): FATAL EXCEPTION: main\n08-07 18:18:00.185 E/AndroidRuntime(10399): Process: com.signage.jaesggaklo, PID: 10399\n08-07 18:18:00.185 E/AndroidRuntime(10399): java.lang.RuntimeException: Unable to start receiver uk.org.xibo.alarms.LicenceServiceReceiver: java.lang.IllegalStateException: Not allowed to start service Intent { cmp=com.signage.jaesggaklo/uk.org.xibo.xmds.LicenceService }: app is in background uid UidRecord{8892da3 u0a72 RCVR bg:+8m4s373ms idle change:uncached procs:3 seq(0,0,0)}\n08-07 18:18:00.185 E/AndroidRuntime(10399): \tat android.app.ActivityThread.handleReceiver(ActivityThread.java:4035)\n08-07 18:18:00.185 E/AndroidRuntime(10399): \tat android.app.ActivityThread.access$1400(ActivityThread.java:237)\n08-07 18:18:00.185 E/AndroidRuntime(10399): \tat android.app.ActivityThread$H.handleMessage(ActivityThread.java:1924)\n08-07 18:18:00.185 E/AndroidRuntime(10399): \tat android.os.Handler.dispatchMessage(Handler.java:106)\n08-07 18:18:00.185 E/AndroidRuntime(10399): \tat android.os.Looper.loop(Looper.java:223)\n08-07 18:18:00.185 E/AndroidRuntime(10399): \tat android.app.ActivityThread.main(ActivityThread.java:7664)\n08-07 18:18:00.185 E/AndroidRuntime(10399): \tat java.lang.reflect.Method.invoke(Native Method)\n08-07 18:18:00.185 E/AndroidRuntime(10399): \tat com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:592)\n08-07 18:18:00.185 E/AndroidRuntime(10399): \tat com.android.internal.os.ZygoteInit.main(ZygoteInit.java:952)\n08-07 18:18:00.185 E/AndroidRuntime(10399): Caused by: java.lang.IllegalStateException: Not allowed to start service Intent { cmp=com.signage.jaesggaklo/uk.org.xibo.xmds.LicenceService }: app is in background uid UidRecord{8892da3 u0a72 RCVR bg:+8m4s373ms idle change:uncached procs:3 seq(0,0,0)}\n08-07 18:18:00.185 E/AndroidRuntime(10399): \tat android.app.ContextImpl.startServiceCommon(ContextImpl.java:1715)\n08-07 18:18:00.185 E/AndroidRuntime(10399): \tat android.app.ContextImpl.startService(ContextImpl.java:1670)\n08-07 18:18:00.185 E/AndroidRuntime(10399): \tat android.content.ContextWrapper.startService(ContextWrapper.java:720)\n08-07 18:18:00.185 E/AndroidRuntime(10399): \tat android.content.ContextWrapper.startService(ContextWrapper.java:720)\n08-07 18:18:00.185 E/AndroidRuntime(10399): \tat uk.org.xibo.alarms.LicenceServiceReceiver.onReceive(LicenceServiceReceiver.java:8)\n08-07 18:18:00.185 E/AndroidRuntime(10399): \tat android.app.ActivityThread.handleReceiver(ActivityThread.java:4026)\n08-07 18:18:00.185 E/AndroidRuntime(10399): \t… 8 more\n08-07 18:18:00.186 E/ACRA (10399): ACRA caught a RuntimeException for com.signage.jaesggaklo\n08-07 18:18:00.186 E/ACRA (10399): java.lang.RuntimeException: Unable to start receiver uk.org.xibo.alarms.LicenceServiceReceiver: java.lang.IllegalStateException: Not allowed to start service Intent { cmp=com.signage.jaesggaklo/uk.org.xibo.xmds.LicenceService }: app is in background uid UidRecord{8892da3 u0a72 RCVR bg:+8m4s373ms idle change:uncached procs:3 seq(0,0,0)}\n08-07 18:18:00.186 E/ACRA (10399): \tat android.app.ActivityThread.handleReceiver(ActivityThread.java:4035)\n08-07 18:18:00.186 E/ACRA (10399): \tat android.app.ActivityThread.access$1400(ActivityThread.java:237)\n08-07 18:18:00.186 E/ACRA (10399): \tat android.app.ActivityThread$H.handleMessage(ActivityThread.java:1924)\n08-07 18:18:00.186 E/ACRA (10399): \tat android.os.Handler.dispatchMessage(Handler.java:106)\n08-07 18:18:00.186 E/ACRA (10399): \tat android.os.Looper.loop(Looper.java:223)\n08-07 18:18:00.186 E/ACRA (10399): \tat android.app.ActivityThread.main(ActivityThread.java:7664)\n08-07 18:18:00.186 E/ACRA (10399): \tat java.lang.reflect.Method.invoke(Native Method)\n08-07 18:18:00.186 E/ACRA (10399): \tat com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:592)\n08-07 18:18:00.186 E/ACRA (10399): \tat com.android.internal.os.ZygoteInit.main(ZygoteInit.java:952)\n08-07 18:18:00.186 E/ACRA (10399): Caused by: java.lang.IllegalStateException: Not allowed to start service Intent { cmp=com.signage.jaesggaklo/uk.org.xibo.xmds.LicenceService }: app is in background uid UidRecord{8892da3 u0a72 RCVR bg:+8m4s373ms idle change:uncached procs:3 seq(0,0,0)}\n08-07 18:18:00.186 E/ACRA (10399): \tat android.app.ContextImpl.startServiceCommon(ContextImpl.java:1715)\n08-07 18:18:00.186 E/ACRA (10399): \tat android.app.ContextImpl.startService(ContextImpl.java:1670)\n08-07 18:18:00.186 E/ACRA (10399): \tat android.content.ContextWrapper.startService(ContextWrapper.java:720)\n08-07 18:18:00.186 E/ACRA (10399): \tat android.content.ContextWrapper.startService(ContextWrapper.java:720)\n08-07 18:18:00.186 E/ACRA (10399): \tat uk.org.xibo.alarms.LicenceServiceReceiver.onReceive(LicenceServiceReceiver.java:8)\n08-07 18:18:00.186 E/ACRA (10399): \tat android.app.ActivityThread.handleReceiver(ActivityThread.java:4026)\n08-07 18:18:00.186 E/ACRA (10399): \t… 8 more\n08-07 18:18:00.199 I/logcat (10492): type=1400 audit(0.0:31469): avc: denied { search } for name="/" dev="dm-0" ino=2 scontext=u:r:untrusted_app_27:s0:c72,c256,c512,c768 tcontext=u:object_r:unlabeled:s0 tclass=dir permissive=1 trawcon="u:object_r:odm_file:s0" app=com.signage.jaesggaklo\n08-07 18:18:00.213 D/[186252.897800@0] logd( 0): logdr: UID=10072 GID=10072 PID=10492 n tail=100 logMask=99 pid=0 start=0ns timeout=0ns”,“USER_CRASH_DATE”:“2024-08-07T18:18:00.244-03:00”,“PHONE_MODEL”:“A95XF4”,“STACK_TRACE”:“java.lang.RuntimeException: Unable to start receiver uk.org.xibo.alarms.LicenceServiceReceiver: java.lang.IllegalStateException: Not allowed to start service Intent { cmp=com.signage.jaesggaklo/uk.org.xibo.xmds.LicenceService }: app is in background uid UidRecord{8892da3 u0a72 RCVR bg:+8m4s373ms idle change:uncached procs:3 seq(0,0,0)}\n\tat android.app.ActivityThread.handleReceiver(ActivityThread.java:4035)\n\tat android.app.ActivityThread.access$1400(ActivityThread.java:237)\n\tat android.app.ActivityThread$H.handleMessage(ActivityThread.java:1924)\n\tat android.os.Handler.dispatchMessage(Handler.java:106)\n\tat android.os.Looper.loop(Looper.java:223)\n\tat android.app.ActivityThread.main(ActivityThread.java:7664)\n\tat java.lang.reflect.Method.invoke(Native Method)\n\tat com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:592)\n\tat com.android.internal.os.ZygoteInit.main(ZygoteInit.java:952)\nCaused by: java.lang.IllegalStateException: Not allowed to start service Intent { cmp=com.signage.jaesggaklo/uk.org.xibo.xmds.LicenceService }: app is in background uid UidRecord{8892da3 u0a72 RCVR bg:+8m4s373ms idle change:uncached procs:3 seq(0,0,0)}\n\tat android.app.ContextImpl.startServiceCommon(ContextImpl.java:1715)\n\tat android.app.ContextImpl.startService(ContextImpl.java:1670)\n\tat android.content.ContextWrapper.startService(ContextWrapper.java:720)\n\tat android.content.ContextWrapper.startService(ContextWrapper.java:720)\n\tat uk.org.xibo.alarms.LicenceServiceReceiver.onReceive(LicenceServiceReceiver.java:8)\n\tat android.app.ActivityThread.handleReceiver(ActivityThread.java:4026)\n\t… 8 more\njava.lang.IllegalStateException: Not allowed to start service Intent { cmp=com.signage.jaesggaklo/uk.org.xibo.xmds.LicenceService }: app is in background uid UidRecord{8892da3 u0a72 RCVR bg:+8m4s373ms idle change:uncached procs:3 seq(0,0,0)}\n\tat android.app.ContextImpl.startServiceCommon(ContextImpl.java:1715)\n\tat android.app.ContextImpl.startService(ContextImpl.java:1670)\n\tat android.content.ContextWrapper.startService(ContextWrapper.java:720)\n\tat android.content.ContextWrapper.startService(ContextWrapper.java:720)\n\tat uk.org.xibo.alarms.LicenceServiceReceiver.onReceive(LicenceServiceReceiver.java:8)\n\tat android.app.ActivityThread.handleReceiver(ActivityThread.java:4026)\n\tat android.app.ActivityThread.access$1400(ActivityThread.java:237)\n\tat android.app.ActivityThread$H.handleMessage(ActivityThread.java:1924)\n\tat android.os.Handler.dispatchMessage(Handler.java:106)\n\tat android.os.Looper.loop(Looper.java:223)\n\tat android.app.ActivityThread.main(ActivityThread.java:7664)\n\tat java.lang.reflect.Method.invoke(Native Method)\n\tat com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:592)\n\tat com.android.internal.os.ZygoteInit.main(ZygoteInit.java:952)\n”,“REPORT_ID”:“ac05d008-81e9-476b-a007-56eb0118460d”,“USER_APP_START_DATE”:“2024-08-07T18:09:45.902-03:00”}

dan · August 8, 2024, 4:04pm

The errors there might be false positives, they might not. They all refer to the same thing which is that from Android 11 apps require additional permissions to start their activities and services if the app is in the background.

The app may have stopped for another unrecorded reason, and these errors are logged as it tries to restart itself, or they may be indicative of the action problem.

We’ve request this permission in later versions of Xibo for Android, so the best option would be to try out the latest v4 player on one unit and see if it improves. When upgrading you’d be asked to grant the additional permissions if you go into the connect to CMS screen.

pitoco02 · August 13, 2024, 3:00pm

Hi @dan, thanks for thw awnser!

I updated a device with this behavior to compare, just as you advised.
I will monitor behavior and keep the community informed about it.

Is it possible to release an R313 version with these updated permissions?
At the moment I won’t be able to buy enough V4 licenses for all the devices. Thanks!

dan · August 15, 2024, 12:51pm

Unfortunately it is not possible to add this permission to the v3 player, although you may be able to manually grant it using the “Draw over other apps” functionality in settings on your device.

system · November 14, 2024, 6:51pm

This topic was automatically closed 91 days after the last reply. New replies are no longer allowed.