eDrive crash loops escalate to Rescueparty rebooting into recovery factory-reset screen
- /e/ version: 0.21-q-20220114
- Device model(s): Moto Harpia
- Device rooted: no
Summary
a few minutes after startup the device sees a small dialog informing the user that it will be restarted. On next bootup, the recovery factory reset is shown. One can skip and successfully boot, but an explanation is missing.
After a few minutes of having again booted, the cycle repeats.
The problem
Steps to reproduce
Not validated yet: the codepath looks like the sync of application settings (and possible files+pictures too). In the device this sync class is disabled and the normal switch buttons are not shown. I think reproduction is upgrading from 0.20->0.21 with having the sync class disabled.
What is the current behavior?
continuous reboots in intervals of a few minutes
What is the expected correct behavior?
no reboots
Technical informations
(see https://source.android.com/devices/tech/debug/rescue-party for an explanation on the system service.)
follow Attempt to invoke virtual method 'boolean java.lang.String.endsWith(java.lang.String)' on a null object reference
for the cause of the exception and the RescueParty
counters until finally deciding to reboot into the recovery factory-reset screen.
Webdav MKCOLs are met with 409 "conflict / parentdir missing". The order of tree walk seems inverted - long to short path. But according to settings that sync type shouldn't run at all.
(To get the logcat, I ran logcat | tee logfile
in com.termux, as Rescueparty will not reboot when still attached to adb)
01-20 20:47:44.892 12161 12161 I EdriveApplication: Starting
01-20 20:47:44.900 12161 12161 I InitializerService: onCreate()
01-20 20:47:44.901 12161 12161 I InitializerService: onStartCommand(...)
01-20 20:47:44.905 12161 12161 I CommonUtils: getOwnCloudClient()
01-20 20:47:44.908 12161 12161 D NetworkUtils: Searching known-servers store at /data/user/0/foundation.e.drive/files/knownServers.bks
01-20 20:47:44.909 12161 12161 D NetworkSecurityConfig: No Network Security Config specified, using platform default
01-20 20:47:44.931 12161 12161 D OwnCloudClient #0: Creating OwnCloudClient
01-20 20:47:44.938 12161 12161 D CommonUtils: user agent: eos(20220114)-eDrive(beta-1-build-o-22-01-05T1559)
01-20 20:47:44.938 12161 12161 I InitializerService: start()
01-20 20:47:44.940 12161 12161 I InitializerService: getInitialSyncedFolders
01-20 20:47:44.941 12161 12161 I InitializerService: createNextRemoteFolder()
01-20 20:47:44.946 12161 12161 I ObserverService: onStartCommand(121)
01-20 20:47:44.946 12161 12161 D ObserverService: ServiceExceptionHandler already set!
01-20 20:47:44.951 12161 12161 W ObserverService: Initialization hasn't been done
01-20 20:47:44.954 12161 12161 I InitializerService: onStartCommand(...)
01-20 20:47:44.954 12161 12161 D ObserverService: ServiceExceptionHandler already set!
01-20 20:47:44.956 12161 12161 I CommonUtils: getOwnCloudClient()
01-20 20:47:44.957 12161 12161 D OwnCloudClient #1: Creating OwnCloudClient
01-20 20:47:44.959 12161 12184 W System.err: SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
01-20 20:47:44.959 12161 12184 W System.err: SLF4J: Defaulting to no-operation (NOP) logger implementation
01-20 20:47:44.960 12161 12184 W System.err: SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
01-20 20:47:44.961 12161 12161 D CommonUtils: user agent: eos(20220114)-eDrive(beta-1-build-o-22-01-05T1559)
01-20 20:47:44.961 12161 12161 I InitializerService: start()
01-20 20:47:44.963 12161 12161 I InitializerService: getInitialSyncedFolders
01-20 20:47:44.965 12161 12161 I InitializerService: createNextRemoteFolder()
01-20 20:47:44.970 12161 12184 D OwnCloudClient #0: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/Motorola_Moto%20G%20Play_unknown/rom_settings/
01-20 20:47:44.970 12161 12185 D OwnCloudClient #1: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/Motorola_Moto%20G%20Play_unknown/rom_settings/
01-20 20:47:44.980 12161 12184 D AdvancedSslSocketFactory: Creating SSL Socket with remote nextcloud.example.com:443, local null:0, params: org.apache.commons.httpclient.params.HttpConnectionParams@61b33e4
01-20 20:47:44.980 12161 12185 D AdvancedSslSocketFactory: Creating SSL Socket with remote nextcloud.example.com:443, local null:0, params: org.apache.commons.httpclient.params.HttpConnectionParams@9bcc04d
01-20 20:47:44.982 12161 12185 D AdvancedSslSocketFactory: ... with connection timeout 5000 and socket timeout 30000
01-20 20:47:44.982 12161 12184 D AdvancedSslSocketFactory: ... with connection timeout 5000 and socket timeout 30000
01-20 20:47:45.009 12161 12185 I ServerNameIndicator: SSLSocket implementation: com.android.org.conscrypt.Java8FileDescriptorSocket
01-20 20:47:45.009 12161 12184 I ServerNameIndicator: SSLSocket implementation: com.android.org.conscrypt.Java8FileDescriptorSocket
01-20 20:47:45.010 12161 12184 I ServerNameIndicator: SNI done, hostname: nextcloud.example.com
01-20 20:47:45.010 12161 12185 I ServerNameIndicator: SNI done, hostname: nextcloud.example.com
01-20 20:47:45.404 12161 12185 D OwnCloudClient #1: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/Motorola_Moto%20G%20Play_unknown/
01-20 20:47:45.404 12161 12184 D OwnCloudClient #0: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/Motorola_Moto%20G%20Play_unknown/
01-20 20:47:45.644 12161 12184 D OwnCloudClient #0: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/
01-20 20:47:45.644 12161 12185 D OwnCloudClient #1: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/
01-20 20:47:45.897 12161 12185 D OwnCloudClient #1: REQUEST MKCOL /remote.php/dav/remote.php/webdav/
01-20 20:47:45.897 12161 12184 D OwnCloudClient #0: REQUEST MKCOL /remote.php/dav/remote.php/webdav/
01-20 20:47:46.134 12161 12184 E AndroidRuntime: FATAL EXCEPTION: Thread-2
01-20 20:47:46.134 12161 12184 E AndroidRuntime: Process: foundation.e.drive, PID: 12161
01-20 20:47:46.134 12161 12184 E AndroidRuntime: java.lang.NullPointerException: Attempt to invoke virtual method 'boolean java.lang.String.endsWith(java.lang.String)' on a null object reference
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.resources.files.FileUtils.getParentPath(FileUtils.java:38)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at foundation.e.drive.operations.CreateInitialFolderRemoteOperation.run(CreateInitialFolderRemoteOperation.java:51)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.run(RemoteOperation.java:316)
01-20 20:47:46.134 12161 12184 E AndroidRuntime: at java.lang.Thread.run(Thread.java:919)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: FATAL EXCEPTION: Thread-3
01-20 20:47:46.134 12161 12185 E AndroidRuntime: Process: foundation.e.drive, PID: 12161
01-20 20:47:46.134 12161 12185 E AndroidRuntime: java.lang.NullPointerException: Attempt to invoke virtual method 'boolean java.lang.String.endsWith(java.lang.String)' on a null object reference
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.resources.files.FileUtils.getParentPath(FileUtils.java:38)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at foundation.e.drive.operations.CreateInitialFolderRemoteOperation.run(CreateInitialFolderRemoteOperation.java:51)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.run(RemoteOperation.java:316)
01-20 20:47:46.134 12161 12185 E AndroidRuntime: at java.lang.Thread.run(Thread.java:919)
01-20 20:47:46.135 12161 12185 D ServiceExceptionHandler: Service class: InitializerService
01-20 20:47:46.135 12161 12184 D ServiceExceptionHandler: Service class: InitializerService
01-20 20:47:46.151 3544 7700 W RescueParty: Noticed 3 events for UID 10114 in last 2 sec
01-20 20:47:46.152 3544 7700 W ActivityManager: Process foundation.e.drive has crashed too many times: killing!
01-20 20:47:46.152 12161 12184 I Process : Sending signal. PID: 12161 SIG: 9
01-20 20:47:46.193 3544 7369 I ActivityManager: Process foundation.e.drive (pid 12161) has died: pers PER
01-20 20:47:46.194 3544 7369 W ActivityManager: Scheduling restart of crashed service foundation.e.drive/.services.InitializerService in 0ms
01-20 20:47:46.195 3544 7369 W ActivityManager: Scheduling restart of crashed service foundation.e.drive/.services.ObserverService in 0ms
01-20 20:47:46.195 3544 7369 W ActivityManager: Re-adding persistent process ProcessRecord{6a62d9a 12161:foundation.e.drive/u0a114}
01-20 20:47:46.203 2834 2834 I Zygote : Process 12161 exited due to signal 9 (Killed)
01-20 20:47:46.212 2834 2834 D Zygote : Forked child process 12189
01-20 20:47:46.222 3544 3816 I ActivityManager: Start proc 12189:foundation.e.drive/u0a114 for restart foundation.e.drive
01-20 20:47:46.235 3544 3817 I libprocessgroup: Successfully killed process cgroup uid 10114 pid 12161 in 42ms
01-20 20:47:46.286 12189 12189 W ApplicationLoaders: Unexpected environment for cached library: (null|[dalvik.system.PathClassLoader[DexPathList[[zip file "/system/framework/android.hidl.base-V1.0-java.jar"],nativeLibraryDirectories=[/system/lib, /system/product/lib, /system/vendor/lib]]]])
01-20 20:47:46.289 12189 12189 I ndation.e.driv: The ClassLoaderContext is a special shared library.
01-20 20:47:46.292 12189 12189 D ApplicationLoaders: Returning zygote-cached class loader: /system/framework/android.hidl.base-V1.0-java.jar
01-20 20:47:46.295 12189 12189 I ndation.e.driv: The ClassLoaderContext is a special shared library.
01-20 20:47:46.300 12189 12189 E ndation.e.driv: Dex checksum does not match for dex: /system/app/eDrive/eDrive.apk.Expected: 1189837633, actual: 2703113976
01-20 20:47:46.302 12189 12189 I ndation.e.driv: The ClassLoaderContext is a special shared library.
01-20 20:47:46.323 12189 12189 I EdriveApplication: Starting
01-20 20:47:46.333 12189 12189 I InitializerService: onCreate()
01-20 20:47:46.333 12189 12189 I InitializerService: onStartCommand(...)
01-20 20:47:46.337 12189 12189 I CommonUtils: getOwnCloudClient()
01-20 20:47:46.342 12189 12189 D NetworkUtils: Searching known-servers store at /data/user/0/foundation.e.drive/files/knownServers.bks
01-20 20:47:46.344 12189 12189 D NetworkSecurityConfig: No Network Security Config specified, using platform default
01-20 20:47:46.368 12189 12189 D OwnCloudClient #0: Creating OwnCloudClient
01-20 20:47:46.375 12189 12189 D CommonUtils: user agent: eos(20220114)-eDrive(beta-1-build-o-22-01-05T1559)
01-20 20:47:46.375 12189 12189 I InitializerService: start()
01-20 20:47:46.376 12189 12189 I InitializerService: getInitialSyncedFolders
01-20 20:47:46.378 12189 12189 I InitializerService: createNextRemoteFolder()
01-20 20:47:46.380 12189 12189 I ObserverService: onStartCommand(122)
01-20 20:47:46.381 12189 12189 D ObserverService: ServiceExceptionHandler already set!
01-20 20:47:46.383 12189 12189 W ObserverService: Initialization hasn't been done
01-20 20:47:46.385 12189 12189 I InitializerService: onStartCommand(...)
01-20 20:47:46.385 12189 12189 D ObserverService: ServiceExceptionHandler already set!
01-20 20:47:46.387 12189 12189 I CommonUtils: getOwnCloudClient()
01-20 20:47:46.388 12189 12189 D OwnCloudClient #1: Creating OwnCloudClient
01-20 20:47:46.391 12189 12189 D CommonUtils: user agent: eos(20220114)-eDrive(beta-1-build-o-22-01-05T1559)
01-20 20:47:46.391 12189 12189 I InitializerService: start()
01-20 20:47:46.392 12189 12189 I InitializerService: getInitialSyncedFolders
01-20 20:47:46.393 12189 12189 I InitializerService: createNextRemoteFolder()
01-20 20:47:46.395 12189 12212 W System.err: SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
01-20 20:47:46.395 12189 12212 W System.err: SLF4J: Defaulting to no-operation (NOP) logger implementation
01-20 20:47:46.396 12189 12212 W System.err: SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
01-20 20:47:46.405 12189 12213 D OwnCloudClient #1: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/Motorola_Moto%20G%20Play_unknown/rom_settings/
01-20 20:47:46.405 12189 12212 D OwnCloudClient #0: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/Motorola_Moto%20G%20Play_unknown/rom_settings/
01-20 20:47:46.415 12189 12213 D AdvancedSslSocketFactory: Creating SSL Socket with remote nextcloud.example.com:443, local null:0, params: org.apache.commons.httpclient.params.HttpConnectionParams@9bcc04d
01-20 20:47:46.415 12189 12212 D AdvancedSslSocketFactory: Creating SSL Socket with remote nextcloud.example.com:443, local null:0, params: org.apache.commons.httpclient.params.HttpConnectionParams@61b33e4
01-20 20:47:46.417 12189 12213 D AdvancedSslSocketFactory: ... with connection timeout 5000 and socket timeout 30000
01-20 20:47:46.417 12189 12212 D AdvancedSslSocketFactory: ... with connection timeout 5000 and socket timeout 30000
01-20 20:47:46.445 12189 12212 I ServerNameIndicator: SSLSocket implementation: com.android.org.conscrypt.Java8FileDescriptorSocket
01-20 20:47:46.446 12189 12212 I ServerNameIndicator: SNI done, hostname: nextcloud.example.com
01-20 20:47:46.449 12189 12213 I ServerNameIndicator: SNI done, hostname: nextcloud.example.com
01-20 20:47:46.864 12189 12212 D OwnCloudClient #0: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/Motorola_Moto%20G%20Play_unknown/
01-20 20:47:46.864 12189 12213 D OwnCloudClient #1: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/Motorola_Moto%20G%20Play_unknown/
01-20 20:47:47.098 12189 12213 D OwnCloudClient #1: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/
01-20 20:47:47.099 12189 12212 D OwnCloudClient #0: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/
01-20 20:47:47.340 12189 12212 D OwnCloudClient #0: REQUEST MKCOL /remote.php/dav/remote.php/webdav/
01-20 20:47:47.340 12189 12213 D OwnCloudClient #1: REQUEST MKCOL /remote.php/dav/remote.php/webdav/
01-20 20:47:47.577 12189 12212 E AndroidRuntime: FATAL EXCEPTION: Thread-2
01-20 20:47:47.577 12189 12212 E AndroidRuntime: Process: foundation.e.drive, PID: 12189
01-20 20:47:47.577 12189 12212 E AndroidRuntime: java.lang.NullPointerException: Attempt to invoke virtual method 'boolean java.lang.String.endsWith(java.lang.String)' on a null object reference
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.resources.files.FileUtils.getParentPath(FileUtils.java:38)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at foundation.e.drive.operations.CreateInitialFolderRemoteOperation.run(CreateInitialFolderRemoteOperation.java:51)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.run(RemoteOperation.java:316)
01-20 20:47:47.577 12189 12212 E AndroidRuntime: at java.lang.Thread.run(Thread.java:919)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: FATAL EXCEPTION: Thread-3
01-20 20:47:47.577 12189 12213 E AndroidRuntime: Process: foundation.e.drive, PID: 12189
01-20 20:47:47.577 12189 12213 E AndroidRuntime: java.lang.NullPointerException: Attempt to invoke virtual method 'boolean java.lang.String.endsWith(java.lang.String)' on a null object reference
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.resources.files.FileUtils.getParentPath(FileUtils.java:38)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at foundation.e.drive.operations.CreateInitialFolderRemoteOperation.run(CreateInitialFolderRemoteOperation.java:51)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.run(RemoteOperation.java:316)
01-20 20:47:47.577 12189 12213 E AndroidRuntime: at java.lang.Thread.run(Thread.java:919)
01-20 20:47:47.577 12189 12213 D ServiceExceptionHandler: Service class: InitializerService
01-20 20:47:47.577 12189 12212 D ServiceExceptionHandler: Service class: InitializerService
01-20 20:47:47.590 3544 7369 W RescueParty: Noticed 4 events for UID 10114 in last 4 sec
01-20 20:47:47.590 3544 7631 W RescueParty: Noticed 4 events for UID 10114 in last 4 sec
01-20 20:47:47.591 3544 7369 W ActivityManager: Process foundation.e.drive has crashed too many times: killing!
01-20 20:47:47.592 3544 7631 W ActivityManager: Process foundation.e.drive has crashed too many times: killing!
01-20 20:47:47.594 12189 12212 I Process : Sending signal. PID: 12189 SIG: 9
01-20 20:47:47.594 12189 12213 I Process : Sending signal. PID: 12189 SIG: 9
01-20 20:47:47.630 3544 7369 I ActivityManager: Process foundation.e.drive (pid 12189) has died: pers PER
01-20 20:47:47.631 3544 7369 W ActivityManager: Scheduling restart of crashed service foundation.e.drive/.services.InitializerService in 0ms
01-20 20:47:47.631 3544 7369 W ActivityManager: Scheduling restart of crashed service foundation.e.drive/.services.ObserverService in 0ms
01-20 20:47:47.631 3544 7369 W ActivityManager: Re-adding persistent process ProcessRecord{6a62d9a 12189:foundation.e.drive/u0a114}
01-20 20:47:47.633 2834 2834 I Zygote : Process 12189 exited due to signal 9 (Killed)
01-20 20:47:47.648 2834 2834 D Zygote : Forked child process 12217
01-20 20:47:47.653 3544 3816 I ActivityManager: Start proc 12217:foundation.e.drive/u0a114 for restart foundation.e.drive
01-20 20:47:47.675 3544 3817 I libprocessgroup: Successfully killed process cgroup uid 10114 pid 12189 in 45ms
01-20 20:47:47.716 12217 12217 W ApplicationLoaders: Unexpected environment for cached library: (null|[dalvik.system.PathClassLoader[DexPathList[[zip file "/system/framework/android.hidl.base-V1.0-java.jar"],nativeLibraryDirectories=[/system/lib, /system/product/lib, /system/vendor/lib]]]])
01-20 20:47:47.719 12217 12217 I ndation.e.driv: The ClassLoaderContext is a special shared library.
01-20 20:47:47.721 12217 12217 D ApplicationLoaders: Returning zygote-cached class loader: /system/framework/android.hidl.base-V1.0-java.jar
01-20 20:47:47.724 12217 12217 I ndation.e.driv: The ClassLoaderContext is a special shared library.
01-20 20:47:47.729 12217 12217 E ndation.e.driv: Dex checksum does not match for dex: /system/app/eDrive/eDrive.apk.Expected: 1189837633, actual: 2703113976
01-20 20:47:47.731 12217 12217 I ndation.e.driv: The ClassLoaderContext is a special shared library.
01-20 20:47:47.751 12217 12217 I EdriveApplication: Starting
01-20 20:47:47.760 12217 12217 I InitializerService: onCreate()
01-20 20:47:47.761 12217 12217 I InitializerService: onStartCommand(...)
01-20 20:47:47.765 12217 12217 I CommonUtils: getOwnCloudClient()
01-20 20:47:47.770 12217 12217 D NetworkUtils: Searching known-servers store at /data/user/0/foundation.e.drive/files/knownServers.bks
01-20 20:47:47.771 12217 12217 D NetworkSecurityConfig: No Network Security Config specified, using platform default
01-20 20:47:47.792 12217 12217 D OwnCloudClient #0: Creating OwnCloudClient
01-20 20:47:47.798 12217 12217 D CommonUtils: user agent: eos(20220114)-eDrive(beta-1-build-o-22-01-05T1559)
01-20 20:47:47.798 12217 12217 I InitializerService: start()
01-20 20:47:47.800 12217 12217 I InitializerService: getInitialSyncedFolders
01-20 20:47:47.802 12217 12217 I InitializerService: createNextRemoteFolder()
01-20 20:47:47.804 12217 12217 I ObserverService: onStartCommand(123)
01-20 20:47:47.805 12217 12217 D ObserverService: ServiceExceptionHandler already set!
01-20 20:47:47.808 12217 12217 W ObserverService: Initialization hasn't been done
01-20 20:47:47.811 12217 12217 I InitializerService: onStartCommand(...)
01-20 20:47:47.811 12217 12217 D ObserverService: ServiceExceptionHandler already set!
01-20 20:47:47.813 12217 12217 I CommonUtils: getOwnCloudClient()
01-20 20:47:47.814 12217 12217 D OwnCloudClient #1: Creating OwnCloudClient
01-20 20:47:47.817 12217 12217 D CommonUtils: user agent: eos(20220114)-eDrive(beta-1-build-o-22-01-05T1559)
01-20 20:47:47.817 12217 12217 I InitializerService: start()
01-20 20:47:47.818 12217 12240 W System.err: SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
01-20 20:47:47.819 12217 12240 W System.err: SLF4J: Defaulting to no-operation (NOP) logger implementation
01-20 20:47:47.819 12217 12240 W System.err: SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
01-20 20:47:47.820 12217 12217 I InitializerService: getInitialSyncedFolders
01-20 20:47:47.820 12217 12217 I InitializerService: createNextRemoteFolder()
01-20 20:47:47.830 12217 12240 D OwnCloudClient #0: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/Motorola_Moto%20G%20Play_unknown/rom_settings/
01-20 20:47:47.830 12217 12241 D OwnCloudClient #1: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/Motorola_Moto%20G%20Play_unknown/rom_settings/
01-20 20:47:47.841 12217 12240 D AdvancedSslSocketFactory: Creating SSL Socket with remote nextcloud.example.com:443, local null:0, params: org.apache.commons.httpclient.params.HttpConnectionParams@9bcc04d
01-20 20:47:47.841 12217 12241 D AdvancedSslSocketFactory: Creating SSL Socket with remote nextcloud.example.com:443, local null:0, params: org.apache.commons.httpclient.params.HttpConnectionParams@61b33e4
01-20 20:47:47.843 12217 12241 D AdvancedSslSocketFactory: ... with connection timeout 5000 and socket timeout 30000
01-20 20:47:47.844 12217 12240 D AdvancedSslSocketFactory: ... with connection timeout 5000 and socket timeout 30000
01-20 20:47:47.869 12217 12240 I ServerNameIndicator: SSLSocket implementation: com.android.org.conscrypt.Java8FileDescriptorSocket
01-20 20:47:47.870 12217 12240 I ServerNameIndicator: SNI done, hostname: nextcloud.example.com
01-20 20:47:47.873 12217 12241 I ServerNameIndicator: SNI done, hostname: nextcloud.example.com
01-20 20:47:48.263 12217 12241 D OwnCloudClient #1: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/Motorola_Moto%20G%20Play_unknown/
01-20 20:47:48.263 12217 12240 D OwnCloudClient #0: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/Motorola_Moto%20G%20Play_unknown/
01-20 20:47:48.617 12217 12241 D OwnCloudClient #1: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/
01-20 20:47:48.617 12217 12240 D OwnCloudClient #0: REQUEST MKCOL /remote.php/dav/remote.php/webdav/Devices/
01-20 20:47:48.854 12217 12240 D OwnCloudClient #0: REQUEST MKCOL /remote.php/dav/remote.php/webdav/
01-20 20:47:48.854 12217 12241 D OwnCloudClient #1: REQUEST MKCOL /remote.php/dav/remote.php/webdav/
01-20 20:47:49.177 12217 12241 E AndroidRuntime: FATAL EXCEPTION: Thread-3
01-20 20:47:49.177 12217 12241 E AndroidRuntime: Process: foundation.e.drive, PID: 12217
01-20 20:47:49.177 12217 12241 E AndroidRuntime: java.lang.NullPointerException: Attempt to invoke virtual method 'boolean java.lang.String.endsWith(java.lang.String)' on a null object reference
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.resources.files.FileUtils.getParentPath(FileUtils.java:38)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at foundation.e.drive.operations.CreateInitialFolderRemoteOperation.run(CreateInitialFolderRemoteOperation.java:51)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.run(RemoteOperation.java:316)
01-20 20:47:49.177 12217 12241 E AndroidRuntime: at java.lang.Thread.run(Thread.java:919)
01-20 20:47:49.177 12217 12241 D ServiceExceptionHandler: Service class: InitializerService
01-20 20:47:49.179 12217 12240 E AndroidRuntime: FATAL EXCEPTION: Thread-2
01-20 20:47:49.179 12217 12240 E AndroidRuntime: Process: foundation.e.drive, PID: 12217
01-20 20:47:49.179 12217 12240 E AndroidRuntime: java.lang.NullPointerException: Attempt to invoke virtual method 'boolean java.lang.String.endsWith(java.lang.String)' on a null object reference
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.resources.files.FileUtils.getParentPath(FileUtils.java:38)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:149)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.createParentFolder(CreateFolderRemoteOperation.java:117)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.resources.files.CreateFolderRemoteOperation.run(CreateFolderRemoteOperation.java:80)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.execute(RemoteOperation.java:145)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at foundation.e.drive.operations.CreateInitialFolderRemoteOperation.run(CreateInitialFolderRemoteOperation.java:51)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at com.owncloud.android.lib.common.operations.RemoteOperation.run(RemoteOperation.java:316)
01-20 20:47:49.179 12217 12240 E AndroidRuntime: at java.lang.Thread.run(Thread.java:919)
01-20 20:47:49.179 12217 12240 D ServiceExceptionHandler: Service class: InitializerService
01-20 20:47:49.191 12217 12241 I Process : Sending signal. PID: 12217 SIG: 9
01-20 20:47:49.193 3544 8034 W RescueParty: Noticed 5 events for UID 10114 in last 5 sec
01-20 20:47:49.194 3544 8034 W PackageManager: Incremented rescue level to FACTORY_RESET triggered by UID 10114
01-20 20:47:49.196 3544 8034 W RescueParty: Attempting rescue level FACTORY_RESET
Summary of Rescueparty counters (everything else ignored) escalating levels from RESET_SETTINGS_UNTRUSTED_DEFAULTS -> RESET_SETTINGS_TRUSTED_DEFAULTS -> FACTORY_RESET
01-20 20:47:17.090 3544 7700 V RescueParty: Disabled because of active USB connection
01-20 20:47:18.508 3544 7700 V RescueParty: Disabled because of active USB connection
01-20 20:47:21.488 3544 7700 W RescueParty: Noticed 2 events for UID 10114 in last 1 sec
01-20 20:47:22.932 3544 7700 W RescueParty: Noticed 3 events for UID 10114 in last 2 sec
01-20 20:47:22.932 3544 7215 W RescueParty: Noticed 4 events for UID 10114 in last 2 sec
01-20 20:47:26.993 3544 7369 W RescueParty: Noticed 5 events for UID 10114 in last 6 sec
01-20 20:47:26.993 3544 7700 W RescueParty: Noticed 5 events for UID 10114 in last 6 sec
01-20 20:47:26.995 3544 7700 W RescueParty: Attempting rescue level RESET_SETTINGS_UNTRUSTED_DEFAULTS
01-20 20:47:26.995 3544 7369 W RescueParty: Attempting rescue level RESET_SETTINGS_UNTRUSTED_DEFAULTS
01-20 20:47:29.806 3544 3623 W RescueParty: Noticed 2 events for UID 10114 in last 1 sec
01-20 20:47:31.211 3544 7369 W RescueParty: Noticed 3 events for UID 10114 in last 2 sec
01-20 20:47:32.690 3544 7369 W RescueParty: Noticed 4 events for UID 10114 in last 4 sec
01-20 20:47:34.554 3544 7215 W RescueParty: Noticed 5 events for UID 10114 in last 6 sec
01-20 20:47:34.557 3544 7215 W RescueParty: Attempting rescue level RESET_SETTINGS_UNTRUSTED_CHANGES
01-20 20:47:38.902 3544 7631 W RescueParty: Noticed 2 events for UID 10114 in last 2 sec
01-20 20:47:40.306 3544 7700 W RescueParty: Noticed 3 events for UID 10114 in last 4 sec
01-20 20:47:41.791 3544 7700 W RescueParty: Noticed 4 events for UID 10114 in last 5 sec
01-20 20:47:41.791 3544 7215 W RescueParty: Noticed 4 events for UID 10114 in last 5 sec
01-20 20:47:43.285 3544 7215 W RescueParty: Noticed 5 events for UID 10114 in last 7 sec
01-20 20:47:43.291 3544 7215 W RescueParty: Attempting rescue level RESET_SETTINGS_TRUSTED_DEFAULTS
01-20 20:47:44.731 3544 7700 W RescueParty: Noticed 2 events for UID 10114 in last 1 sec
01-20 20:47:44.731 3544 7631 W RescueParty: Noticed 2 events for UID 10114 in last 1 sec
01-20 20:47:46.151 3544 7700 W RescueParty: Noticed 3 events for UID 10114 in last 2 sec
01-20 20:47:47.590 3544 7369 W RescueParty: Noticed 4 events for UID 10114 in last 4 sec
01-20 20:47:47.590 3544 7631 W RescueParty: Noticed 4 events for UID 10114 in last 4 sec
01-20 20:47:49.193 3544 8034 W RescueParty: Noticed 5 events for UID 10114 in last 5 sec
01-20 20:47:49.196 3544 8034 W RescueParty: Attempting rescue level FACTORY_RESET
01-20 20:47:50.207 12245 12245 I /system/bin/uncrypt: --reason=RescueParty
Relevant screenshots
broken
proper
Solutions
Workaround to pause edrive
pm disable foundation.e.drive
am kill foundation.e.drive
(or force-stop ? forgot)
Possible fixes
- not setting the app as persistent system app, as yet unknown bugs can cause crash loops passing the rescueparty factory-reset threshold. It is a risk. (https://gitlab.e.foundation/e/apps/eDrive/-/merge_requests/61#note_151923)
- see place of exception operations/CreateInitialFolderRemoteOperation.java:51, what is in "client"?
- ignoring if the appsettings upload should run: does the appsettings mkcol have the proper order?
- the settings screenshot looks corrupted, maybe the sqlite db for the sync account is corrupted after upgrade. As the crash disappeared after some pm disable / am kill and start actions, the sync settings again have switchable handles