android async protocols panic after 10 second timeout

[jkelleyrtp]

Describe the bug

I just updated Dioxus to Wry 50 and then 51 and started to run into a weird issue where after 10 seconds the app simply crashes. We're using Tao 33. Seems like a response isn't making it back from the shim code?

04-22 18:09:54.755   605   721 D ActivityManager: freezing 2286 com.android.vending:background
04-22 18:09:55.203   605   721 D ActivityManager: freezing 1899 com.android.vending
04-22 18:09:55.210   605   771 D InetDiagMessage: Destroyed 0 sockets, proto=IPPROTO_TCP, family=AF_INET, states=14
04-22 18:09:55.211   605   771 D InetDiagMessage: Destroyed 4 sockets, proto=IPPROTO_TCP, family=AF_INET6, states=14
04-22 18:09:55.211   605   771 D InetDiagMessage: Destroyed live tcp sockets for uids={10144} in 3ms
04-22 18:09:55.483   605   721 D ActivityManager: freezing 1566 com.google.android.googlequicksearchbox:search
04-22 18:09:55.885   605   721 D ActivityManager: freezing 3483 com.google.android.webview:webview_service
04-22 18:09:55.890   605   771 D InetDiagMessage: Destroyed 0 sockets, proto=IPPROTO_TCP, family=AF_INET, states=14
04-22 18:09:55.891   605   771 D InetDiagMessage: Destroyed 0 sockets, proto=IPPROTO_TCP, family=AF_INET6, states=14
04-22 18:09:55.891   605   771 D InetDiagMessage: Destroyed live tcp sockets for uids={10166} in 2ms
04-22 18:09:56.158   988  1191 D SatelliteController: iisInCarrierRoamingNbIotNtn: satellite is disabled
04-22 18:09:56.539  4738  4794 I RustStdoutStderr:
04-22 18:09:56.539  4738  4794 I RustStdoutStderr: thread '<unnamed>' panicked at /Users/jonathankelley/.cargo/registry/src/index.crates.io-1949cf8c6b5b557f/wry-0.51.2/src/android/mod.rs:295:60:
04-22 18:09:56.539  4738  4794 I RustStdoutStderr: called `Result::unwrap()` on an `Err` value: Timeout
04-22 18:09:56.539  4738  4794 I RustStdoutStderr: stack backtrace:
04-22 18:09:56.739  4738  4794 I RustStdoutStderr:    0: rust_begin_unwind
04-22 18:09:56.739  4738  4794 I RustStdoutStderr:              at ./rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/std/src/panicking.rs:695:5
04-22 18:09:56.739  4738  4794 I RustStdoutStderr:    1: core::panicking::panic_fmt
04-22 18:09:56.739  4738  4794 I RustStdoutStderr:              at ./rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/core/src/panicking.rs:75:14
04-22 18:09:56.739  4738  4794 I RustStdoutStderr:    2: core::result::unwrap_failed
04-22 18:09:56.739  4738  4794 I RustStdoutStderr:              at ./rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/core/src/result.rs:1704:5
04-22 18:09:56.740  4738  4794 I RustStdoutStderr:    3: core::result::Result<T,E>::unwrap
04-22 18:09:56.740  4738  4794 I RustStdoutStderr:              at ./Users/jonathankelley/.rustup/toolchains/stable-aarch64-apple-darwin/lib/rustlib/src/rust/library/core/src/result.rs:1109:23
04-22 18:09:56.740  4738  4794 I RustStdoutStderr:    4: wry::android::InnerWebView::new::{{closure}}
04-22 18:09:56.740  4738  4794 I RustStdoutStderr:              at ./Users/jonathankelley/.cargo/registry/src/index.crates.io-1949cf8c6b5b557f/wry-0.51.2/src/android/mod.rs:295:25
04-22 18:09:56.740  4738  4794 I RustStdoutStderr:    5: <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call
04-22 18:09:56.740  4738  4794 I RustStdoutStderr:              at ./Users/jonathankelley/.rustup/toolchains/stable-aarch64-apple-darwin/lib/rustlib/src/rust/library/alloc/src/boxed.rs:1990:9
04-22 18:09:56.741  4738  4794 I RustStdoutStderr:    6: wry::android::binding::handle_request
04-22 18:09:56.741  4738  4794 I RustStdoutStderr:              at ./Users/jonathankelley/.cargo/registry/src/index.crates.io-1949cf8c6b5b557f/wry-0.51.2/src/android/binding.rs:175:7
04-22 18:09:56.741  4738  4794 I RustStdoutStderr:    7: wry::android::binding::handleRequest
04-22 18:09:56.741  4738  4794 I RustStdoutStderr:              at ./Users/jonathankelley/.cargo/registry/src/index.crates.io-1949cf8c6b5b557f/wry-0.51.2/src/android/binding.rs:276:9
04-22 18:09:56.741  4738  4794 I RustStdoutStderr:    8: Java_dev_dioxus_main_RustWebViewClient_handleRequest
04-22 18:09:56.741  4738  4794 I RustStdoutStderr:              at ./Users/jonathankelley/Development/dioxus/packages/mobile/src/lib.rs:108:5
04-22 18:09:56.742  4738  4794 I RustStdoutStderr:    9: <unknown>
04-22 18:09:56.742  4738  4794 I RustStdoutStderr:   10: <unknown>
04-22 18:09:56.742  4738  4794 I RustStdoutStderr:   11: _ZN3art11interpreter6DoCallILb0EEEbPNS_9ArtMethodEPNS_6ThreadERNS_11ShadowFrameEPKNS_11InstructionEtbPNS_6JValueE
04-22 18:09:56.743  4738  4794 I RustStdoutStderr:   12: <unknown>
04-22 18:09:56.743  4738  4794 I RustStdoutStderr:   13: <unknown>
04-22 18:09:56.743  4738  4794 I RustStdoutStderr:   14: <unknown>
04-22 18:09:56.743  4738  4794 I RustStdoutStderr:   15: _ZN3art11interpreter6DoCallILb0EEEbPNS_9ArtMethodEPNS_6ThreadERNS_11ShadowFrameEPKNS_11InstructionEtbPNS_6JValueE
04-22 18:09:56.743  4738  4794 I RustStdoutStderr:   16: <unknown>
04-22 18:09:56.743  4738  4794 I RustStdoutStderr:   17: <unknown>
04-22 18:09:56.743  4738  4794 I RustStdoutStderr:   18: <unknown>
04-22 18:09:56.743  4738  4794 I RustStdoutStderr:   19: _ZN3art11interpreter6DoCallILb0EEEbPNS_9ArtMethodEPNS_6ThreadERNS_11ShadowFrameEPKNS_11InstructionEtbPNS_6JValueE
04-22 18:09:56.743  4738  4794 I RustStdoutStderr:   20: <unknown>
04-22 18:09:56.743  4738  4794 I RustStdoutStderr:   21: <unknown>
04-22 18:09:56.743  4738  4794 I RustStdoutStderr:   22: <unknown>
04-22 18:09:56.744  4738  4794 I RustStdoutStderr:   23: <unknown>
04-22 18:09:56.744  4738  4794 I RustStdoutStderr:   24: <unknown>
04-22 18:09:56.744  4738  4794 I RustStdoutStderr:   25: <unknown>
04-22 18:09:56.744  4738  4794 I RustStdoutStderr:   26: <unknown>
04-22 18:09:56.745  4738  4794 I RustStdoutStderr:   27: <unknown>
04-22 18:09:56.745  4738  4794 I RustStdoutStderr:   28: <unknown>
04-22 18:09:56.745  4738  4794 I RustStdoutStderr:   29: <unknown>
04-22 18:09:56.748  4738  4794 I RustStdoutStderr:   30: <unknown>
04-22 18:09:56.748  4738  4794 I RustStdoutStderr:   31: <unknown>
04-22 18:09:56.748  4738  4794 I RustStdoutStderr:   32: <unknown>
04-22 18:09:56.748  4738  4794 I RustStdoutStderr:   33: <unknown>
04-22 18:09:56.748  4738  4794 I RustStdoutStderr:   34: <unknown>
04-22 18:09:56.749  4738  4794 I RustStdoutStderr:   35: <unknown>
04-22 18:09:56.749  4738  4794 I RustStdoutStderr:   36: <unknown>
04-22 18:09:56.749  4738  4794 I RustStdoutStderr:   37: <unknown>
04-22 18:09:56.749  4738  4794 I RustStdoutStderr:   38: <unknown>
04-22 18:09:56.749  4738  4794 I RustStdoutStderr:   39: <unknown>
04-22 18:09:56.749  4738  4794 I RustStdoutStderr:   40: <unknown>
04-22 18:09:56.749  4738  4794 I RustStdoutStderr:   41: <unknown>
04-22 18:09:56.749  4738  4794 I RustStdoutStderr:   42: <unknown>
04-22 18:09:56.749  4738  4794 I RustStdoutStderr:   43: <unknown>
04-22 18:09:56.749  4738  4794 I RustStdoutStderr:   44: <unknown>
04-22 18:09:56.752  4738  4794 I RustStdoutStderr:   45: _ZL15__pthread_startPv
04-22 18:09:56.752  4738  4794 I RustStdoutStderr:   46: __start_thread
04-22 18:09:56.752  4738  4794 I RustStdoutStderr: note: Some details are omitted, run with `RUST_BACKTRACE=full` for a verbose backtrace.
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:
04-22 18:09:56.753  4738  4794 I RustStdoutStderr: thread '<unnamed>' panicked at library/core/src/panicking.rs:218:5:
04-22 18:09:56.753  4738  4794 I RustStdoutStderr: panic in a function that cannot unwind
04-22 18:09:56.753  4738  4794 I RustStdoutStderr: stack backtrace:
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:    0:       0x7b69828708 - std::backtrace_rs::backtrace::libunwind::trace::h9788b27d87a65119
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:    1:       0x7b69828708 - std::backtrace_rs::backtrace::trace_unsynchronized::h84279415deaece9e
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:    2:       0x7b69828708 - std::sys::backtrace::_print_fmt::h486c7459fe753633
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/std/src/sys/backtrace.rs:66:9
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:    3:       0x7b69828708 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::he6ae5c13f337e055
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/std/src/sys/backtrace.rs:39:26
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:    4:       0x7b69872cd0 - core::fmt::rt::Argument::fmt::ha6abcfbfc49ffe53
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/core/src/fmt/rt.rs:177:76
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:    5:       0x7b69872cd0 - core::fmt::write::hcb9bd977262a4cc9
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/core/src/fmt/mod.rs:1449:21
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:    6:       0x7b6981c418 - std::io::Write::write_fmt::he5e2b90bc467a15e
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/std/src/io/mod.rs:1890:15
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:    7:       0x7b698285bc - std::sys::backtrace::BacktraceLock::print::h36f6f245f6fb4dd6
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/std/src/sys/backtrace.rs:42:9
04-22 18:09:56.753  4738  4794 I RustStdoutStderr:    8:       0x7b6982a99c - std::panicking::default_hook::{{closure}}::h45d76474b7dacf6e
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/std/src/panicking.rs:298:22
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:    9:       0x7b6982a7c8 - std::panicking::default_hook::he40ccac6074689d0
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/std/src/panicking.rs:325:9
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:   10:       0x7b6982b8b8 - std::panicking::rust_panic_with_hook::hf825e5cc1b52c2a0
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/std/src/panicking.rs:831:13
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:   11:       0x7b6982b550 - std::panicking::begin_panic_handler::{{closure}}::h39f9583f31e5ea3e
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/std/src/panicking.rs:697:13
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:   12:       0x7b69828c08 - std::sys::backtrace::__rust_end_short_backtrace::h771b31aa3783c19a
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/std/src/sys/backtrace.rs:168:18
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:   13:       0x7b6982b238 - rust_begin_unwind
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/std/src/panicking.rs:695:5
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:   14:       0x7b6986f1b4 - core::panicking::panic_nounwind_fmt::runtime::h645866fe5f341c11
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/core/src/panicking.rs:117:22
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:   15:       0x7b6986f1b4 - core::panicking::panic_nounwind_fmt::hc95df0479ad49ba5
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/core/src/intrinsics/mod.rs:3886:9
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:   16:       0x7b6986f22c - core::panicking::panic_nounwind::h0020fdba32bb1341
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/core/src/panicking.rs:218:5
04-22 18:09:56.754  4738  4794 I RustStdoutStderr:   17:       0x7b6986f3dc - core::panicking::panic_cannot_unwind::hda0eeab974791a1b
04-22 18:09:56.755  4738  4794 I RustStdoutStderr:                                at /rustc/05f9846f893b09a1be1fc8560e33fc3c815cfecb/library/core/src/panicking.rs:323:5
04-22 18:09:56.755  4738  4794 I RustStdoutStderr:   18:       0x7b6898f0a8 - Java_dev_dioxus_main_RustWebViewClient_handleRequest
04-22 18:09:56.755  4738  4794 I RustStdoutStderr:                                at /Users/jonathankelley/.cargo/registry/src/index.crates.io-1949cf8c6b5b557f/wry-0.51.2/src/android/binding.rs:37:5

[jkelleyrtp]

In Dioxus we use long polling on the request async responder for custom protocols to get binary data into the webview using requests. Why should Android work differently here? I think we should be allowed to indefinitely hold the RequestAsyncResponder object without wry panicking the app. What's the point of that handler being async if you can't poll it for more than 10 seconds?

https://github.com/DioxusLabs/dioxus/blob/2d0ca77ff938e9d537e1c72946acac1cae94fffc/packages/desktop/src/edits.rs

[FabianLars]

for reference the pr that introduced the timeout #1415 cc @lucasfernog

[jkelleyrtp]

Is there any update on this? We'd like to release dioxus 0.7 soon but we can't upgrade to the newest wry because of this bug.

We can try moving to a websocket, but the underlying issue is going to cause deadlocks like in #1521