Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Crashes when run in work profile with microg #7

Closed
rugk opened this issue Apr 19, 2019 · 4 comments
Closed

Crashes when run in work profile with microg #7

rugk opened this issue Apr 19, 2019 · 4 comments

Comments

@rugk
Copy link

rugk commented Apr 19, 2019 •
edited
Loading

Crashes when trying to register for push notifications.

LineageOS 14.1 for microG
inside of shelter (work profile)
see https://git.angry.im/PeterCxy/Shelter/issues/26#issuecomment-231 for details

Logcat:

04-19 09:51:30.017   678   829 I ActivityManager: START u0 {act=net.typeblog.shelter.action.UNFREEZE_AND_LAUNCH flg=0x10000000 cmp=net.typeblog.shelter/.ui.DummyActivity (has extras)} from uid 10232 on display 0
04-19 09:51:30.107   678  1581 I ActivityManager: START u0 {act=net.typeblog.shelter.action.UNFREEZE_AND_LAUNCH cmp=android/com.android.internal.app.ForwardIntentToManagedProfile (has extras)} from uid 10232 on display 0
04-19 09:51:30.139   678   678 I ActivityManager: START u10 {act=net.typeblog.shelter.action.UNFREEZE_AND_LAUNCH flg=0x3800000 cmp=net.typeblog.shelter/.ui.DummyActivity (has extras) u=0} from uid 10232 on display 0
04-19 09:51:30.208   678  2673 I Adreno-EGL: <qeglDrvAPI_eglInitialize:379>: QUALCOMM Build: 10/21/15, 369a2ea, I96aee987eb
04-19 09:51:30.208   678  2673 I OpenGLRenderer: Initialized EGL, version 1.4
04-19 09:51:30.209   678  2673 D OpenGLRenderer: Swap behavior 1
04-19 09:51:30.353   678   829 I ActivityManager: START u10 {act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10000000 pkg=com.firstrowria.pushnotificationtester cmp=com.firstrowria.pushnotificationtester/.activities.MainActivity} from uid 1010232 on display 0
04-19 09:51:30.428   678  1574 W ActivityManager: Slow operation: 52ms so far, now at startProcess: returned from zygote!
04-19 09:51:30.428   678  1574 W ActivityManager: Slow operation: 52ms so far, now at startProcess: done updating battery stats
04-19 09:51:30.428   678  1574 W ActivityManager: Slow operation: 52ms so far, now at startProcess: building log message
04-19 09:51:30.428   678  1574 I ActivityManager: Start proc 6227:com.firstrowria.pushnotificationtester/u10a151 for activity com.firstrowria.pushnotificationtester/.activities.MainActivity
04-19 09:51:30.428   678  1574 W ActivityManager: Slow operation: 53ms so far, now at startProcess: starting to update pids map
04-19 09:51:30.428   678  1574 W ActivityManager: Slow operation: 53ms so far, now at startProcess: done updating pids map
04-19 09:51:30.429   678  1574 W ActivityManager: Slow operation: 53ms so far, now at startProcess: done starting proc!
04-19 09:51:30.532  6227  6227 I art     : Starting a blocking GC AddRemoveAppImageSpace
04-19 09:51:30.534  6227  6227 W System  : ClassLoader referenced unknown path: /data/app/com.firstrowria.pushnotificationtester-2/lib/arm
04-19 09:51:30.607  6227  6227 D FirebaseApp: com.google.firebase.auth.FirebaseAuth is not linked. Skipping initialization.
04-19 09:51:30.608  6227  6227 D FirebaseApp: com.google.firebase.crash.FirebaseCrash is not linked. Skipping initialization.
04-19 09:51:30.641  6227  6227 I FirebaseInitProvider: FirebaseApp initialization successful
04-19 09:51:30.674  6227  6246 I FA      : App measurement is starting up, version: 12451
04-19 09:51:30.674  6227  6246 I FA      : To enable debug logging run: adb shell setprop log.tag.FA VERBOSE
04-19 09:51:30.674  6227  6246 I FA      : To enable faster debug mode event logging run:
04-19 09:51:30.674  6227  6246 I FA      :   adb shell setprop debug.firebase.analytics.app com.firstrowria.pushnotificationtester
04-19 09:51:30.850   678   766 D WifiStateMachine: updateCapabilities for config:******false,false
04-19 09:51:30.974  6227  6249 I Adreno-EGL: <qeglDrvAPI_eglInitialize:379>: QUALCOMM Build: 10/21/15, 369a2ea, I96aee987eb
04-19 09:51:30.989  6249  6249 W RenderThread: type=1400 audit(0.0:16): avc: denied { read } for name="gpuclk" dev="sysfs" ino=11273 scontext=u:r:untrusted_app:s0:c522,c768 tcontext=u:object_r:sysfs:s0 tclass=file permissive=0
04-19 09:51:30.989  6249  6249 W RenderThread: type=1300 audit(0.0:16): arch=40000028 syscall=322 per=800008 success=no exit=-13 a0=ffffff9c a1=a759d07a a2=20000 a3=0 items=1 ppid=318 auid=4294967295 uid=1010151 gid=1010151 euid=1010151 suid=1010151 fsuid=1010151 egid=1010151 sgid=1010151 fsgid=1010151 tty=(none) ses=4294967295 exe="/system/bin/app_process32" subj=u:r:untrusted_app:s0:c522,c768 key=(null)
04-19 09:51:30.989   211   211 W auditd  : type=1307 audit(0.0:16): cwd="/"
04-19 09:51:30.989   211   211 W auditd  : type=1302 audit(0.0:16): item=0 name="/sys/class/kgsl/kgsl-3d0/gpuclk" inode=11273 dev=00:0d mode=0100644 ouid=0 ogid=0 rdev=00:00 obj=u:object_r:sysfs:s0
04-19 09:51:30.989   211   211 W auditd  : type=1320 audit(0.0:16): 
04-19 09:51:30.999  6227  6249 I OpenGLRenderer: Initialized EGL, version 1.4
04-19 09:51:30.999  6227  6249 D OpenGLRenderer: Swap behavior 1
04-19 09:51:31.003  6227  6249 W Adreno-ES20: <get_gpu_clk:229>: open failed: errno 13
04-19 09:51:31.142   678   710 I ActivityManager: Displayed com.firstrowria.pushnotificationtester/.activities.MainActivity: +757ms (total +7s41ms)
04-19 09:51:31.145   808   808 W InputMethodService: Window size has been changed. This may cause jankiness of resizing window: -1 -> -2
04-19 09:51:31.145  5610  5610 W IInputConnectionWrapper: finishComposingText on inactive InputConnection
04-19 09:51:31.148  5610  5610 W IInputConnectionWrapper: reportFullscreenMode on inexistent InputConnection
04-19 09:51:31.151  5610  5610 W IInputConnectionWrapper: finishComposingText on inactive InputConnection
04-19 09:51:32.001  6227  6246 W art     : Long monitor contention with owner pool-2-thread-1 (6245) at long com.android.org.conscrypt.NativeCrypto.RSA_generate_key_ex(int, byte[])(NativeCrypto.java:-2) waiters=0 in com.google.firebase.iid.q com.google.firebase.iid.p.a(java.lang.String, java.lang.String, java.lang.String) for 487ms
04-19 09:51:32.018  3937  3937 D GmsGcmRegisterSvc: onBind: Intent { act=com.google.android.c2dm.intent.REGISTER pkg=com.google.android.gms }
04-19 09:51:32.072  6227  6245 E FirebaseInstanceId: Token retrieval failed: SERVICE_NOT_AVAILABLE
04-19 09:51:32.073  3937  3937 D GmsMeasureBrokerSvc: onBind: Intent { act=com.google.android.gms.measurement.START pkg=com.google.android.gms }
04-19 09:51:32.080  6227  6246 I FA      : Tag Manager is not found and thus will not be used
04-19 09:51:32.083  3937  4077 D SafeParcel: Unknown field num 10 in com.google.android.gms.common.internal.GetServiceRequest, skipping.
04-19 09:51:32.083  3937  4077 D SafeParcel: Unknown field num 11 in com.google.android.gms.common.internal.GetServiceRequest, skipping.
04-19 09:51:32.083  3937  4077 D SafeParcel: Unknown field num 12 in com.google.android.gms.common.internal.GetServiceRequest, skipping.
04-19 09:51:32.083  3937  4077 D GmsMeasureBrokerSvc: bound by: GetServiceRequest{serviceId=MEASUREMENT, gmsVersion=12451000, packageName='com.firstrowria.pushnotificationtester', extras=Bundle[{}]}
04-19 09:51:32.176  3937  3960 D GmsMeasureSvcImpl: onTransact [unknown]: 4, android.os.Parcel@82d92b5, 16
04-19 09:51:32.210  3937  4065 D GmsMeasureSvcImpl: onTransact [unknown]: 1, android.os.Parcel@371a531, 16
04-19 09:51:32.212  3937  3961 D GmsMeasureSvcImpl: onTransact [unknown]: 11, android.os.Parcel@82d92b5, 16
04-19 09:51:32.225  3937  4077 D GmsMeasureSvcImpl: onTransact [unknown]: 10, android.os.Parcel@371a531, 16
04-19 09:51:33.057   319   415 D audio_hw_primary: out_set_parameters: enter: usecase(1: low-latency-playback) kvpairs: routing=2
04-19 09:51:33.082  6227  6227 D PushNotificationTester: Connected to Internet: WIFI
04-19 09:51:33.102  6227  6281 D NetworkSecurityConfig: No Network Security Config specified, using platform default
04-19 09:51:33.113  6227  6281 W System  : ClassLoader referenced unknown path: /system/framework/tcmclient.jar
04-19 09:51:33.119  6227  6282 D PushNotificationTester: check token availability
04-19 09:51:33.655   678   678 W WindowManager: Attempted to remove non-existing token: android.os.Binder@c1ddb73
04-19 09:51:34.106  6227  6282 D PushNotificationTester: check token availability
04-19 09:51:35.106  6227  6282 D PushNotificationTester: check token availability
04-19 09:51:36.106  6227  6282 D PushNotificationTester: check token availability
04-19 09:51:36.197   319   415 D audio_hw_primary: out_standby: enter: stream (0xb61c4240) usecase(1: low-latency-playback)
04-19 09:51:37.106  6227  6282 D PushNotificationTester: check token availability
04-19 09:51:38.105  6227  6282 D PushNotificationTester: check token availability
04-19 09:51:39.105  6227  6282 D PushNotificationTester: check token availability
04-19 09:51:40.106  6227  6282 D PushNotificationTester: check token availability
04-19 09:51:40.231  2090  2090 D smarter : service binder call and bind, isbound=true
04-19 09:51:40.231  2090  2090 D smarter : service binder already bound, not rebinding
04-19 09:51:40.424  2090  2090 W Settings: Setting airplane_mode_on has moved from android.provider.Settings.System to android.provider.Settings.Global, returning read-only value.
04-19 09:51:41.106  6227  6282 D PushNotificationTester: check token availability
04-19 09:51:42.106  6227  6282 D PushNotificationTester: check token availability
04-19 09:51:42.106  6227  6282 E PushNotificationTester: Registering for Push Notifications failed
04-19 09:51:42.120  6227  6282 E AndroidRuntime: FATAL EXCEPTION: Timer-0
04-19 09:51:42.120  6227  6282 E AndroidRuntime: Process: com.firstrowria.pushnotificationtester, PID: 6227
04-19 09:51:42.120  6227  6282 E AndroidRuntime: android.view.ViewRootImpl$CalledFromWrongThreadException: Only the original thread that created a view hierarchy can touch its views.
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at android.view.ViewRootImpl.checkThread(ViewRootImpl.java:6898)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at android.view.ViewRootImpl.invalidateChildInParent(ViewRootImpl.java:1083)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at android.view.ViewGroup.invalidateChild(ViewGroup.java:5205)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at android.view.View.invalidateInternal(View.java:13660)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at android.view.View.invalidate(View.java:13624)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at android.view.View.setFlags(View.java:11465)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at android.view.View.setVisibility(View.java:8069)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at android.widget.ImageView.setVisibility(ImageView.java:1551)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at com.firstrowria.pushnotificationtester.activities.a.a(Unknown Source)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at com.firstrowria.pushnotificationtester.activities.MainActivity$b.onReceive(Unknown Source)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at android.support.v4.a.c.a(Unknown Source)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at android.support.v4.a.c.b(Unknown Source)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at com.firstrowria.pushnotificationtester.services.FCMInstanceIDListenerService$a.a(Unknown Source)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at com.firstrowria.pushnotificationtester.services.FCMInstanceIDListenerService$a.a(Unknown Source)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at com.firstrowria.pushnotificationtester.services.FCMInstanceIDListenerService$a$b.run(Unknown Source)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at java.util.TimerThread.mainLoop(Timer.java:555)
04-19 09:51:42.120  6227  6282 E AndroidRuntime: 	at java.util.TimerThread.run(Timer.java:505)
04-19 09:51:42.129   678   691 W ActivityManager:   Force finishing activity com.firstrowria.pushnotificationtester/.activities.MainActivity
04-19 09:51:42.142   678   691 W ActivityManager:   Force finishing activity com.firstrowria.pushnotificationtester/.activities.MainActivity
04-19 09:51:42.143   678   691 W ActivityManager: Duplicate finish request for ActivityRecord{c7f2c19 u10 com.firstrowria.pushnotificationtester/.activities.MainActivity t1000075 f}
04-19 09:51:42.230  3937  3960 D SafeParcel: Unknown field num 10 in com.google.android.gms.common.internal.GetServiceRequest, skipping.
04-19 09:51:42.230  3937  3960 D SafeParcel: Unknown field num 11 in com.google.android.gms.common.internal.GetServiceRequest, skipping.
04-19 09:51:42.230  3937  3960 D SafeParcel: Unknown field num 12 in com.google.android.gms.common.internal.GetServiceRequest, skipping.
04-19 09:51:42.230  3937  3960 D GmsMeasureBrokerSvc: bound by: GetServiceRequest{serviceId=MEASUREMENT, gmsVersion=12451000, packageName='com.firstrowria.pushnotificationtester', extras=Bundle[{}]}
04-19 09:51:42.250   678  6332 W DropBoxManagerService: Dropping: data_app_crash (1491 > 0 bytes)
04-19 09:51:42.343   808   808 W InputMethodService: Window size has been changed. This may cause jankiness of resizing window: -1 -> -2
04-19 09:51:42.348   678  2673 I Adreno-EGL: <qeglDrvAPI_eglInitialize:379>: QUALCOMM Build: 10/21/15, 369a2ea, I96aee987eb
04-19 09:51:42.349   678  2673 I OpenGLRenderer: Initialized EGL, version 1.4
04-19 09:51:42.349   678  2673 D OpenGLRenderer: Swap behavior 1
04-19 09:51:42.356   808   808 I LatinIME: Starting input. Cursor position = 2,2
04-19 09:51:42.529  3937  3961 D GmsMeasureSvcImpl: onTransact [unknown]: 10, android.os.Parcel@82d92b5, 16
04-19 09:51:42.548   678   689 I art     : Background partial concurrent mark sweep GC freed 116500(5MB) AllocSpace objects, 11(216KB) LOS objects, 33% free, 17MB/26MB, paused 3.448ms total 372.497ms
04-19 09:51:42.551   822   845 I art     : Background partial concurrent mark sweep GC freed 36736(1978KB) AllocSpace objects, 3(196KB) LOS objects, 31% free, 34MB/50MB, paused 885us total 110.046ms
04-19 09:51:42.682  3937  4077 D GmsMeasureSvcImpl: onTransact [unknown]: 1, android.os.Parcel@371a531, 16
04-19 09:51:43.035   225   225 W SurfaceFlinger: couldn't log to binary event log: overflow.
@rugk
Copy link
Author

rugk commented Apr 19, 2019 •
edited
Loading

Another try, another logcat:

04-19 10:06:45.565   678  1577 I ActivityManager: Killing 8914:com.svox.pico/u0a55 (adj 906): empty #17
04-19 10:06:45.581   678  1581 D ActivityManager: cleanUpApplicationRecord -- 8914
04-19 10:06:46.440   678   678 W WindowManager: Attempted to remove non-existing token: android.os.Binder@e4365e4
04-19 10:06:46.575   319   415 D audio_hw_primary: out_set_parameters: enter: usecase(1: low-latency-playback) kvpairs: routing=2
04-19 10:06:47.542   678  1074 I ActivityManager: START u0 {act=net.typeblog.shelter.action.UNFREEZE_AND_LAUNCH flg=0x10000000 cmp=net.typeblog.shelter/.ui.DummyActivity (has extras)} from uid 10232 on display 0
04-19 10:06:47.543   319   415 D audio_hw_primary: out_set_parameters: enter: usecase(1: low-latency-playback) kvpairs: routing=2
04-19 10:06:47.630   678  1583 I ActivityManager: START u0 {act=net.typeblog.shelter.action.UNFREEZE_AND_LAUNCH cmp=android/com.android.internal.app.ForwardIntentToManagedProfile (has extras)} from uid 10232 on display 0
04-19 10:06:47.666   678   678 I ActivityManager: START u10 {act=net.typeblog.shelter.action.UNFREEZE_AND_LAUNCH flg=0x3800000 cmp=net.typeblog.shelter/.ui.DummyActivity (has extras) u=0} from uid 10232 on display 0
04-19 10:06:47.775   678  2673 I Adreno-EGL: <qeglDrvAPI_eglInitialize:379>: QUALCOMM Build: 10/21/15, 369a2ea, I96aee987eb
04-19 10:06:47.777   678  2673 I OpenGLRenderer: Initialized EGL, version 1.4
04-19 10:06:47.777   678  2673 D OpenGLRenderer: Swap behavior 1
04-19 10:06:47.869   678  1167 I ActivityManager: START u10 {act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10000000 pkg=com.firstrowria.pushnotificationtester cmp=com.firstrowria.pushnotificationtester/.activities.MainActivity} from uid 1010232 on display 0
04-19 10:06:47.958   678   829 W ActivityManager: Slow operation: 52ms so far, now at startProcess: returned from zygote!
04-19 10:06:47.958   678   829 W ActivityManager: Slow operation: 52ms so far, now at startProcess: done updating battery stats
04-19 10:06:47.958   678   829 W ActivityManager: Slow operation: 53ms so far, now at startProcess: building log message
04-19 10:06:47.958   678   829 I ActivityManager: Start proc 9314:com.firstrowria.pushnotificationtester/u10a151 for activity com.firstrowria.pushnotificationtester/.activities.MainActivity
04-19 10:06:47.958   678   829 W ActivityManager: Slow operation: 53ms so far, now at startProcess: starting to update pids map
04-19 10:06:47.959   678   829 W ActivityManager: Slow operation: 53ms so far, now at startProcess: done updating pids map
04-19 10:06:47.959   678   829 W ActivityManager: Slow operation: 53ms so far, now at startProcess: done starting proc!
04-19 10:06:48.073  9314  9314 I art     : Starting a blocking GC AddRemoveAppImageSpace
04-19 10:06:48.075  9314  9314 W System  : ClassLoader referenced unknown path: /data/app/com.firstrowria.pushnotificationtester-2/lib/arm
04-19 10:06:48.140  9314  9314 D FirebaseApp: com.google.firebase.auth.FirebaseAuth is not linked. Skipping initialization.
04-19 10:06:48.142  9314  9314 D FirebaseApp: com.google.firebase.crash.FirebaseCrash is not linked. Skipping initialization.
04-19 10:06:48.175  9314  9314 I FirebaseInitProvider: FirebaseApp initialization successful
04-19 10:06:48.250  9314  9337 I FA      : App measurement is starting up, version: 12451
04-19 10:06:48.251  9314  9337 I FA      : To enable debug logging run: adb shell setprop log.tag.FA VERBOSE
04-19 10:06:48.251  9314  9337 I FA      : To enable faster debug mode event logging run:
04-19 10:06:48.251  9314  9337 I FA      :   adb shell setprop debug.firebase.analytics.app com.firstrowria.pushnotificationtester
04-19 10:06:48.531  9314  9344 I Adreno-EGL: <qeglDrvAPI_eglInitialize:379>: QUALCOMM Build: 10/21/15, 369a2ea, I96aee987eb
04-19 10:06:48.534  9344  9344 W RenderThread: type=1400 audit(0.0:21): avc: denied { read } for name="gpuclk" dev="sysfs" ino=11273 scontext=u:r:untrusted_app:s0:c522,c768 tcontext=u:object_r:sysfs:s0 tclass=file permissive=0
04-19 10:06:48.534  9344  9344 W RenderThread: type=1300 audit(0.0:21): arch=40000028 syscall=322 per=800008 success=no exit=-13 a0=ffffff9c a1=a759d07a a2=20000 a3=0 items=1 ppid=318 auid=4294967295 uid=1010151 gid=1010151 euid=1010151 suid=1010151 fsuid=1010151 egid=1010151 sgid=1010151 fsgid=1010151 tty=(none) ses=4294967295 exe="/system/bin/app_process32" subj=u:r:untrusted_app:s0:c522,c768 key=(null)
04-19 10:06:48.534   211   211 W auditd  : type=1307 audit(0.0:21): cwd="/"
04-19 10:06:48.534   211   211 W auditd  : type=1302 audit(0.0:21): item=0 name="/sys/class/kgsl/kgsl-3d0/gpuclk" inode=11273 dev=00:0d mode=0100644 ouid=0 ogid=0 rdev=00:00 obj=u:object_r:sysfs:s0
04-19 10:06:48.534   211   211 W auditd  : type=1320 audit(0.0:21): 
04-19 10:06:48.536  9314  9344 I OpenGLRenderer: Initialized EGL, version 1.4
04-19 10:06:48.537  9314  9344 D OpenGLRenderer: Swap behavior 1
04-19 10:06:48.542  9314  9344 W Adreno-ES20: <get_gpu_clk:229>: open failed: errno 13
04-19 10:06:48.679  3937  3937 D GmsGcmRegisterSvc: onBind: Intent { act=com.google.android.c2dm.intent.REGISTER pkg=com.google.android.gms }
04-19 10:06:48.699   808   808 W InputMethodService: Window size has been changed. This may cause jankiness of resizing window: -1 -> -2
04-19 10:06:48.701  5610  5610 W IInputConnectionWrapper: finishComposingText on inactive InputConnection
04-19 10:06:48.704  5610  5610 W IInputConnectionWrapper: reportFullscreenMode on inexistent InputConnection
04-19 10:06:48.704  5610  5610 W IInputConnectionWrapper: finishComposingText on inactive InputConnection
04-19 10:06:48.706   678   710 I ActivityManager: Displayed com.firstrowria.pushnotificationtester/.activities.MainActivity: +791ms (total +4s653ms)
04-19 10:06:48.723  5610  5615 I art     : Do partial code cache collection, code=235KB, data=238KB
04-19 10:06:48.729  5610  5615 I art     : After code cache collection, code=235KB, data=238KB
04-19 10:06:48.729  5610  5615 I art     : Increasing code cache capacity to 1024KB
04-19 10:06:48.758  9314  9336 E FirebaseInstanceId: Token retrieval failed: SERVICE_NOT_AVAILABLE
04-19 10:06:49.348  3937  3937 D GmsMeasureBrokerSvc: onBind: Intent { act=com.google.android.gms.measurement.START pkg=com.google.android.gms }
04-19 10:06:49.363  3937  5360 D SafeParcel: Unknown field num 10 in com.google.android.gms.common.internal.GetServiceRequest, skipping.
04-19 10:06:49.363  3937  5360 D SafeParcel: Unknown field num 11 in com.google.android.gms.common.internal.GetServiceRequest, skipping.
04-19 10:06:49.363  3937  5360 D SafeParcel: Unknown field num 12 in com.google.android.gms.common.internal.GetServiceRequest, skipping.
04-19 10:06:49.363  3937  5360 D GmsMeasureBrokerSvc: bound by: GetServiceRequest{serviceId=MEASUREMENT, gmsVersion=12451000, packageName='com.firstrowria.pushnotificationtester', extras=Bundle[{}]}
04-19 10:06:49.364  9314  9337 I FA      : Tag Manager is not found and thus will not be used
04-19 10:06:49.451  3937  3960 D GmsMeasureSvcImpl: onTransact [unknown]: 4, android.os.Parcel@371a531, 16
04-19 10:06:49.495  3937  4065 D GmsMeasureSvcImpl: onTransact [unknown]: 1, android.os.Parcel@82d92b5, 16
04-19 10:06:49.495  3937  3961 D GmsMeasureSvcImpl: onTransact [unknown]: 11, android.os.Parcel@371a531, 16
04-19 10:06:49.503  3937  5360 D GmsMeasureSvcImpl: onTransact [unknown]: 10, android.os.Parcel@82d92b5, 16
04-19 10:06:49.595   319   415 D audio_hw_primary: out_set_parameters: enter: usecase(1: low-latency-playback) kvpairs: routing=2
04-19 10:06:49.600  9314  9314 D PushNotificationTester: Connected to Internet: WIFI
04-19 10:06:49.608  9314  9359 D NetworkSecurityConfig: No Network Security Config specified, using platform default
04-19 10:06:49.609  9314  9359 W System  : ClassLoader referenced unknown path: /system/framework/tcmclient.jar
04-19 10:06:49.613  9314  9360 D PushNotificationTester: check token availability
04-19 10:06:50.610  9314  9360 D PushNotificationTester: check token availability
04-19 10:06:51.199   678   678 W WindowManager: Attempted to remove non-existing token: android.os.Binder@8f7ae4f
04-19 10:06:51.610  9314  9360 D PushNotificationTester: check token availability
04-19 10:06:52.611  9314  9360 D PushNotificationTester: check token availability
04-19 10:06:52.732   319   415 D audio_hw_primary: out_standby: enter: stream (0xb61c4240) usecase(1: low-latency-playback)
04-19 10:06:53.611  9314  9360 D PushNotificationTester: check token availability
04-19 10:06:54.614  9314  9360 D PushNotificationTester: check token availability
04-19 10:06:55.612  9314  9360 D PushNotificationTester: check token availability
04-19 10:06:56.610  9314  9360 D PushNotificationTester: check token availability
04-19 10:06:57.131   678   766 D WifiStateMachine: updateCapabilities for config:******false,false
04-19 10:06:57.610  9314  9360 D PushNotificationTester: check token availability
04-19 10:06:58.610  9314  9360 D PushNotificationTester: check token availability
04-19 10:06:58.611  9314  9360 E PushNotificationTester: Registering for Push Notifications failed
04-19 10:06:58.619  9314  9360 E AndroidRuntime: FATAL EXCEPTION: Timer-0
04-19 10:06:58.619  9314  9360 E AndroidRuntime: Process: com.firstrowria.pushnotificationtester, PID: 9314
04-19 10:06:58.619  9314  9360 E AndroidRuntime: android.view.ViewRootImpl$CalledFromWrongThreadException: Only the original thread that created a view hierarchy can touch its views.
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at android.view.ViewRootImpl.checkThread(ViewRootImpl.java:6898)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at android.view.ViewRootImpl.invalidateChildInParent(ViewRootImpl.java:1083)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at android.view.ViewGroup.invalidateChild(ViewGroup.java:5205)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at android.view.View.invalidateInternal(View.java:13660)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at android.view.View.invalidate(View.java:13624)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at android.view.View.setFlags(View.java:11465)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at android.view.View.setVisibility(View.java:8069)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at android.widget.ImageView.setVisibility(ImageView.java:1551)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at com.firstrowria.pushnotificationtester.activities.a.a(Unknown Source)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at com.firstrowria.pushnotificationtester.activities.MainActivity$b.onReceive(Unknown Source)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at android.support.v4.a.c.a(Unknown Source)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at android.support.v4.a.c.b(Unknown Source)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at com.firstrowria.pushnotificationtester.services.FCMInstanceIDListenerService$a.a(Unknown Source)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at com.firstrowria.pushnotificationtester.services.FCMInstanceIDListenerService$a.a(Unknown Source)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at com.firstrowria.pushnotificationtester.services.FCMInstanceIDListenerService$a$b.run(Unknown Source)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at java.util.TimerThread.mainLoop(Timer.java:555)
04-19 10:06:58.619  9314  9360 E AndroidRuntime: 	at java.util.TimerThread.run(Timer.java:505)
04-19 10:06:58.628   678   829 W ActivityManager:   Force finishing activity com.firstrowria.pushnotificationtester/.activities.MainActivity
04-19 10:06:58.652   678   829 W ActivityManager:   Force finishing activity com.firstrowria.pushnotificationtester/.activities.MainActivity
04-19 10:06:58.652   678   829 W ActivityManager: Duplicate finish request for ActivityRecord{fc142f8 u10 com.firstrowria.pushnotificationtester/.activities.MainActivity t1000082 f}
04-19 10:06:58.662   678  9403 W DropBoxManagerService: Dropping: data_app_crash (1491 > 0 bytes)
04-19 10:06:58.730  3937  4077 D SafeParcel: Unknown field num 10 in com.google.android.gms.common.internal.GetServiceRequest, skipping.
04-19 10:06:58.731  3937  4077 D SafeParcel: Unknown field num 11 in com.google.android.gms.common.internal.GetServiceRequest, skipping.
04-19 10:06:58.731  3937  4077 D SafeParcel: Unknown field num 12 in com.google.android.gms.common.internal.GetServiceRequest, skipping.
04-19 10:06:58.731  3937  4077 D GmsMeasureBrokerSvc: bound by: GetServiceRequest{serviceId=MEASUREMENT, gmsVersion=12451000, packageName='com.firstrowria.pushnotificationtester', extras=Bundle[{}]}
04-19 10:06:58.845   678   692 W InputMethodManagerService: Focus gain on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@10dca5e (uid=10232 pid=5610)
04-19 10:06:58.849   678  1581 W InputMethodManagerService: Ignoring showSoftInput of uid 10232: com.android.internal.view.IInputMethodClient$Stub$Proxy@b7cf9c9
04-19 10:06:58.888   678  2673 I Adreno-EGL: <qeglDrvAPI_eglInitialize:379>: QUALCOMM Build: 10/21/15, 369a2ea, I96aee987eb
04-19 10:06:58.888   678  2673 I OpenGLRenderer: Initialized EGL, version 1.4
04-19 10:06:58.888   678  2673 D OpenGLRenderer: Swap behavior 1
04-19 10:06:58.946  3937  4065 D GmsMeasureSvcImpl: onTransact [unknown]: 10, android.os.Parcel@371a531, 16
04-19 10:06:58.996   678   689 I art     : Background partial concurrent mark sweep GC freed 140250(6MB) AllocSpace objects, 12(240KB) LOS objects, 33% free, 17MB/26MB, paused 2.502ms total 309.234ms
04-19 10:06:59.021  3937  3961 D GmsMeasureSvcImpl: onTransact [unknown]: 1, android.os.Parcel@82d92b5, 16
04-19 10:06:59.475   678   702 I ActivityManager: Killing 8865:org.fdroid.fdroid/u0a64 (adj 906): empty #17
04-19 10:06:59.497   225   225 W SurfaceFlinger: couldn't log to binary event log: overflow.
04-19 10:06:59.523   678  1583 D ActivityManager: cleanUpApplicationRecord -- 8865
04-19 10:07:00.178   678   766 D WifiStateMachine: updateCapabilities for config:******false,false
04-19 10:07:00.972   678   829 I ActivityManager: Killing 9314:com.firstrowria.pushnotificationtester/u10a151 (adj 900): crash
04-19 10:07:00.972   678   829 D ActivityManager: cleanUpApplicationRecord -- 9314
04-19 10:07:01.020   678   703 W InputEventReceiver: Attempted to finish an input event but the input event receiver has already been disposed.
04-19 10:07:01.020   678   703 W ViewRootImpl[pushnotificationtester]: Dropping event due to root view being removed: MotionEvent { action=ACTION_MOVE, actionButton=0, id[0]=0, x[0]=443.0, y[0]=980.0, toolType[0]=TOOL_TYPE_FINGER, buttonState=0, metaState=0, flags=0x0, edgeFlags=0x0, pointerCount=1, historySize=1, eventTime=1191033, downTime=1191006, deviceId=21, source=0x1002 }
04-19 10:07:01.020   678   703 W InputEventReceiver: Attempted to finish an input event but the input event receiver has already been disposed.
04-19 10:07:01.029   808   808 W InputMethodService: Window size has been changed. This may cause jankiness of resizing window: -1 -> -2
04-19 10:07:01.052   808   808 I LatinIME: Starting input. Cursor position = 3,3
04-19 10:07:01.154   678   692 D GraphicsStats: Buffer count: 9
04-19 10:07:01.213   678   710 W AppOps  : Finishing op nesting under-run: uid 1000 pkg android code 24 time=0 duration=0 nesting=0

@rugk rugk mentioned this issue Apr 19, 2019
Open
@bbindreiter
Copy link
Owner

Before I try to reproduce the issue, please update to the latest version from Google Play. I updated all the libraries and built with the app with the latest SDK. Please report back whether it's been fixed

@rugk
Copy link
Author

rugk commented Apr 19, 2019 •
edited
Loading

Released just some minutes ago, right?

Okay, so, it now indeed doesd not crash anymore. Still fails though, so if you can help in any way that would be great…

Logcat:

04-19 20:49:17.325 12298 12316 I ActivityManager: Start proc 21589:com.firstrowria.pushnotificationtester/u11a151 for activity com.firstrowria.pushnotificationtester/.activities.MainActivity
04-19 20:49:17.351 12298 12328 I ActivityManager: Killing 20763:com.android.settings/1000 (adj 906): empty #17
04-19 20:49:17.360 12298 12328 I ActivityManager: Killing 20458:com.android.deskclock/u0a45 (adj 906): empty #18
04-19 20:49:17.380 12298 18489 D GraphicsStats: Buffer count: 7
04-19 20:49:17.381 12298 13435 D ActivityManager: cleanUpApplicationRecord -- 20458
04-19 20:49:17.409 12298 18489 D GraphicsStats: Buffer count: 6
04-19 20:49:17.409 12298 12571 D WifiService: Client connection lost with reason: 4
04-19 20:49:17.410 12298 13439 D ActivityManager: cleanUpApplicationRecord -- 20763
04-19 20:49:17.466 21589 21589 W System  : ClassLoader referenced unknown path: /data/app/com.firstrowria.pushnotificationtester-1/lib/arm
04-19 20:49:17.519 21589 21589 D FirebaseApp: com.google.firebase.auth.FirebaseAuth is not linked. Skipping initialization.
04-19 20:49:17.521 21589 21589 D FirebaseApp: com.google.firebase.crash.FirebaseCrash is not linked. Skipping initialization.
04-19 20:49:17.522 21589 21589 D FirebaseApp: com.google.android.gms.measurement.AppMeasurement is not linked. Skipping initialization.
04-19 20:49:17.522 21589 21589 I FirebaseInitProvider: FirebaseApp initialization successful
04-19 20:49:17.555 21105 21105 D GmsGcmRegisterSvc: onBind: Intent { act=com.google.android.c2dm.intent.REGISTER pkg=com.google.android.gms }
04-19 20:49:17.924 21589 21627 I Adreno-EGL: <qeglDrvAPI_eglInitialize:379>: QUALCOMM Build: 10/21/15, 369a2ea, I96aee987eb
04-19 20:49:17.930 21589 21627 I OpenGLRenderer: Initialized EGL, version 1.4
04-19 20:49:17.931 21589 21627 D OpenGLRenderer: Swap behavior 1
04-19 20:49:17.935 21589 21627 W Adreno-ES20: <get_gpu_clk:229>: open failed: errno 13
04-19 20:49:17.918 21627 21627 W RenderThread: type=1400 audit(0.0:281): avc: denied { read } for name="gpuclk" dev="sysfs" ino=11273 scontext=u:r:untrusted_app:s0:c523,c768 tcontext=u:object_r:sysfs:s0 tclass=file permissive=0
04-19 20:49:17.918 21627 21627 W RenderThread: type=1300 audit(0.0:281): arch=40000028 syscall=322 per=800008 success=no exit=-13 a0=ffffff9c a1=a879707a a2=20000 a3=0 items=1 ppid=12068 auid=4294967295 uid=1110151 gid=1110151 euid=1110151 suid=1110151 fsuid=1110151 egid=1110151 sgid=1110151 fsgid=1110151 tty=(none) ses=4294967295 exe="/system/bin/app_process32" subj=u:r:untrusted_app:s0:c523,c768 key=(null)
04-19 20:49:17.918   212   212 W auditd  : type=1307 audit(0.0:281): cwd="/"
04-19 20:49:17.918   212   212 W auditd  : type=1302 audit(0.0:281): item=0 name="/sys/class/kgsl/kgsl-3d0/gpuclk" inode=11273 dev=00:0d mode=0100644 ouid=0 ogid=0 rdev=00:00 obj=u:object_r:sysfs:s0
04-19 20:49:17.918   212   212 W auditd  : type=1320 audit(0.0:281): 
04-19 20:49:18.048 12298 12355 I ActivityManager: Displayed com.firstrowria.pushnotificationtester/.activities.MainActivity: +774ms
04-19 20:49:18.049 21589 21618 E FirebaseInstanceId: Token retrieval failed: SERVICE_NOT_AVAILABLE
04-19 20:49:20.403 12069 12105 D audio_hw_primary: out_standby: enter: stream (0xb6244240) usecase(1: low-latency-playback)
04-19 20:49:21.654 12298 12572 D WifiStateMachine: updateCapabilities for config:*******,false
04-19 20:49:23.000 12298 21629 W DropBoxManagerService: Dropping: system_app_strictmode (1122 > 0 bytes)
04-19 20:49:24.699 12298 12572 D WifiStateMachine: updateCapabilities for config:********,false
04-19 20:49:29.069 12069 12105 D audio_hw_primary: out_set_parameters: enter: usecase(1: low-latency-playback) kvpairs: routing=2
04-19 20:49:29.073 12069 12105 D audio_hw_primary: start_output_stream: enter: stream(0xb6244240)usecase(1: low-latency-playback) devices(0x2)
04-19 20:49:29.073 12069 12105 D audio_hw_primary: select_devices: out_snd_device(2: speaker) in_snd_device(0: )
04-19 20:49:29.073 12069 12105 I msm8960_platform: platform_send_audio_calibration: sending audio calibration for snd_device(2) acdb_id(15)
04-19 20:49:29.073 12069 12105 D ACDB-LOADER: ACDB -> send_audio_cal, acdb_id = 15, path =  0
04-19 20:49:29.073 12069 12105 D ACDB-LOADER: ACDB -> send_adm_topology
04-19 20:49:29.073 12069 12105 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TOPOLOGY_ID
04-19 20:49:29.075 12069 12105 D ACDB-LOADER: ACDB -> send_asm_topology
04-19 20:49:29.075 12069 12105 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TOPOLOGY_ID
04-19 20:49:29.075 12069 12105 D ACDB-LOADER: ACDB -> send_audtable
04-19 20:49:29.075 12069 12105 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TABLE
04-19 20:49:29.075 12069 12105 D ACDB-LOADER: ACDB -> AUDIO_SET_AUDPROC_CAL
04-19 20:49:29.075 12069 12105 D ACDB-LOADER: ACDB -> send_audvoltable
04-19 20:49:29.075 12069 12105 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_GAIN_DEP_VOLTBL_STEP_COPP
04-19 20:49:29.076 12069 12105 E ACDB-LOADER: Error: ACDB AudProc vol returned = -8
04-19 20:49:29.076 12069 12105 D ACDB-LOADER: ACDB -> AUDIO_SET_AUDPROC_VOL_CAL
04-19 20:49:29.076 12069 12105 D ACDB-LOADER: ACDB -> send_afe_cal
04-19 20:49:29.076 12069 12105 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_COMMON_TABLE
04-19 20:49:29.076 12069 12105 D ACDB-LOADER: ACDB -> AUDIO_SET_AFE_CAL
04-19 20:49:29.076 12069 12105 D ACDB-LOADER: ACDB -> send_hw_delay : acdb_id = 15 path = 0
04-19 20:49:29.076 12069 12105 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_DEVICE_PROPERTY_SIZE
04-19 20:49:29.076 12069 12105 D ACDB-LOADER: ACDB -> ACDB_AVSYNC_INFO: ACDB_CMD_GET_DEVICE_PROPERTY
04-19 20:49:29.076 12069 12105 D ACDB-LOADER: send_hw_delay id = 15 delay_num_entries = 1 result = 0
04-19 20:49:29.096 12069 12105 D audio_hw_primary: select_devices: done
04-19 20:49:29.099 21589 21589 D PushNotificationTester: Connected to Internet
04-19 20:49:29.150 21105 21105 D GmsGcmRegisterSvc: onBind: Intent { act=com.google.android.c2dm.intent.REGISTER pkg=com.google.android.gms }
04-19 20:49:29.169 21589 21651 D NetworkSecurityConfig: No Network Security Config specified, using platform default
04-19 20:49:29.183 21589 21651 W System  : ClassLoader referenced unknown path: /system/framework/tcmclient.jar
04-19 20:49:29.293 21589 21589 E PushNotificationTester: Registering for Push Notifications failed

BTW, you can totally reproduce it in a new user profile in Android, too. It does not actually need shelter. It failed and crashed with the same logcat there before…

@bbindreiter
Copy link
Owner

FirebaseInstanceId: Token retrieval failed: SERVICE_NOT_AVAILABLE

There must be something wrong in the general setup in connection with microg. I don't think this is app specific.

@rugk rugk closed this as completed Apr 20, 2019
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@bbindreiter @rugk