[android] Crash in RegisterDownloadedFiles #6413

New issue

Open

opened 2023-10-29 17:43:53 +00:00 by rtsisyk · 3 comments

rtsisyk commented

2023-10-29 17:43:53 +00:00

Owner

Monkey on api=27
video
logcat
firebase

     *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** ***
Build fingerprint: 'google/sdk_gphone_arm64/generic_arm64:8.1.0/OSM1.180201.044.D3/10734665:userdebug/dev-keys'
Revision: '0'
ABI: 'arm64'
pid: 7312, tid: 7312, name: ganicmaps.debug  >>> app.organicmaps.debug <<<
signal 6 (SIGABRT), code -6 (SI_TKILL), fault addr --------
Abort message: '/home/runner/work/organicmaps/organicmaps/android/app/src/main/cpp/app/organicmaps/core/logging.cpp:45: void jni::AndroidLogMessage(LogLevel, const SrcPoint &, const std::string &): assertion "false" failed'
    x0   0000000000000000  x1   0000000000001c90  x2   0000000000000006  x3   0000000000000008
    x4   0000000000000000  x5   0000000000000000  x6   0000000000000000  x7   0000000000000038
    x8   0000000000000083  x9   7ea885ce216eae96  x10  0000000000000001  x11  0000000000000001
    x12  ffffffffffffffff  x13  00000000653e9766  x14  00070889c793f980  x15  0000c106b6ac35fc
    x16  0000007e415a8fa8  x17  0000007e3ef7eed8  x18  0000000000000008  x19  0000000000001c90
    x20  0000000000001c90  x21  0000007d93dfca80  x22  0000000013200000  x23  0000000013a17310
    x24  0000000000000001  x25  0000000013a17310  x26  0000000000000000  x27  0000000000000001
    x28  0000007fc117e600  x29  0000007fc117de60  x30  0000007e3ef349ec
    sp   0000007fc117de20  pc   0000007e3ef34a08  pstate 0000000060000000
backtrace:
    #00 pc 000000000001da08  /system/lib64/libc.so (abort+104)
    #01 pc 000000000001ddb4  /system/lib64/libc.so (__assert2+52)
    #02 pc 000000000208de28  /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so (jni::AndroidLogMessage(base::LogLevel, base::SrcPoint const&, std::__ndk1::basic_string<char, std::__ndk1::char_traits<char>, std::__ndk1::allocator<char>> const&)+336)
    #03 pc 00000000033fa6b0  /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so (storage::Storage::RegisterDownloadedFiles(std::__ndk1::basic_string<char, std::__ndk1::char_traits<char>, std::__ndk1::allocator<char>> const&, MapFileType)+1220)
    #04 pc 00000000033f6db0  /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so (storage::Storage::OnMapDownloadFinished(std::__ndk1::basic_string<char, std::__ndk1::char_traits<char>, std::__ndk1::allocator<char>> const&, downloader::DownloadStatus, MapFileType)+824)
    #05 pc 00000000033fa1ac  /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so
    #06 pc 00000000034647e0  /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so
    #07 pc 00000000034646e4  /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so
    #08 pc 000000000346469c  /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so
    #09 pc 0000000003464678  /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so
    #10 pc 0000000003463728  /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so
    #11 pc 0000000002151e70  /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so
    #12 pc 00000000020c445c  /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so (std::__ndk1::function<void ()>::operator()() const+20)
    #13 pc 00000000020b8cb4  /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so (android::GuiThread::ProcessTask(long)+64)
    #14 pc 00000000020b8c64  /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so (Java_app_organicmaps_MwmApplication_nativeProcessTask+28)
    #15 pc 000000000054fff0  /system/lib64/libart.so (art_quick_generic_jni_trampoline+144)
    #16 pc 000000000017c184  /dev/ashmem/dalvik-jit-code-cache (deleted)

- Monkey on api=27 - [video](https://storage.googleapis.com/test-lab-tfv1dx2ft95t8-yibm740y7szh2/2023-10-29_17%3A29%3A28.417207_sZKy/MediumPhone.arm-27-en-portrait/video.mp4) - [logcat](https://storage.googleapis.com/test-lab-tfv1dx2ft95t8-yibm740y7szh2/2023-10-29_17%3A29%3A28.417207_sZKy/MediumPhone.arm-27-en-portrait/logcat) - [firebase](https://console.firebase.google.com/u/0/project/omapsapp/testlab/histories/bh.7a38003b1edbc7b5/matrices/6468472138749398611/executions/bs.7b495d56d4072f84) ``` *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** Build fingerprint: 'google/sdk_gphone_arm64/generic_arm64:8.1.0/OSM1.180201.044.D3/10734665:userdebug/dev-keys' Revision: '0' ABI: 'arm64' pid: 7312, tid: 7312, name: ganicmaps.debug >>> app.organicmaps.debug <<< signal 6 (SIGABRT), code -6 (SI_TKILL), fault addr -------- Abort message: '/home/runner/work/organicmaps/organicmaps/android/app/src/main/cpp/app/organicmaps/core/logging.cpp:45: void jni::AndroidLogMessage(LogLevel, const SrcPoint &, const std::string &): assertion "false" failed' x0 0000000000000000 x1 0000000000001c90 x2 0000000000000006 x3 0000000000000008 x4 0000000000000000 x5 0000000000000000 x6 0000000000000000 x7 0000000000000038 x8 0000000000000083 x9 7ea885ce216eae96 x10 0000000000000001 x11 0000000000000001 x12 ffffffffffffffff x13 00000000653e9766 x14 00070889c793f980 x15 0000c106b6ac35fc x16 0000007e415a8fa8 x17 0000007e3ef7eed8 x18 0000000000000008 x19 0000000000001c90 x20 0000000000001c90 x21 0000007d93dfca80 x22 0000000013200000 x23 0000000013a17310 x24 0000000000000001 x25 0000000013a17310 x26 0000000000000000 x27 0000000000000001 x28 0000007fc117e600 x29 0000007fc117de60 x30 0000007e3ef349ec sp 0000007fc117de20 pc 0000007e3ef34a08 pstate 0000000060000000 backtrace: #00 pc 000000000001da08 /system/lib64/libc.so (abort+104) #01 pc 000000000001ddb4 /system/lib64/libc.so (__assert2+52) #02 pc 000000000208de28 /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so (jni::AndroidLogMessage(base::LogLevel, base::SrcPoint const&, std::__ndk1::basic_string<char, std::__ndk1::char_traits<char>, std::__ndk1::allocator<char>> const&)+336) #03 pc 00000000033fa6b0 /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so (storage::Storage::RegisterDownloadedFiles(std::__ndk1::basic_string<char, std::__ndk1::char_traits<char>, std::__ndk1::allocator<char>> const&, MapFileType)+1220) #04 pc 00000000033f6db0 /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so (storage::Storage::OnMapDownloadFinished(std::__ndk1::basic_string<char, std::__ndk1::char_traits<char>, std::__ndk1::allocator<char>> const&, downloader::DownloadStatus, MapFileType)+824) #05 pc 00000000033fa1ac /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so #06 pc 00000000034647e0 /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so #07 pc 00000000034646e4 /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so #08 pc 000000000346469c /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so #09 pc 0000000003464678 /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so #10 pc 0000000003463728 /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so #11 pc 0000000002151e70 /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so #12 pc 00000000020c445c /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so (std::__ndk1::function<void ()>::operator()() const+20) #13 pc 00000000020b8cb4 /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so (android::GuiThread::ProcessTask(long)+64) #14 pc 00000000020b8c64 /data/app/app.organicmaps.debug-ssB2_Kqm6fWcL4r9r4KptQ==/lib/arm64/liborganicmaps.so (Java_app_organicmaps_MwmApplication_nativeProcessTask+28) #15 pc 000000000054fff0 /system/lib64/libart.so (art_quick_generic_jni_trampoline+144) #16 pc 000000000017c184 /dev/ashmem/dalvik-jit-code-cache (deleted) ```

biodranik commented

2023-10-29 20:38:23 +00:00

(Migrated from github.com)

@vng why the mwm is mentioned twice?

10-29 10:33:25.872: D/OMcore(7312): platform/platform_android.cpp:37 ~DbgLogger(): Source for file /storage/emulated/0/Android/data/app.organicmaps.debug/files/230920/US_California_Chico.mwm is f
10-29 10:33:25.883: D/OMcore(7312): platform/platform_android.cpp:37 ~DbgLogger(): Source for file /storage/emulated/0/Android/data/app.organicmaps.debug/files/230920/US_California_Chico.mwm is f
10-29 10:33:26.130: D/OMcore(7312): storage/storage.cpp:743 operator()(): Successful SHA check
10-29 10:33:26.130: E/OMcore(7312): storage/storage.cpp:799 RegisterDownloadedFiles(): Downloaded country file for already existing one LocalCountryFile [/storage/emulated/0/Android/data/app.organicmaps.debug/files/230920, CountryFile [US_California_Chico], 230920, [46261178]]
10-29 10:33:26.130: E/OMcore(7312): core/logging.cpp:45 AndroidLogMessage(): CHECK(level < g_LogAbortLevel) 3 3 Abort. Log level is too serious 3

`@vng` why the mwm is mentioned twice? ``` 10-29 10:33:25.872: D/OMcore(7312): platform/platform_android.cpp:37 ~DbgLogger(): Source for file /storage/emulated/0/Android/data/app.organicmaps.debug/files/230920/US_California_Chico.mwm is f 10-29 10:33:25.883: D/OMcore(7312): platform/platform_android.cpp:37 ~DbgLogger(): Source for file /storage/emulated/0/Android/data/app.organicmaps.debug/files/230920/US_California_Chico.mwm is f 10-29 10:33:26.130: D/OMcore(7312): storage/storage.cpp:743 operator()(): Successful SHA check 10-29 10:33:26.130: E/OMcore(7312): storage/storage.cpp:799 RegisterDownloadedFiles(): Downloaded country file for already existing one LocalCountryFile [/storage/emulated/0/Android/data/app.organicmaps.debug/files/230920, CountryFile [US_California_Chico], 230920, [46261178]] 10-29 10:33:26.130: E/OMcore(7312): core/logging.cpp:45 AndroidLogMessage(): CHECK(level < g_LogAbortLevel) 3 3 Abort. Log level is too serious 3 ```

rtsisyk commented

2023-11-22 08:32:09 +00:00

Author

Owner

This issue is constantly reproducing during monkey tests:

11-21 21:20:36.636: D/OMcore(7788): platform/platform_unix_impl.cpp:119 GetWritableStorageStatus(): statfs return = 0 ; block size = 4096 ; blocks available = 1318855
11-21 21:20:36.636: D/OMcore(7788): platform/platform_unix_impl.cpp:128 GetWritableStorageStatus(): Free space check: requested = 57316499 ; available = 5402030080
11-21 21:20:36.636: I/OMcore(7788): storage/storage.cpp:1288 DownloadNode(): Downloading US_California_Chico
11-21 21:20:36.636: I/OMcore(7788): storage/storage.cpp:760 operator()(): Registering downloaded file: US_California_Chico Map ; success: 1
11-21 21:20:36.637: D/OMcore(7788): platform/platform_android.cpp:37 ~DbgLogger(): Source for file /storage/emulated/0/Android/data/app.organicmaps.debug/files/231113/US_Ca
lifornia_Chico.mwm is f
11-21 21:20:36.637: I/OMcore(7788): map/framework.cpp:144 RegisterMap(): Loaded US_California_Chico map, of version 231113
11-21 21:20:36.667: D/OMcore(7788): storage/storage.cpp:743 operator()(): Successful SHA check
11-21 21:20:36.667: E/OMcore(7788): storage/storage.cpp:799 RegisterDownloadedFiles(): Downloaded country file for already existing one LocalCountryFile [/storage/emulated/
0/Android/data/app.organicmaps.debug/files/231113, CountryFile [US_California_Chico], 231113, [46830739]]
11-21 21:20:36.667: E/OMcore(7788): core/logging.cpp:45 AndroidLogMessage(): CHECK(level < g_LogAbortLevel) 3 3 Abort. Log level is too serious 3
11-21 21:20:36.667: F/libc(7788): /home/runner/work/organicmaps/organicmaps/android/app/src/main/cpp/app/organicmaps/core/logging.cpp:45: void jni::AndroidLogMessage(LogLev
el, const SrcPoint &, const std::string &): assertion "false" failed

This issue is constantly reproducing during monkey tests: ``` 11-21 21:20:36.636: D/OMcore(7788): platform/platform_unix_impl.cpp:119 GetWritableStorageStatus(): statfs return = 0 ; block size = 4096 ; blocks available = 1318855 11-21 21:20:36.636: D/OMcore(7788): platform/platform_unix_impl.cpp:128 GetWritableStorageStatus(): Free space check: requested = 57316499 ; available = 5402030080 11-21 21:20:36.636: I/OMcore(7788): storage/storage.cpp:1288 DownloadNode(): Downloading US_California_Chico 11-21 21:20:36.636: I/OMcore(7788): storage/storage.cpp:760 operator()(): Registering downloaded file: US_California_Chico Map ; success: 1 11-21 21:20:36.637: D/OMcore(7788): platform/platform_android.cpp:37 ~DbgLogger(): Source for file /storage/emulated/0/Android/data/app.organicmaps.debug/files/231113/US_Ca lifornia_Chico.mwm is f 11-21 21:20:36.637: I/OMcore(7788): map/framework.cpp:144 RegisterMap(): Loaded US_California_Chico map, of version 231113 11-21 21:20:36.667: D/OMcore(7788): storage/storage.cpp:743 operator()(): Successful SHA check 11-21 21:20:36.667: E/OMcore(7788): storage/storage.cpp:799 RegisterDownloadedFiles(): Downloaded country file for already existing one LocalCountryFile [/storage/emulated/ 0/Android/data/app.organicmaps.debug/files/231113, CountryFile [US_California_Chico], 231113, [46830739]] 11-21 21:20:36.667: E/OMcore(7788): core/logging.cpp:45 AndroidLogMessage(): CHECK(level < g_LogAbortLevel) 3 3 Abort. Log level is too serious 3 11-21 21:20:36.667: F/libc(7788): /home/runner/work/organicmaps/organicmaps/android/app/src/main/cpp/app/organicmaps/core/logging.cpp:45: void jni::AndroidLogMessage(LogLev el, const SrcPoint &, const std::string &): assertion "false" failed ```

biodranik commented

2023-11-22 10:15:09 +00:00

(Migrated from github.com)

@rtsisyk @vng it means that the same file that was already downloaded is downloaded a second time. How is it possible? Could it be that after the download starts, the same file is added again to the download queue? Can we see it from the monkey screencast?

`@rtsisyk` `@vng` it means that the same file that was already downloaded is downloaded a second time. How is it possible? Could it be that after the download starts, the same file is added again to the download queue? Can we see it from the monkey screencast?