Cwa-app-android: Error when communicating with Google API(20): Timing out service connection

Created on 30 Jun 2020 · 12Comments · Source: corona-warn-app/cwa-app-android

Describe the bug

Opening the CWA for the first time today resulted in display of error message Fehler bei Kommunikation mit Google API(20), Error when communicating with Google API(20). Every opening of the app shows this error until Google API(39508) error kicks in (too many calls to API).

Today would have been the first time to have 14/14 active days. Now it stays at 13/14 days.

Sorry I cannot provide more details right now. Unfortunately I had USB debugging off and after switching it on, only the Google API(39508) error was captured in the log. Also, it is a massive hindrance to documentation not being able to take screenshots. I didn't have another smartphone or a computer nearby when the error happened. Users of CWA on iOS apparently can take screenshots without hindrance. Friends on iPhones share screenshots of CWA with me all the time. Frustrating.

Expected behaviour

The app opens without any errors.

Steps to reproduce the issue

Install the app on 16 June 2020 via Google Play Store, keep it updated, version is 1.0.4 before any error in CWA appears
Use app with bluetooth and location on for some time every day; see days active incremented every day
On 25 June 2020 see the Google API(10) error appearing for the first time; error does not appear again that days and days active are incremented when opening the app again
See Google API(10) error appearing and disappearing on other days after that (I don't have an exact log which days); days active are still incremented every day
On 30 June 2020 see Google API(20) error appearing when opening CWA for the first time. Appears again every time the app is opened / put into foreground until no more calls to Google API possible (Google API(39508) error).

Technical details

Device

App Version: 1.0.4
Android Version: 6.0.1 (stock Android of device, not rooted)
Device Model and Manufacturer: Samsung S5 (SM-G900F)
Latest OS Update: can't determine date, Android menu says all available updates installed
- Kernel: 3.4.0-14131106 from 06 Aug 2018
- Build number: MMB29M.G900FXXU1CRH1
Latest Update of CWA: update to 1.0.4
Installation Date of CWA: 16 June 2020
Date/Time of the error: 30 June 2020 about 9:00 local time Germany
Google Play Services version: 20.21.17 (040308-316502805)
Google Mobile Services (GMS) version:
- com.google.android.gms [202117018] [20.21.17 (040308-316502805)] [Container]
- com.google.android.gms.nearby_en [v202304013]

Additional context

This error happened for me after several days of seeing Fehler bei Kommunikation mit Google API(10) (Error when communicating with Google API(10)) when starting the app, as described in #771. Today, only the Google API(20) error appeared. The Google API(10) error so far seemed to "resolve itself" on my device, not reaching Google API(39508) error (too many calls to API); days active was incremented in those cases after the error was not displayed anymore. Google API(20) in contrast reappeared until no more calls to the API were possible. Days active was not incremented today.

Google API issue bug community

Source

aurisnoctis

All 12 comments

Could you click the error away and try to reenable the API by manually switching it on / off. We want to make sure that the API is able to connect properly to CWA

jakobmoellersap on 30 Jun 2020

@jakobmoellersap

We want to make sure that the API is able to connect properly to CWA

Thank you, much appreciated. I will write in English but my OS is in German so translations might not match English version exactly.

(A) CWA App, starting the app for the first time today

App shows start screen (all white with app logo in the middle) for about 20 seconds - extremely long waiting time I never had before
then the app switches to the main screen, is showing the grey plate with undetermined risk
then a timeout error appears, java.net.SocketTimeoutException: timeout [1]
clicking Okay reverts view to main app screen, with green low risk plate and that latest update was today 11:34, which is indeed when I opened the app, but still showing 13 out of 14 days active, so no increment since the day before yesterday :arrow_right: last successful increment was the day before the day that the Google API(20) error appeared (yesterday)

(B) Switching API on and off

try to reenable the API by manually switching it on / off.

Here, I wasn't sure if you meant deactivating and activating the tracing in CWA or if you meant the Android Google setting for the Google Exposure Notification framework so I tried both, eventually ending up in the same CWA settings, see below:

(B1) Switching CWA tracing off and back on

switching off by slider in submenu for tracing status
switching slider on again
- pop-up activate COVID-19 EN? :arrow_right: I click Activate :arrow_right: risk assessment is active, slider stays on
going back to main screen: still only 13/14 days active
putting app in background
bringing app back to foreground :arrow_right: no change: update time is still 11:34, still 13 of 14 days active

(B2) Google Exposure Notification framework

Android settings menu > Google > COVID-19 menu item :arrow_right: looks like in its usual active state [2]
clicking deactivate notifications about possible ... (Benachrichtigungen zu möglicher Begegnung mit Infizierten deaktivieren)
- :arrow_right: this field is now greyed out, at the top is a message that I should open the corresponding app to activate
- clicking Öffnen to the right of Corona-Warn
back in CWA the main plate shows risk assessment stopped: Activate risk assessment to calculate your risk status for today (instead of the usual grey or green plates)
click on switch on risk assessment :arrow_right: app switches to the setting for activating risk assessment
switching slider on for risk assessment :arrow_right: pop-up activate COVID-19 EN? :arrow_right: I click Activate :arrow_right: risk assessment is active, slider stays on (as already done above in (B1), doing everything inside CWA)
closing risk assessment settings view :arrow_right: no change: update time is still 11:34, still 13 of 14 days active

Details

[1] timeout error

Really sorry for the quality - my partner and his smartphone are not here and I don't have a camera except for my own smartphone so I only have a webcam here to take pictures of my phone screen. Had to install an app for taking pics with the webcam. Webcam always focuses on the background and I had to crop all the pics by hand - took all in all 20 Minutes just to get the pics here without Android screenshots :fearful:

[2] What my Google COVID-19 EN framework settings look like in 'normal state'

| |
|:-------------------------:|
| Google COVID-19 EN in 'normal state', ignore notes included for other github issue

Much better quality when I had my partner's phone to take pics of my phone screen.

aurisnoctis on 1 Jul 2020

Okay, so as far as I understand you have multiple error cases at once that match to different errors.

Regarding your original Issue 20: This seemed to be sporadically and does not seem to reappear, correct?
Regarding your issue 10: This is confirmed and is being resolved in #737
Regarding the timeout: Did you maybe lose internet connection in the meantime? This only happens when we have issues connecting to the internet in a stable way.
Regarding the issue of 13/14 days active: We have confirmed this issue and are working on it in #796

jakobmoellersap on 1 Jul 2020

@jakobmoellersap The sequence of errors was

CWA installed, everything fine, CWA updated to 1.0.4, still runs fine for 1 or 2 days
on 25 June 2020 Google API(10) error appears for the first time https://github.com/corona-warn-app/cwa-app-android/issues/737#issuecomment-649702108, date of last update of risk assessment (Aktualisiert) and days active in main windows increments
on 26 June 2020 Google API(10) error appears again https://github.com/corona-warn-app/cwa-app-android/issues/737#issuecomment-650144069, date of last update of risk assessment and days active in main windows increments as before
cannot recollect if Goole API(10) error appeared after that -- but days active increased steadily every day
on 30 June 2020 Google API(20) appears :arrow_right: for the first time days active is not incremented and stays at 13 of 14 days active
on 31 July 2020 no Google API errors, but long waiting time just showing the app symbol on white background when starting CWA, then timeout error and still only 13 of 14 days active

I was at home with a stable internet connection. I could surf the internet with the same phone before and after. I think it is unlikely that it was a short gap in internet connection for just that half minute.

The days not incrementing started the day when the Google API(20) error happened to me. Yes, it might be that it coincided with #796 by chance and that it's two separate issues.

I'd like to keep this open until I didn't have any errors starting the app for a couple of days and to see if others start seeing the Google API (20) error these days.

aurisnoctis on 1 Jul 2020

Google API(20) error appeared again today. Brief summary:

bring app to foreground first time today: Google API(20 error)
then Google API(10) error is displayed #737
the two error pop-ups alternate until Google API(39508) timeout error appears

Today is the first day in CWA version 1.0.4 that the last update (Aktualisiert:) was not incremented.

This time I had a second phone to take pics:

As mentioned in the brief summary, the errors started with the Google API(20)error as a pop-up. After the smartphone screen was off and I switched it on again, it was already overlaid with the Google API(10) error pop-up. This is when the pictures below start.

after clicking Okay to dismiss the errors, the main CWA screen is visible for some time, showing 13 of 14 days active (see also #796) and last update Yesterday, 11:34
then the Google API(10) error pops up again
still 13 of 14 days active and last update Yesterday, 11:34
putting app in background
opening app again: Google API(39508) error appears
still 13 of 14 days active and last update Yesterday, 11:34

aurisnoctis on 2 Jul 2020

Additional info for https://github.com/corona-warn-app/cwa-app-android/issues/788#issuecomment-652871916 from Android debug log file - maybe that helps to sort out problems with Google GMS:

Click here to expand

07-02 08:33:05.113  1673  1673 I Timeline: Timeline: Activity_launch_request id:de.rki.coronawarnapp time:88153752

[...]

07-02 08:33:05.573  3738  3847 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/files/reporting-log

[...]

07-02 08:33:05.853  3865  3865 D TimaKeyStoreProvider: TimaSignature is unavailable
07-02 08:33:05.853  3865  3865 D ActivityThread: Added TimaKeyStore provider
07-02 08:33:06.083  3865  3865 W DynamiteModule: Local module descriptor class for providerinstaller not found.
07-02 08:33:06.093  3865  3865 W ProviderHelper: Unknown dynamite feature providerinstaller
07-02 08:33:06.093  3865  3865 I DynamiteModule: Considering local module providerinstaller:0 and remote module providerinstaller:0
07-02 08:33:06.093  3865  3865 W ProviderInstaller: Failed to load providerinstaller module: No acceptable module found. Local version is 0 and remote version is 0.
07-02 08:33:06.113  3865  3865 V NativeCrypto: Registering com/google/android/gms/org/conscrypt/NativeCrypto's 286 native methods...
07-02 08:33:06.123  3865  3865 W         : Unable to open '/system/framework/com.qti.location.sdk.jar': No such file or directory
07-02 08:33:06.123  3865  3865 W art     : Failed to open zip archive '/system/framework/com.qti.location.sdk.jar': I/O Error
07-02 08:33:06.173  3865  3865 I art     : Rejecting re-init on previously-failed class java.lang.Class<com.google.android.gms.org.conscrypt.Java7ExtendedSSLSession>
07-02 08:33:06.173  3865  3865 I art     : Rejecting re-init on previously-failed class java.lang.Class<com.google.android.gms.org.conscrypt.Java7ExtendedSSLSession>
07-02 08:33:06.173  3865  3865 I art     : Rejecting re-init on previously-failed class java.lang.Class<com.google.android.gms.org.conscrypt.Java8ExtendedSSLSession>
07-02 08:33:06.173  3865  3865 I art     : Rejecting re-init on previously-failed class java.lang.Class<com.google.android.gms.org.conscrypt.Java8ExtendedSSLSession>
07-02 08:33:06.203  3865  3865 I ProviderInstaller: Installed default security provider GmsCore_OpenSSL
07-02 08:33:06.203  3865  3865 I Safeboot: Checking safeboot...
07-02 08:33:06.233  3865  3865 I Safeboot Condition: No need to enter Safeboot.
07-02 08:33:06.233  3865  3865 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/files/CFN.now
07-02 08:33:06.293  3865  3865 I beit    : Primes not initialized, returning default (no-op) Primes instance which will ignore all calls. Please call Primes.initialize(...) before using any Primes API.
07-02 08:33:06.353  3865  3865 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/databases/playlog.db
07-02 08:33:06.353  3865  3865 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/databases/playlog.db-journal
07-02 08:33:06.353  3865  3865 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/databases/playlog.db-shm
07-02 08:33:06.353  3865  3865 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/databases/playlog.db-wal
07-02 08:33:06.433  3891  3891 E TZ_CCM_SERVER: Only 'CCM' are supported
07-02 08:33:06.433  3891  3891 I TZ_CCM_SERVER: ###Exit TZ CCM Server
07-02 08:33:06.453  3865  3875 I DynamiteModule: Considering local module com.google.android.gms.googlecertificates:4 and remote module com.google.android.gms.googlecertificates:4
07-02 08:33:06.453  3865  3875 I DynamiteModule: Selected local version of com.google.android.gms.googlecertificates
07-02 08:33:06.473   813   902 D LocationProviderProxy: applying state to connected service
07-02 08:33:06.613  3865  3890 I art     : Rejecting re-init on previously-failed class java.lang.Class<skk>
07-02 08:33:06.613  3865  3890 I art     : Rejecting re-init on previously-failed class java.lang.Class<skk>
07-02 08:33:06.613  3865  3890 I art     : Rejecting re-init on previously-failed class java.lang.Class<skk>
07-02 08:33:06.613  3865  3890 I art     : Rejecting re-init on previously-failed class java.lang.Class<skk>
07-02 08:33:06.663  3865  3890 I NetworkScheduler: Using standalone scheduling engine [CONTEXT service_id=218 ]
07-02 08:33:06.673   813   902 D LocationProviderProxy: applying state to connected service
07-02 08:33:06.803  3865  3865 D ConnectivityManager: requestNetwork; getAppId(CallingUid) : 10014, CallingPid : 3865

[...]

07-02 08:33:06.863  3865  3865 W System  : ClassLoader referenced unknown path: /data/data/com.google.android.gms/app_chimera/m/00000102/n/armeabi
07-02 08:33:06.923  3865  3908 W ProviderHelper: Unknown dynamite feature providerinstaller
07-02 08:33:06.923  3865  3908 I DynamiteModule: Considering local module providerinstaller:0 and remote module providerinstaller:0
07-02 08:33:06.923  3865  3908 I DynamiteModule: Considering local module providerinstaller:0 and remote module providerinstaller:0
07-02 08:33:06.923  3865  3908 I qtaguid : Tagging socket -1 with tag 2000040700000000{536871943,0} uid -1, pid: 3865, getuid(): 10014
07-02 08:33:06.923  3865  3908 I qtaguid : Failed write_ctrl(t -1 2305847437324976128 -1) res=-1 errno=9
07-02 08:33:06.923  3865  3908 I qtaguid : Tagging socket -1 with tag 2000040700000000(536871943) for uid -1 failed errno=-9
07-02 08:33:06.923  3865  3908 I NetworkManagementSocketTagger: tagSocketFd(-1, 536871943, -1) failed with errno-9
07-02 08:33:06.923  3865  3908 I qtaguid : Tagging socket 136 with tag 2000040700000000{536871943,0} uid -1, pid: 3865, getuid(): 10014
07-02 08:33:06.953   315   315 D libEGL  : eglInitialize EGLDisplay = 0xbea1a364
07-02 08:33:06.973  3865  3865 I ExposureNotification: ExposureNotificationInternalService.onCreate, com.google.android.gms.nearby.exposurenotification.service.ExposureNotificationInternalChimeraService@c8e7c
07-02 08:33:07.023  3865  3865 I ExposureNotification: ExposureServiceInternalService.onStartCommand, null [CONTEXT service_id=236 ]
07-02 08:33:07.123  3865  3865 D BluetoothAdapter: STATE_BLE_ON
07-02 08:33:07.123  3865  3865 I ExposureNotification: Utils#isSupported enabled=true, isDeviceSupported=true, isBluetoothSupported=true, BluetoothAdapter.isMultipleAdvertisementSupported=false [CONTEXT servi
07-02 08:33:07.123  3865  3865 I ExposureNotification: ExposureNotificationInternalService.onStartCommand received intent, action=null [CONTEXT service_id=236 ]
07-02 08:33:07.143  3865  3865 I ExposureNotification: Active client found, start tracing. [CONTEXT service_id=236 ]
07-02 08:33:07.143  3865  3865 I ExposureNotification: ExposureServiceInternalService.startTracing [CONTEXT service_id=236 ]
07-02 08:33:07.163  3865  3865 I ExposureNotification: AlarmManagerImpl.opportunisticSchedule called, delay=1800000ms [CONTEXT service_id=236 ]
07-02 08:33:07.183  3865  3865 I ExposureNotification: AlarmManagerImpl.opportunisticSchedule called, delay=1800000ms [CONTEXT service_id=236 ]

[... some errors repeat, e.g., 07-02 08:33:07.773  3865  3919 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/files/nlp_state]

07-02 08:33:08.563  3971  3971 E Zygote  : v2
07-02 08:33:08.573  3971  3971 I SELinux : Function: selinux_compare_spd_ram, index[1], SPD-policy is existed. and_ver=SEPF_SECMOBILE_6.0.1 ver=11
07-02 08:33:08.573  3971  3971 W SELinux : Function: selinux_compare_spd_ram, index[1], priority [2], priority version is VE=SEPF_SECMOBILE_6.0.1_0035
07-02 08:33:08.573  3971  3971 E Zygote  : accessInfo : 0
07-02 08:33:08.573  3971  3971 W SELinux : SELinux: seapp_context_lookup: seinfo=gmscore, level=s0:c512,c768, pkgname=com.google.android.gms.persistent
07-02 08:33:08.593  3971  3971 D TimaKeyStoreProvider: TimaSignature is unavailable
07-02 08:33:08.593  3971  3971 D ActivityThread: Added TimaKeyStore provider
07-02 08:33:08.613   813  1073 E Sensors : SigMotionSensor old sensor_state 8705, new sensor_state : 513 en : 0
07-02 08:33:08.853  3971  3971 W DynamiteModule: Local module descriptor class for providerinstaller not found.
07-02 08:33:08.863  3971  3971 W ProviderHelper: Unknown dynamite feature providerinstaller
07-02 08:33:08.873  3971  3971 I DynamiteModule: Considering local module providerinstaller:0 and remote module providerinstaller:0
07-02 08:33:08.873  3971  3971 W ProviderInstaller: Failed to load providerinstaller module: No acceptable module found. Local version is 0 and remote version is 0.
07-02 08:33:08.883  3971  3971 V NativeCrypto: Registering com/google/android/gms/org/conscrypt/NativeCrypto's 286 native methods...
07-02 08:33:08.893  3971  3971 W         : Unable to open '/system/framework/com.qti.location.sdk.jar': No such file or directory
07-02 08:33:08.893  3971  3971 W art     : Failed to open zip archive '/system/framework/com.qti.location.sdk.jar': I/O Error
07-02 08:33:08.943  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<com.google.android.gms.org.conscrypt.Java7ExtendedSSLSession>
07-02 08:33:08.943  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<com.google.android.gms.org.conscrypt.Java7ExtendedSSLSession>
07-02 08:33:08.943  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<com.google.android.gms.org.conscrypt.Java8ExtendedSSLSession>
07-02 08:33:08.943  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<com.google.android.gms.org.conscrypt.Java8ExtendedSSLSession>
07-02 08:33:08.963  3971  3971 I ProviderInstaller: Installed default security provider GmsCore_OpenSSL
07-02 08:33:08.963  3971  3971 I Safeboot: Checking safeboot...
07-02 08:33:08.993  3971  3971 I Safeboot Condition: No need to enter Safeboot.
07-02 08:33:09.003  3971  3971 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/files/CFN.now
07-02 08:33:09.063  3971  3971 I beit    : Primes not initialized, returning default (no-op) Primes instance which will ignore all calls. Please call Primes.initialize(...) before using any Primes API.
07-02 08:33:09.133  3971  3971 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/databases/playlog.db
07-02 08:33:09.133  3971  3971 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/databases/playlog.db-journal
07-02 08:33:09.133  3971  3971 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/databases/playlog.db-shm
07-02 08:33:09.133  3971  3971 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/databases/playlog.db-wal
07-02 08:33:09.243  3971  3981 I DynamiteModule: Considering local module com.google.android.gms.googlecertificates:4 and remote module com.google.android.gms.googlecertificates:4
07-02 08:33:09.243  3971  3981 I DynamiteModule: Selected local version of com.google.android.gms.googlecertificates
07-02 08:33:09.263   813   902 D LocationProviderProxy: applying state to connected service
07-02 08:33:09.423   813   902 D LocationProviderProxy: applying state to connected service
07-02 08:33:09.473  1234  1234 D StatusBar.NetworkController: refreshViews connected={ wifi } level=4 combinedSignalIconId=0x7f020643/com.android.systemui:drawable/stat_sys_wifi_signal_2 mobileLabel=BLAU wifi
07-02 08:33:09.473  1234  1234 D StatusBar.NetworkController: refreshNwBoosterIndicator - setNWBoosterIndicators(false)
07-02 08:33:09.473  1234  1234 D StatusBar.NetworkController: refreshNwBoosterIndicator - setNWBoosterIndicators(false)
07-02 08:33:09.473  1234  1234 D StatusBar.NetworkController: refreshNwBoosterIndicator - setNWBoosterIndicators(false)
07-02 08:33:09.473  1234  1234 D StatusBar.NetworkController: refreshNwBoosterIndicator - setNWBoosterIndicators(false)
07-02 08:33:09.523  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<skk>
07-02 08:33:09.523  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<skk>
07-02 08:33:09.533  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<skk>
07-02 08:33:09.533  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<skk>
07-02 08:33:09.613  3971  3971 D ConnectivityManager: requestNetwork; getAppId(CallingUid) : 10014, CallingPid : 3971
07-02 08:33:09.643   330  1052 D EnterpriseController: netId is 0
07-02 08:33:09.643   330  1052 D Netd    : getNetworkForDns: using netid 514 for uid 10014
07-02 08:33:09.643  3971  4015 W ProviderHelper: Unknown dynamite feature providerinstaller
07-02 08:33:09.643  3971  4015 I DynamiteModule: Considering local module providerinstaller:0 and remote module providerinstaller:0
07-02 08:33:09.653  3971  4015 I DynamiteModule: Considering local module providerinstaller:0 and remote module providerinstaller:0
07-02 08:33:09.653  3971  4015 I qtaguid : Tagging socket -1 with tag 2000040700000000{536871943,0} uid -1, pid: 3971, getuid(): 10014
07-02 08:33:09.653  3971  4015 I qtaguid : Failed write_ctrl(t -1 2305847437324976128 -1) res=-1 errno=9
07-02 08:33:09.653  3971  4015 I qtaguid : Tagging socket -1 with tag 2000040700000000(536871943) for uid -1 failed errno=-9
07-02 08:33:09.653  3971  4015 I NetworkManagementSocketTagger: tagSocketFd(-1, 536871943, -1) failed with errno-9
07-02 08:33:09.653  3971  4015 I qtaguid : Tagging socket 120 with tag 2000040700000000{536871943,0} uid -1, pid: 3971, getuid(): 10014
07-02 08:33:09.673  3971  3971 W System  : ClassLoader referenced unknown path: /data/data/com.google.android.gms/app_chimera/m/00000102/n/armeabi
07-02 08:33:09.773  3971  3971 I ExposureNotification: ExposureNotificationInternalService.onCreate, com.google.android.gms.nearby.exposurenotification.service.ExposureNotificationInternalChimeraService@44921
07-02 08:33:09.823  3971  3971 I ExposureNotification: ExposureServiceInternalService.onStartCommand, null [CONTEXT service_id=236 ]
07-02 08:33:09.853  3971  4015 I NetworkScheduler: Using standalone scheduling engine [CONTEXT service_id=218 ]
07-02 08:33:09.913  3971  3971 D BluetoothAdapter: STATE_BLE_ON
07-02 08:33:09.913  3971  3971 I ExposureNotification: Utils#isSupported enabled=true, isDeviceSupported=true, isBluetoothSupported=true, BluetoothAdapter.isMultipleAdvertisementSupported=false [CONTEXT servi
07-02 08:33:09.913  3971  3971 I ExposureNotification: ExposureNotificationInternalService.onStartCommand received intent, action=null [CONTEXT service_id=236 ]
07-02 08:33:09.933  3971  3971 I ExposureNotification: Active client found, start tracing. [CONTEXT service_id=236 ]
07-02 08:33:09.933  3971  3971 I ExposureNotification: ExposureServiceInternalService.startTracing [CONTEXT service_id=236 ]
07-02 08:33:09.953  3971  3971 I ExposureNotification: AlarmManagerImpl.opportunisticSchedule called, delay=1800000ms [CONTEXT service_id=236 ]
07-02 08:33:09.963  3971  3971 I ExposureNotification: AlarmManagerImpl.opportunisticSchedule called, delay=1800000ms [CONTEXT service_id=236 ]
07-02 08:33:10.003  3971  3971 I ExposureNotification: scheduling daily task dispatcher [CONTEXT service_id=236 ]
07-02 08:33:10.063  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<bvsa>
07-02 08:33:10.063  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<bvsa>
07-02 08:33:10.063  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<bvsa>
07-02 08:33:10.073  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<bvsa>
07-02 08:33:10.073  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<bvsa>
07-02 08:33:10.073  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<bvsa>
07-02 08:33:10.083  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<bvsa>
07-02 08:33:10.083  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<bvsa>
07-02 08:33:10.083  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<bvsa>
07-02 08:33:10.083  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<bvsa>
07-02 08:33:10.083  3971  3971 I art     : Rejecting re-init on previously-failed class java.lang.Class<bvsa>

[...]

07-02 08:33:10.503  3971  4030 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/files/nlp_state
07-02 08:33:10.503  3971  4030 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/cache/nlp_devices
07-02 08:33:10.503  3971  4030 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/files/nlp_ioh
07-02 08:33:10.503  3971  4030 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/cache/nlp_s
07-02 08:33:10.503  3971  4030 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/com.google.android.gms/cache/nlp_GlsPlatformKey
07-02 08:33:10.783  1394  1394 E TranscodeReceiver: onReceive : android.intent.action.CHECK_SIOP_LEVEL
07-02 08:33:10.783  1394  1394 D TranscodeReceiver:  SIOP_LEVEL: 1
07-02 08:33:10.823   813  1669 D LocationManagerService: request c3af7d0 passive Request[POWER_NONE passive fastest=0] from com.google.android.gms(10014)
07-02 08:33:10.823   813  1669 D LocationManagerService: provider request: passive ProviderRequest[ON interval=0]
07-02 08:33:10.863  3971  3971 I Backup  : [GmsBackupAccountManager] Backup account not found in gmscore.
07-02 08:33:10.883  3971  3982 W DynamiteModule: Local module descriptor class for com.google.android.gms.googlecertificates not found.
07-02 08:33:10.893  3971  3982 I DynamiteModule: Considering local module com.google.android.gms.googlecertificates:0 and remote module com.google.android.gms.googlecertificates:4
07-02 08:33:10.893  3971  3982 I DynamiteModule: Selected remote version of com.google.android.gms.googlecertificates, version >= 4
07-02 08:33:10.893  3971  3982 W System  : ClassLoader referenced unknown path: /data/data/com.google.android.gms/app_chimera/m/00000109/n/armeabi-v7a
07-02 08:33:10.893  3971  3982 W System  : ClassLoader referenced unknown path: /data/data/com.google.android.gms/app_chimera/m/00000109/n/armeabi
07-02 08:33:10.963  3971  3971 I ExposureNotification: Settings updated bluetooth enabled: false location enabled false [CONTEXT service_id=236 ]
07-02 08:33:10.983  3971  3971 I ExposureNotification: User turn off scanning. [CONTEXT service_id=236 ]
07-02 08:33:10.983  3971  3971 I ExposureNotification: Not scanning! [CONTEXT service_id=236 ]
07-02 08:33:10.983  3971  3982 D BluetoothAdapter: STATE_BLE_ON
07-02 08:33:10.993  3971  3982 I ExposureNotification: Utils#isSupported enabled=true, isDeviceSupported=true, isBluetoothSupported=true, BluetoothAdapter.isMultipleAdvertisementSupported=false [CONTEXT servi
07-02 08:33:11.003  3971  3971 I ExposureNotification: ThreadSafeLevelDbWrapper: do open LevelDb contact-tracing-self-tracing-key-db [CONTEXT service_id=236 ]
07-02 08:33:11.003  3971  3971 I ExposureNotification: ThreadSafeLevelDbWrapper:contact-tracing-self-tracing-key-db instance btz@cf87b78 created [CONTEXT service_id=236 ]
07-02 08:33:11.033   813  2141 D ApplicationPolicy: isStatusBarNotificationAllowedAsUser: packageName = com.google.android.gms,userId = 0
07-02 08:33:11.033 18663  4081 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/de.rki.coronawarnapp/cache/http_cache/9fe44808aba26677253c42a986222fcd.0
07-02 08:33:11.033 18663  4081 W System.err: remove failed: ENOENT (No such file or directory) : /data/user/0/de.rki.coronawarnapp/cache/http_cache/9fe44808aba26677253c42a986222fcd.1

[...]

aurisnoctis on 2 Jul 2020

Additional info for https://github.com/corona-warn-app/cwa-app-android/issues/788#issuecomment-652871916: Internet connection was working on phone before during and after these errors occurred (WiFi at home).

aurisnoctis on 2 Jul 2020

Thanks for the detailed info. I will update once we investigated more closely and can give more input

jakobmoellersap on 2 Jul 2020

👍1

Update to https://github.com/corona-warn-app/cwa-app-android/issues/788#issuecomment-652871916

Today is the first day in CWA version 1.0.4 that the last update (Aktualisiert:) was not incremented.

Today I 'only' had the Google API(10) error [1], mentioned in the Update of https://github.com/corona-warn-app/cwa-app-android/issues/737#issuecomment-652873704, but no Google API(20) error. Aktualisiert: changed from day before yesterday, 11:34 to Today, 8:48.

So it was presumably indeed the Google API(20) error causing the Aktualisiert: not to be updated.

[1] Have to take that back. While writing this comment another error came up that I have never seen before. Will report elsewhere.

Edit: This time I made sure not only internet is working, but also that bluetooth and location are switched on even though that shouldn't be necessary for the risk update. As with BT and location on, API(20) didn't appear today, I will keep an eye on that.

Edit 2: Today (05 Jul 2020) only the Google API(10) error appeared when opening the app and this time it also caused Aktualisiert: not to be updated. So that behavior is not unique to the Google API(20) error.

aurisnoctis on 3 Jul 2020

I just want add that I am also encountering this error today. I haven't opened the app in 2-3 days and never changed anything after the initial setup 14 days ago.

I closed the app two times and on the third try the error message went away and the app updated again.