Closed Bug 1726910 Opened 4 years ago Closed 4 years ago

Intermittent netwerk/test/unit/test_http3_perf.js | application crashed [@ >()] | After Hit MOZ_CRASH(assertion failed: earliest > now) | xpcshell return code: 1

Categories

(Core :: Networking: HTTP, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE
Tracking Status
firefox-esr78 --- unaffected
firefox-esr91 --- unaffected
firefox91 --- unaffected
firefox92 --- unaffected
firefox93 --- affected

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: crash, intermittent-failure, regression, Whiteboard: [necko-triaged])

Crash Data

Filed by: nbeleuzu [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=349122621&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/KeVkR5_BSkGWpIaPTCBIHw/runs/1/artifacts/public/logs/live_backing.log


[task 2021-08-21T10:52:40.867Z] 10:52:40     INFO -  TEST-PASS | netwerk/test/unit/test_http3_perf.js | testOnStartRequest - [testOnStartRequest : 113] 200 == 200
[task 2021-08-21T10:52:40.867Z] 10:52:40     INFO -  PID 11824 | Hit MOZ_CRASH(assertion failed: earliest > now) at /builds/worker/checkouts/gecko/third_party/rust/neqo-transport/src/connection/mod.rs:940
[task 2021-08-21T10:52:40.867Z] 10:52:40     INFO -  Initializing stack-fixing for the first stack frame, this may take a while...
[task 2021-08-21T10:52:50.727Z] 10:52:50     INFO -  PID 11824 | #01: RustMozCrash(char const*, int, char const*) [mozglue/static/rust/wrappers.cpp:17]
[task 2021-08-21T10:52:50.727Z] 10:52:50     INFO -  PID 11824 | #02: mozglue_static::panic_hook(core::panic::PanicInfo*) [mozglue/static/rust/lib.rs:91]
[task 2021-08-21T10:52:50.728Z] 10:52:50     INFO -  PID 11824 | #03: core::ops::function::Fn::call<fn(core::panic::PanicInfo*),tuple<core::panic::PanicInfo*>>(void (**)(core::panic::PanicInfo*), core::panic::PanicInfo*) [git:github.com/rust-lang/rust:../a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/ops/function.rs:a178d0322ce20e33eac124758e837cbd80a6f633:70]
[task 2021-08-21T10:52:50.728Z] 10:52:50     INFO -  PID 11824 | #04: std::panicking::rust_panic_with_hook() [git:github.com/rust-lang/rust:../a178d0322ce20e33eac124758e837cbd80a6f633//library/std/src/panicking.rs:a178d0322ce20e33eac124758e837cbd80a6f633:629]
[task 2021-08-21T10:52:50.728Z] 10:52:50     INFO -  PID 11824 | #05: std::panicking::begin_panic_handler::{{closure}}() [git:github.com/rust-lang/rust:../a178d0322ce20e33eac124758e837cbd80a6f633//library/std/src/panicking.rs:a178d0322ce20e33eac124758e837cbd80a6f633:517]
[task 2021-08-21T10:52:50.729Z] 10:52:50     INFO -  PID 11824 | #06: std::sys_common::backtrace::__rust_end_short_backtrace<closure-0,!>() [git:github.com/rust-lang/rust:../a178d0322ce20e33eac124758e837cbd80a6f633//library/std/src/sys_common/backtrace.rs:a178d0322ce20e33eac124758e837cbd80a6f633:141]
[task 2021-08-21T10:52:50.729Z] 10:52:50     INFO -  PID 11824 | #07: std::panicking::begin_panic_handler() [git:github.com/rust-lang/rust:../a178d0322ce20e33eac124758e837cbd80a6f633//library/std/src/panicking.rs:a178d0322ce20e33eac124758e837cbd80a6f633:515]
[task 2021-08-21T10:52:50.730Z] 10:52:50     INFO -  PID 11824 | #08: core::panicking::panic_fmt() [git:github.com/rust-lang/rust:../a178d0322ce20e33eac124758e837cbd80a6f633//library/core/src/panicking.rs:a178d0322ce20e33eac124758e837cbd80a6f633:92]
[task 2021-08-21T10:52:50.730Z] 10:52:50     INFO -  PID 11824 | #09: core::panicking::panic() [git:github.com/rust-lang/rust:../a178d0322ce20e33eac124758e837cbd80a6f633//library/core/src/panicking.rs:a178d0322ce20e33eac124758e837cbd80a6f633:50]
[task 2021-08-21T10:52:50.730Z] 10:52:50     INFO -  PID 11824 | #10: neqo_transport::connection::Connection::process_output(std::time::Instant) [third_party/rust/neqo-transport/src/connection/mod.rs:974]
[task 2021-08-21T10:52:50.731Z] 10:52:50     INFO -  PID 11824 | #11: neqo_http3::connection_client::Http3Client::process_output(std::time::Instant) [third_party/rust/neqo-http3/src/connection_client.rs:506]
[task 2021-08-21T10:52:50.731Z] 10:52:50     INFO -  PID 11824 | #12: neqo_glue::neqo_http3conn_process_output(neqo_glue::NeqoHttp3Conn*, nsstring::nsACString*, unsigned short*, thin_vec::ThinVec<u8>*, unsigned long long*) [netwerk/socket/neqo_glue/src/lib.rs:246]
[task 2021-08-21T10:52:50.732Z] 10:52:50     INFO -  PID 11824 | #13: mozilla::net::Http3Session::ProcessOutput(nsIUDPSocket*) [netwerk/protocol/http/Http3Session.cpp:646]
[task 2021-08-21T10:52:50.732Z] 10:52:50     INFO -  PID 11824 | #14: mozilla::net::Http3Session::ProcessOutputAndEvents(nsIUDPSocket*) [netwerk/protocol/http/Http3Session.cpp:697]
[task 2021-08-21T10:52:50.733Z] 10:52:50     INFO -  PID 11824 | #15: static mozilla::net::HttpConnectionUDP::OnQuicTimeout(nsITimer*, void*) [netwerk/protocol/http/HttpConnectionUDP.cpp:507]
[task 2021-08-21T10:52:50.733Z] 10:52:50     INFO -  PID 11824 | #16: nsTimerImpl::Fire(int) [xpcom/threads/nsTimerImpl.cpp:627]
[task 2021-08-21T10:52:50.733Z] 10:52:50     INFO -  PID 11824 | #17: nsTimerEvent::Run() [xpcom/threads/TimerThread.cpp:248]
[task 2021-08-21T10:52:50.734Z] 10:52:50     INFO -  PID 11824 | #18: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1142]
[task 2021-08-21T10:52:50.735Z] 10:52:50     INFO -  PID 11824 | #19: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:466]
[task 2021-08-21T10:52:50.735Z] 10:52:50     INFO -  PID 11824 | #20: mozilla::net::nsSocketTransportService::Run() [netwerk/base/nsSocketTransportService2.cpp:1191]
[task 2021-08-21T10:52:50.735Z] 10:52:50     INFO -  PID 11824 | #21: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1142]
[task 2021-08-21T10:52:50.735Z] 10:52:50     INFO -  PID 11824 | #22: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:466]
[task 2021-08-21T10:52:50.736Z] 10:52:50     INFO -  PID 11824 | #23: mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [ipc/glue/MessagePump.cpp:301]
[task 2021-08-21T10:52:50.736Z] 10:52:50     INFO -  PID 11824 | #24: MessageLoop::RunHandler() [ipc/chromium/src/base/message_loop.cc:325]
[task 2021-08-21T10:52:50.736Z] 10:52:50     INFO -  PID 11824 | #25: MessageLoop::Run() [ipc/chromium/src/base/message_loop.cc:307]
[task 2021-08-21T10:52:50.736Z] 10:52:50     INFO -  PID 11824 | #26: static nsThread::ThreadFunc(void*) [xpcom/threads/nsThread.cpp:392]
[task 2021-08-21T10:52:50.923Z] 10:52:50     INFO -  PID 11824 | #27: PR_NativeRunThread(void*) [nsprpub/pr/src/threads/combined/pruthr.c:408]
[task 2021-08-21T10:52:50.929Z] 10:52:50     INFO -  PID 11824 | #28: pr_root(void*) [nsprpub/pr/src/md/windows/w95thred.c:140]
[task 2021-08-21T10:52:50.933Z] 10:52:50     INFO -  fix-stacks: error: failed to read debug info file `ucrtbase.pdb` for `C:\Windows\System32\ucrtbase.dll`
[task 2021-08-21T10:52:50.934Z] 10:52:50     INFO -  fix-stacks: note: this is expected and harmless for all PDB files on opt automation runs
[task 2021-08-21T10:52:50.934Z] 10:52:50     INFO -  fix-stacks: The system cannot find the file specified. (os error 2)
[task 2021-08-21T10:52:50.934Z] 10:52:50     INFO -  PID 11824 | #29: configthreadlocale [C:\Windows\System32\ucrtbase.dll + 0x21bb2]
[task 2021-08-21T10:52:50.937Z] 10:52:50     INFO -  fix-stacks: error: failed to read debug info file `wkernel32.pdb` for `C:\Windows\System32\KERNEL32.DLL`
[task 2021-08-21T10:52:50.938Z] 10:52:50     INFO -  fix-stacks: note: this is expected and harmless for all PDB files on opt automation runs
[task 2021-08-21T10:52:50.938Z] 10:52:50     INFO -  fix-stacks: The system cannot find the file specified. (os error 2)
[task 2021-08-21T10:52:50.938Z] 10:52:50     INFO -  PID 11824 | #30: BaseThreadInitThunk [C:\Windows\System32\KERNEL32.DLL + 0x17034]
[task 2021-08-21T10:52:50.982Z] 10:52:50     INFO -  PID 11824 | #31: patched_BaseThreadInitThunk(int, void*, void*) [toolkit/xre/dllservices/mozglue/WindowsDllBlocklist.cpp:588]
[task 2021-08-21T10:52:50.999Z] 10:52:50     INFO -  fix-stacks: error: failed to read debug info file `wntdll.pdb` for `C:\Windows\SYSTEM32\ntdll.dll`
[task 2021-08-21T10:52:50.999Z] 10:52:50     INFO -  fix-stacks: note: this is expected and harmless for all PDB files on opt automation runs
[task 2021-08-21T10:52:50.999Z] 10:52:50     INFO -  fix-stacks: The system cannot find the file specified. (os error 2)
[task 2021-08-21T10:52:50.999Z] 10:52:50     INFO -  PID 11824 | #32: RtlUserThreadStart [C:\Windows\SYSTEM32\ntdll.dll + 0x52651]
[task 2021-08-21T10:52:51.000Z] 10:52:50     INFO -  <<<<<<<
[task 2021-08-21T10:52:57.080Z] 10:52:57  WARNING -  PROCESS-CRASH | netwerk/test/unit/test_http3_perf.js | application crashed [@ >()]
[task 2021-08-21T10:52:57.080Z] 10:52:57     INFO -  Mozilla crash reason: assertion failed: earliest > now
[task 2021-08-21T10:52:57.094Z] 10:52:57     INFO -  Crash dump filename: C:\Users\task_162954082415344\AppData\Local\Temp\xpc-other-0q20ykpv\c36bfca8-bc02-4c1f-acd6-627b74a62bc0.dmp
[task 2021-08-21T10:52:57.094Z] 10:52:57     INFO -  Operating system: Windows NT
[task 2021-08-21T10:52:57.094Z] 10:52:57     INFO -                    10.0.19041
[task 2021-08-21T10:52:57.094Z] 10:52:57     INFO -  CPU: amd64
[task 2021-08-21T10:52:57.095Z] 10:52:57     INFO -       family 6 model 85 stepping 4
[task 2021-08-21T10:52:57.095Z] 10:52:57     INFO -       8 CPUs
[task 2021-08-21T10:52:57.095Z] 10:52:57     INFO -  GPU: UNKNOWN
[task 2021-08-21T10:52:57.095Z] 10:52:57     INFO -  Crash reason:  EXCEPTION_BREAKPOINT
[task 2021-08-21T10:52:57.095Z] 10:52:57     INFO -  Crash address: 0xcd5be593
[task 2021-08-21T10:52:57.095Z] 10:52:57     INFO -  Process uptime: 31 seconds
[task 2021-08-21T10:52:57.096Z] 10:52:57     INFO -  Thread 9 tid 6840 (crashed) - Socket Thread 0  xul.dll!RustMozCrash(char const*, int, char const*) [wrappers.cpp:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 17 + 0x23]
[task 2021-08-21T10:52:57.096Z] 10:52:57     INFO -      rax = 0x00007fffe1f88888   rdx = 0x0000000000000000
[task 2021-08-21T10:52:57.096Z] 10:52:57     INFO -      rcx = 0x0000000000002002   rbx = 0x00007fffcf115780
[task 2021-08-21T10:52:57.097Z] 10:52:57     INFO -      rsi = 0x00000074a46fdfe2   rdi = 0x00000000000003ac
[task 2021-08-21T10:52:57.097Z] 10:52:57     INFO -      rbp = 0x00000074a46fde30   rsp = 0x00000074a46fdd70
[task 2021-08-21T10:52:57.097Z] 10:52:57     INFO -       r8 = 0x00000074a46ffdd0    r9 = 0x00007ff8095b0000
[task 2021-08-21T10:52:57.097Z] 10:52:57     INFO -      r10 = 0x00007ff809602651   r11 = 0x00000074a46fd730
[task 2021-08-21T10:52:57.098Z] 10:52:57     INFO -      r12 = 0x00007fffcf083998   r13 = 0x00007fffcf116320
[task 2021-08-21T10:52:57.098Z] 10:52:57     INFO -      r14 = 0x00007fffcf116300   r15 = 0x0000000000000020
[task 2021-08-21T10:52:57.098Z] 10:52:57     INFO -      rip = 0x00007fffcd5be593
[task 2021-08-21T10:52:57.098Z] 10:52:57     INFO -      Found by: given as instruction pointer in context
[task 2021-08-21T10:52:57.099Z] 10:52:57     INFO -   1  xul.dll!mozglue_static::panic_hook(core::panic::PanicInfo*) [lib.rs:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 91 + 0x7]
[task 2021-08-21T10:52:57.099Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.099Z] 10:52:57     INFO -      rsp = 0x00000074a46fddb0   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.099Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.100Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffcbfd79e4
[task 2021-08-21T10:52:57.100Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.100Z] 10:52:57     INFO -   2  xul.dll!core::ops::function::Fn::call<fn(core::panic::PanicInfo*),tuple<core::panic::PanicInfo*>>(void (**)(core::panic::PanicInfo*), core::panic::PanicInfo*) [function.rs:a178d0322ce20e33eac124758e837cbd80a6f633 : 70 + 0x12]
[task 2021-08-21T10:52:57.100Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.101Z] 10:52:57     INFO -      rsp = 0x00000074a46fe220   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.101Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.101Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffcbfd7642
[task 2021-08-21T10:52:57.101Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.101Z] 10:52:57     INFO -   3  xul.dll!std::panicking::rust_panic_with_hook() [panicking.rs:a178d0322ce20e33eac124758e837cbd80a6f633 : 626 + 0xa]
[task 2021-08-21T10:52:57.102Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.102Z] 10:52:57     INFO -      rsp = 0x00000074a46fe250   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.102Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.102Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffccda1cd0
[task 2021-08-21T10:52:57.102Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.103Z] 10:52:57     INFO -   4  xul.dll!std::panicking::begin_panic_handler::{{closure}}() [panicking.rs:a178d0322ce20e33eac124758e837cbd80a6f633 : 517 + 0x28]
[task 2021-08-21T10:52:57.103Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.103Z] 10:52:57     INFO -      rsp = 0x00000074a46fe330   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.103Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.103Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffccda1763
[task 2021-08-21T10:52:57.104Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.104Z] 10:52:57     INFO -   5  xul.dll!std::sys_common::backtrace::__rust_end_short_backtrace<closure-0,!>() [backtrace.rs:a178d0322ce20e33eac124758e837cbd80a6f633 : 141 + 0x1b]
[task 2021-08-21T10:52:57.104Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.104Z] 10:52:57     INFO -      rsp = 0x00000074a46fe390   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.105Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.105Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffccd9daff
[task 2021-08-21T10:52:57.105Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.105Z] 10:52:57     INFO -   6  xul.dll!std::panicking::begin_panic_handler() [panicking.rs:a178d0322ce20e33eac124758e837cbd80a6f633 : 515 + 0x19]
[task 2021-08-21T10:52:57.106Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.106Z] 10:52:57     INFO -      rsp = 0x00000074a46fe3d0   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.106Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.106Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffccda16e9
[task 2021-08-21T10:52:57.106Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.107Z] 10:52:57     INFO -   7  xul.dll!core::panicking::panic_fmt() [panicking.rs:a178d0322ce20e33eac124758e837cbd80a6f633 : 92 + 0x5]
[task 2021-08-21T10:52:57.107Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.107Z] 10:52:57     INFO -      rsp = 0x00000074a46fe420   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.107Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.107Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffcdbc7be0
[task 2021-08-21T10:52:57.108Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.108Z] 10:52:57     INFO -   8  xul.dll!core::panicking::panic() [panicking.rs:a178d0322ce20e33eac124758e837cbd80a6f633 : 50 + 0x8]
[task 2021-08-21T10:52:57.108Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.108Z] 10:52:57     INFO -      rsp = 0x00000074a46fe470   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.108Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.109Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffcdbc7b2c
[task 2021-08-21T10:52:57.109Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.109Z] 10:52:57     INFO -   9  xul.dll!neqo_transport::connection::Connection::process_output(std::time::Instant) [mod.rs:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 974 + 0x5cd]
[task 2021-08-21T10:52:57.109Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.109Z] 10:52:57     INFO -      rsp = 0x00000074a46fe4e0   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.110Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.110Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffcd0018eb
[task 2021-08-21T10:52:57.110Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.110Z] 10:52:57     INFO -  10  xul.dll!neqo_http3::connection_client::Http3Client::process_output(std::time::Instant) [connection_client.rs:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 503 + 0x12]
[task 2021-08-21T10:52:57.111Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.111Z] 10:52:57     INFO -      rsp = 0x00000074a46fe9d0   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.111Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.111Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffcd06ab2a
[task 2021-08-21T10:52:57.111Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.112Z] 10:52:57     INFO -  11  xul.dll!neqo_glue::neqo_http3conn_process_output(neqo_glue::NeqoHttp3Conn*, nsstring::nsACString*, unsigned short*, thin_vec::ThinVec<u8>*, unsigned long long*) [lib.rs:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 245 + 0x17]
[task 2021-08-21T10:52:57.112Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.112Z] 10:52:57     INFO -      rsp = 0x00000074a46fea90   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.112Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.113Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffcbed9c11
[task 2021-08-21T10:52:57.113Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.113Z] 10:52:57     INFO -  12  xul.dll!mozilla::net::Http3Session::ProcessOutput(nsIUDPSocket*) [Http3Session.cpp:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 646 + 0x4f]
[task 2021-08-21T10:52:57.113Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.114Z] 10:52:57     INFO -      rsp = 0x00000074a46fec40   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.114Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.114Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffc563c1eb
[task 2021-08-21T10:52:57.114Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.114Z] 10:52:57     INFO -  13  xul.dll!mozilla::net::Http3Session::ProcessOutputAndEvents(nsIUDPSocket*) [Http3Session.cpp:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 696 + 0xb]
[task 2021-08-21T10:52:57.115Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.115Z] 10:52:57     INFO -      rsp = 0x00000074a46fedf0   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.115Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.115Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffc563cab1
[task 2021-08-21T10:52:57.116Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.117Z] 10:52:57     INFO -  14  xul.dll!static mozilla::net::HttpConnectionUDP::OnQuicTimeout(nsITimer*, void*) [HttpConnectionUDP.cpp:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 507 + 0x18]
[task 2021-08-21T10:52:57.117Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.117Z] 10:52:57     INFO -      rsp = 0x00000074a46feea0   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.117Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.118Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffc569e676
[task 2021-08-21T10:52:57.118Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.118Z] 10:52:57     INFO -  15  xul.dll!nsTimerImpl::Fire(int) [nsTimerImpl.cpp:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 618 + 0xb6]
[task 2021-08-21T10:52:57.118Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.118Z] 10:52:57     INFO -      rsp = 0x00000074a46feed0   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.119Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.119Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffc50386a4
[task 2021-08-21T10:52:57.119Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.119Z] 10:52:57     INFO -  16  xul.dll!nsTimerEvent::Run() [TimerThread.cpp:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 248 + 0x8]
[task 2021-08-21T10:52:57.119Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.120Z] 10:52:57     INFO -      rsp = 0x00000074a46ff060   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.120Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.120Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffc500d56b
[task 2021-08-21T10:52:57.120Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.120Z] 10:52:57     INFO -  17  xul.dll!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 1142 + 0xd]
[task 2021-08-21T10:52:57.121Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.121Z] 10:52:57     INFO -      rsp = 0x00000074a46ff0d0   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.121Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.121Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffc5017bd5
[task 2021-08-21T10:52:57.121Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.122Z] 10:52:57     INFO -  18  xul.dll!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 466 + 0x14]
[task 2021-08-21T10:52:57.122Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.122Z] 10:52:57     INFO -      rsp = 0x00000074a46ff2b0   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.122Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.123Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffc501f012
[task 2021-08-21T10:52:57.123Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.123Z] 10:52:57     INFO -  19  xul.dll!mozilla::net::nsSocketTransportService::Run() [nsSocketTransportService2.cpp:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 1190 + 0xb]
[task 2021-08-21T10:52:57.123Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.123Z] 10:52:57     INFO -      rsp = 0x00000074a46ff300   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.124Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.124Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffc521aefa
[task 2021-08-21T10:52:57.124Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.124Z] 10:52:57     INFO -  20  xul.dll!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 1142 + 0xd]
[task 2021-08-21T10:52:57.124Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.125Z] 10:52:57     INFO -      rsp = 0x00000074a46ff6a0   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.125Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.125Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffc5017bd5
[task 2021-08-21T10:52:57.125Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.125Z] 10:52:57     INFO -  21  xul.dll!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 466 + 0x14]
[task 2021-08-21T10:52:57.126Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.126Z] 10:52:57     INFO -      rsp = 0x00000074a46ff880   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.126Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.126Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffc501f012
[task 2021-08-21T10:52:57.126Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.127Z] 10:52:57     INFO -  22  xul.dll!mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [MessagePump.cpp:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 300 + 0xa]
[task 2021-08-21T10:52:57.127Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.127Z] 10:52:57     INFO -      rsp = 0x00000074a46ff8d0   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.127Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.128Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffc59172d7
[task 2021-08-21T10:52:57.128Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.128Z] 10:52:57     INFO -  23  xul.dll!MessageLoop::RunHandler() [message_loop.cc:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 324 + 0x8]
[task 2021-08-21T10:52:57.128Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.129Z] 10:52:57     INFO -      rsp = 0x00000074a46ff940   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.129Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.129Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffc589ac00
[task 2021-08-21T10:52:57.129Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.129Z] 10:52:57     INFO -  24  xul.dll!MessageLoop::Run() [message_loop.cc:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 306 + 0x5]
[task 2021-08-21T10:52:57.130Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.130Z] 10:52:57     INFO -      rsp = 0x00000074a46ff990   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.130Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.130Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffc589aabd
[task 2021-08-21T10:52:57.130Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.131Z] 10:52:57     INFO -  25  xul.dll!static nsThread::ThreadFunc(void*) [nsThread.cpp:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 390 + 0x8]
[task 2021-08-21T10:52:57.131Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.131Z] 10:52:57     INFO -      rsp = 0x00000074a46ff9e0   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.131Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.131Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffc5013f67
[task 2021-08-21T10:52:57.132Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.132Z] 10:52:57     INFO -  26  nss3.dll!PR_NativeRunThread(void*) [pruthr.c:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 399 + 0xe]
[task 2021-08-21T10:52:57.132Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.132Z] 10:52:57     INFO -      rsp = 0x00000074a46ffbd0   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.132Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.133Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffe0a99462
[task 2021-08-21T10:52:57.133Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.133Z] 10:52:57     INFO -  27  nss3.dll!pr_root(void*) [w95thred.c:3db432e2820882f8a29b52e4a3a0baee9e8d19eb : 139 + 0xd]
[task 2021-08-21T10:52:57.133Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.133Z] 10:52:57     INFO -      rsp = 0x00000074a46ffc50   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.134Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.134Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007fffe0a89e41
[task 2021-08-21T10:52:57.134Z] 10:52:57     INFO -      Found by: call frame info
[task 2021-08-21T10:52:57.134Z] 10:52:57     INFO -  28  ucrtbase.dll!RtlpReAllocateHeap + 0x1ce
[task 2021-08-21T10:52:57.134Z] 10:52:57     INFO -      rbx = 0x00007fffcf115780   rbp = 0x00000074a46fde30
[task 2021-08-21T10:52:57.135Z] 10:52:57     INFO -      rsp = 0x00000074a46ffc80   r12 = 0x00007fffcf083998
[task 2021-08-21T10:52:57.135Z] 10:52:57     INFO -      r13 = 0x00007fffcf116320   r14 = 0x00007fffcf116300
[task 2021-08-21T10:52:57.135Z] 10:52:57     INFO -      r15 = 0x0000000000000020   rip = 0x00007ff806fd1bb2
[task 2021-08-21T10:52:57.135Z] 10:52:57     INFO -      Found by: call frame info
Component: mozglue → Networking: HTTP
Flags: needinfo?(dd.mozilla)
Keywords: regression
Regressed by: 1723218
Has Regression Range: --- → yes

This is an known issue. It is not related to bug 1723218. It is only a debug assert. I will open an issue in neqo repo, maybe with this test we could reproduce it. We will need logs to resolved it.

Flags: needinfo?(dd.mozilla)
Priority: -- → P5
Whiteboard: [necko-triaged]
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.