events::chatlist_events::test_chatlist_events::test_update_after_ephemeral_messages is flaky

[link2xt]

cc @Simon-Laux

Still not fixed. I fixed python docs by pinning sphinx meanwhile.

Here is a test failure: https://github.com/deltachat/deltachat-core-rust/actions/runs/8721401263/job/23925048947

[link2xt]

Reproduced by running while cargo test events::chatlist_events::test_chatlist_events::test_update_after_ephemeral_messages; do :; done for a while:

running 1 test
test events::chatlist_events::test_chatlist_events::test_update_after_ephemeral_messages ... FAILED

failures:

---- events::chatlist_events::test_chatlist_events::test_update_after_ephemeral_messages stdout ----
thread 'events::chatlist_events::test_chatlist_events::test_update_after_ephemeral_messages' panicked at src/test_utils.rs:1010:10:
timeout waiting for event match: Elapsed(())
note: run with `RUST_BACKTRACE=1` environment variable to display a backtrace

========== Chats of alice: ==========
Group#Chat#10: My Group [1 member(s)] 🛡️
--------------------------------------------------------------------------------
Msg#10: info (Contact#Contact#Info): Messages are guaranteed to be end-to-end encrypted from now on. [NOTICED][INFO 🛡️]
Msg#11🔒: Me (Contact#Contact#Self): Hello  o
--------------------------------------------------------------------------------

alice INFO: src/sql/migrations.rs:924: Created new database; [migration] v68-v110
alice INFO: src/sql.rs:293: Opened database "/tmp/.tmp8hATjy/db.sqlite".
alice Received MSGS_CHANGED(chat_id=Chat#Special0, msg_id=Msg#0)
alice Received Event { id: 760938927, typ: ChatlistChanged }
alice Received Event { id: 760938927, typ: ChatlistItemChanged { chat_id: Some(ChatId(10)) } }
alice Received CHAT_MODIFIED(Chat#10)
alice Received Event { id: 760938927, typ: ChatlistItemChanged { chat_id: Some(ChatId(10)) } }
alice INFO: src/chat.rs:1327: Set gossiped_timestamp for chat Chat#10 to 0.
alice Received MSGS_CHANGED(chat_id=Chat#10, msg_id=Msg#10)
alice Received Event { id: 760938927, typ: ChatlistChanged }
alice Received Event { id: 760938927, typ: ChatlistItemChanged { chat_id: Some(ChatId(10)) } }
alice Received Event { id: 760938927, typ: ChatlistItemChanged { chat_id: Some(ChatId(10)) } }
alice Received Event { id: 760938927, typ: ChatEphemeralTimerModified { chat_id: ChatId(10), timer: Enabled { duration: 1 } } }
alice Received MSGS_CHANGED(chat_id=Chat#10, msg_id=Msg#11)
alice Received Event { id: 760938927, typ: ChatlistChanged }
alice Received Event { id: 760938927, typ: ChatlistItemChanged { chat_id: Some(ChatId(10)) } }


failures:
    events::chatlist_events::test_chatlist_events::test_update_after_ephemeral_messages

test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 790 filtered out; finished in 10.04s

error: test failed, to rerun pass `--lib`

Same with backtrace from while RUST_BACKTRACE=1 cargo test events::chatlist_events::test_chatlist_events::test_update_after_ephemeral_messages; do :; done:

running 1 test
test events::chatlist_events::test_chatlist_events::test_update_after_ephemeral_messages ... FAILED

failures:

---- events::chatlist_events::test_chatlist_events::test_update_after_ephemeral_messages stdout ----
thread 'events::chatlist_events::test_chatlist_events::test_update_after_ephemeral_messages' panicked at src/test_utils.rs:1010:10:
timeout waiting for event match: Elapsed(())
stack backtrace:
   0: rust_begin_unwind
   1: core::panicking::panic_fmt
   2: core::result::unwrap_failed
   3: core::result::Result<T,E>::expect
             at /usr/src/debug/rust/rustc-1.77.2-src/library/core/src/result.rs:1030:23
   4: deltachat::test_utils::EventTracker::get_matching::{{closure}}
             at ./src/test_utils.rs:1001:9
   5: deltachat::events::chatlist_events::test_chatlist_events::wait_for_chatlist_and_specific_item::{{closure}}
             at ./src/events/chatlist_events.rs:103:14
   6: deltachat::events::chatlist_events::test_chatlist_events::test_update_after_ephemeral_messages::{{closure}}
             at ./src/events/chatlist_events.rs:526:59
   7: <core::pin::Pin<P> as core::future::future::Future>::poll
             at /usr/src/debug/rust/rustc-1.77.2-src/library/core/src/future/future.rs:124:9
   8: tokio::runtime::park::CachedParkThread::block_on::{{closure}}
             at /home/user/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.37.0/src/runtime/park.rs:281:63
   9: tokio::runtime::coop::with_budget
             at /home/user/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.37.0/src/runtime/coop.rs:107:5
  10: tokio::runtime::coop::budget
             at /home/user/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.37.0/src/runtime/coop.rs:73:5
  11: tokio::runtime::park::CachedParkThread::block_on
             at /home/user/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.37.0/src/runtime/park.rs:281:31
  12: tokio::runtime::context::blocking::BlockingRegionGuard::block_on
             at /home/user/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.37.0/src/runtime/context/blocking.rs:66:9
  13: tokio::runtime::scheduler::multi_thread::MultiThread::block_on::{{closure}}
             at /home/user/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.37.0/src/runtime/scheduler/multi_thread/mod.rs:87:13
  14: tokio::runtime::context::runtime::enter_runtime
             at /home/user/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.37.0/src/runtime/context/runtime.rs:65:16
  15: tokio::runtime::scheduler::multi_thread::MultiThread::block_on
             at /home/user/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.37.0/src/runtime/scheduler/multi_thread/mod.rs:86:9
  16: tokio::runtime::runtime::Runtime::block_on
             at /home/user/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.37.0/src/runtime/runtime.rs:351:45
  17: deltachat::events::chatlist_events::test_chatlist_events::test_update_after_ephemeral_messages
             at ./src/events/chatlist_events.rs:528:9
  18: deltachat::events::chatlist_events::test_chatlist_events::test_update_after_ephemeral_messages::{{closure}}
             at ./src/events/chatlist_events.rs:516:56
  19: core::ops::function::FnOnce::call_once
             at /usr/src/debug/rust/rustc-1.77.2-src/library/core/src/ops/function.rs:250:5
note: Some details are omitted, run with `RUST_BACKTRACE=full` for a verbose backtrace.

========== Chats of alice: ==========
Group#Chat#10: My Group [1 member(s)] 🛡️
--------------------------------------------------------------------------------
Msg#10: info (Contact#Contact#Info): Messages are guaranteed to be end-to-end encrypted from now on. [NOTICED][INFO 🛡️]
Msg#11🔒: Me (Contact#Contact#Self): Hello  o
--------------------------------------------------------------------------------

alice INFO: src/sql/migrations.rs:924: Created new database; [migration] v68-v110
alice INFO: src/sql.rs:293: Opened database "/tmp/.tmpsvraLy/db.sqlite".
alice Received MSGS_CHANGED(chat_id=Chat#Special0, msg_id=Msg#0)
alice Received Event { id: 1091945647, typ: ChatlistChanged }
alice Received Event { id: 1091945647, typ: ChatlistItemChanged { chat_id: Some(ChatId(10)) } }
alice Received CHAT_MODIFIED(Chat#10)
alice Received Event { id: 1091945647, typ: ChatlistItemChanged { chat_id: Some(ChatId(10)) } }
alice INFO: src/chat.rs:1327: Set gossiped_timestamp for chat Chat#10 to 0.
alice Received MSGS_CHANGED(chat_id=Chat#10, msg_id=Msg#10)
alice Received Event { id: 1091945647, typ: ChatlistChanged }
alice Received Event { id: 1091945647, typ: ChatlistItemChanged { chat_id: Some(ChatId(10)) } }
alice Received Event { id: 1091945647, typ: ChatlistItemChanged { chat_id: Some(ChatId(10)) } }
alice Received Event { id: 1091945647, typ: ChatEphemeralTimerModified { chat_id: ChatId(10), timer: Enabled { duration: 1 } } }
alice Received MSGS_CHANGED(chat_id=Chat#10, msg_id=Msg#11)
alice Received Event { id: 1091945647, typ: ChatlistChanged }
alice Received Event { id: 1091945647, typ: ChatlistItemChanged { chat_id: Some(ChatId(10)) } }


failures:
    events::chatlist_events::test_chatlist_events::test_update_after_ephemeral_messages

test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 790 filtered out; finished in 10.16s

error: test failed, to rerun pass `--lib`