1926722 - Intermittent application crashed [@ nsCOMPtr<nsIThread>::operator->] | single tracking bug

Reporter

Description

•

1 year ago

treeherder

Filed by: nfay [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=479572280&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/PGT-F1JMS1KX3vsEs4Pv8w/runs/0/artifacts/public/logs/live_backing.log

[task 2024-10-23T22:20:36.298Z] 22:20:36     INFO -  TEST-PASS | xpcshell-remote.toml:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_startup.js | took 82592ms
[task 2024-10-23T22:20:39.203Z] 22:20:39     INFO -  TEST-PASS | xpcshell-remote.toml:toolkit/components/extensions/test/xpcshell/test_ext_contentScripts_register.js | took 45107ms
[task 2024-10-23T22:20:45.542Z] 22:20:45  WARNING -  PROCESS-CRASH | application crashed [@ nsCOMPtr<nsIThread>::operator->] | xpcshell-remote.toml:toolkit/components/extensions/test/xpcshell/test_ext_contentScripts_register.js
[task 2024-10-23T22:20:45.543Z] 22:20:45     INFO -  Process type: unknown
[task 2024-10-23T22:20:45.544Z] 22:20:45     INFO -  Process pid: 15406
[task 2024-10-23T22:20:45.545Z] 22:20:45     INFO -  Crash dump filename: /tmp/xpc-other-gibwmk98/2e464162-225d-341f-5441-5f332967b86b.dmp
[task 2024-10-23T22:20:45.546Z] 22:20:45     INFO -  Operating system: Linux
[task 2024-10-23T22:20:45.547Z] 22:20:45     INFO -                    4.4.0-1014-aws #14taskcluster1-Ubuntu SMP Tue Apr 3 10:27:00 UTC 2018
[task 2024-10-23T22:20:45.548Z] 22:20:45     INFO -  CPU: amd64
[task 2024-10-23T22:20:45.548Z] 22:20:45     INFO -       family 6 model 85 stepping 7
[task 2024-10-23T22:20:45.549Z] 22:20:45     INFO -       4 CPUs
[task 2024-10-23T22:20:45.550Z] 22:20:45     INFO -  Linux Ubuntu 18.04 - bionic (Ubuntu 18.04.6 LTS)
[task 2024-10-23T22:20:45.551Z] 22:20:45     INFO -  Crash reason:  SIGSEGV / SEGV_MAPERR
[task 2024-10-23T22:20:45.552Z] 22:20:45     INFO -  Crash address: 0x0000000000000000
[task 2024-10-23T22:20:45.553Z] 22:20:45     INFO -  Crashing instruction: `mov dword [0x0], 0x303`
[task 2024-10-23T22:20:45.553Z] 22:20:45     INFO -  Memory accessed by instruction:
[task 2024-10-23T22:20:45.553Z] 22:20:45     INFO -    0. Address: 0x0000000000000000
[task 2024-10-23T22:20:45.553Z] 22:20:45     INFO -       Size: 4
[task 2024-10-23T22:20:45.553Z] 22:20:45     INFO -  Process uptime: not available
[task 2024-10-23T22:20:45.553Z] 22:20:45     INFO -  Thread 13 StreamTrans #5 (crashed)
[task 2024-10-23T22:20:45.554Z] 22:20:45     INFO -   0  libxul.so!nsCOMPtr<nsIThread>::operator->() const [nsCOMPtr.h:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 770]
[task 2024-10-23T22:20:45.554Z] 22:20:45     INFO -      Found by: inlining
[task 2024-10-23T22:20:45.554Z] 22:20:45     INFO -   1  libxul.so!mozilla::RemoteLazyInputStreamThread::Dispatch(already_AddRefed<nsIRunnable>, unsigned int) [RemoteLazyInputStreamThread.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 161 + 0x29]
[task 2024-10-23T22:20:45.554Z] 22:20:45     INFO -       rax = 0x00007f1fc2ce4eeb    rdx = 0x0000000000000000
[task 2024-10-23T22:20:45.554Z] 22:20:45     INFO -       rcx = 0x000055eb059865d0    rbx = 0x0000000000000000
[task 2024-10-23T22:20:45.554Z] 22:20:45     INFO -       rsi = 0x00007f1fc162a8b0    rdi = 0x00007f1fc1629680
[task 2024-10-23T22:20:45.554Z] 22:20:45     INFO -       rbp = 0x00007f1faafbc9d0    rsp = 0x00007f1faafbc9a0
[task 2024-10-23T22:20:45.554Z] 22:20:45     INFO -        r8 = 0x00007f1fc162a8b0     r9 = 0x00007f1faafbe700
[task 2024-10-23T22:20:45.554Z] 22:20:45     INFO -       r10 = 0x0000000000000000    r11 = 0x0000000000000000
[task 2024-10-23T22:20:45.554Z] 22:20:45     INFO -       r12 = 0x00007f1faba8b7f0    r13 = 0x00007f1faafbcb54
[task 2024-10-23T22:20:45.554Z] 22:20:45     INFO -       r14 = 0x0000000000000000    r15 = 0x00007f1faba94fa0
[task 2024-10-23T22:20:45.554Z] 22:20:45     INFO -       rip = 0x00007f1fc912d981
[task 2024-10-23T22:20:45.555Z] 22:20:45     INFO -      Found by: given as instruction pointer in context
[task 2024-10-23T22:20:45.555Z] 22:20:45     INFO -   2  libxul.so!mozilla::RemoteLazyInputStreamChild::StreamConsumed() [RemoteLazyInputStreamChild.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 34 + 0x9]
[task 2024-10-23T22:20:45.555Z] 22:20:45     INFO -       rbx = 0x00007f1fac2c35f0    rbp = 0x00007f1faafbca40
[task 2024-10-23T22:20:45.555Z] 22:20:45     INFO -       rsp = 0x00007f1faafbc9e0    r12 = 0x00007f1faba8b7f0
[task 2024-10-23T22:20:45.555Z] 22:20:45     INFO -       r13 = 0x00007f1faafbcb54    r14 = 0x00007f1faba5ba00
[task 2024-10-23T22:20:45.555Z] 22:20:45     INFO -       r15 = 0x00007f1faba94fa0    rip = 0x00007f1fc9129926
[task 2024-10-23T22:20:45.555Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.555Z] 22:20:45     INFO -   3  libxul.so!mozilla::RemoteLazyInputStream::MarkConsumed() [RemoteLazyInputStream.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 472 + 0x7]
[task 2024-10-23T22:20:45.555Z] 22:20:45     INFO -       rbx = 0x00007f1faba8b7f0    rbp = 0x00007f1faafbca90
[task 2024-10-23T22:20:45.555Z] 22:20:45     INFO -       rsp = 0x00007f1faafbca50    r12 = 0x00007f1faba8b7f0
[task 2024-10-23T22:20:45.555Z] 22:20:45     INFO -       r13 = 0x00007f1faafbcb54    r14 = 0x00007f1faba8b790
[task 2024-10-23T22:20:45.555Z] 22:20:45     INFO -       r15 = 0x00007f1fac2c35f0    rip = 0x00007f1fc912b0f5
[task 2024-10-23T22:20:45.555Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.555Z] 22:20:45     INFO -   4  libxul.so!mozilla::RemoteLazyInputStream::Read(char*, unsigned int, unsigned int*) [RemoteLazyInputStream.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 401 + 0x7]
[task 2024-10-23T22:20:45.556Z] 22:20:45     INFO -       rbx = 0x0000000000000000    rbp = 0x00007f1faafbcb00
[task 2024-10-23T22:20:45.556Z] 22:20:45     INFO -       rsp = 0x00007f1faafbcaa0    r12 = 0x00007f1faba8b7f0
[task 2024-10-23T22:20:45.556Z] 22:20:45     INFO -       r13 = 0x00007f1faafbcb54    r14 = 0x0000000000001000
[task 2024-10-23T22:20:45.556Z] 22:20:45     INFO -       r15 = 0x00007f1faba8b790    rip = 0x00007f1fc912af0c
[task 2024-10-23T22:20:45.556Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.556Z] 22:20:45     INFO -   5  libxul.so!mozilla::dom::BlobURLInputStream::Read(char*, unsigned int, unsigned int*) [BlobURLInputStream.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 116 + 0xe]
[task 2024-10-23T22:20:45.556Z] 22:20:45     INFO -       rbx = 0x00007f1fb6fd9090    rbp = 0x00007f1faafbcb40
[task 2024-10-23T22:20:45.556Z] 22:20:45     INFO -       rsp = 0x00007f1faafbcb10    r12 = 0x00007f1faafbcb54
[task 2024-10-23T22:20:45.557Z] 22:20:45     INFO -       r13 = 0x00007f1fabaa2000    r14 = 0x00007f1fb6fd9040
[task 2024-10-23T22:20:45.557Z] 22:20:45     INFO -       r15 = 0x0000000000001000    rip = 0x00007f1fc914285b
[task 2024-10-23T22:20:45.557Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.557Z] 22:20:45     INFO -   6  libxul.so!nsBufferedInputStream::Fill() [nsBufferedStreams.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 507 + 0x12]
[task 2024-10-23T22:20:45.557Z] 22:20:45     INFO -       rbx = 0x00007f1fb4061700    rbp = 0x00007f1faafbcb80
[task 2024-10-23T22:20:45.557Z] 22:20:45     INFO -       rsp = 0x00007f1faafbcb50    r12 = 0x0000000000000000
[task 2024-10-23T22:20:45.557Z] 22:20:45     INFO -       r13 = 0x0000000000000000    r14 = 0x00007f1fb4061728
[task 2024-10-23T22:20:45.557Z] 22:20:45     INFO -       r15 = 0x00007f1fabaa2000    rip = 0x00007f1fc6029246
[task 2024-10-23T22:20:45.557Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.557Z] 22:20:45     INFO -   7  libxul.so!nsBufferedInputStream::ReadSegments(nsresult (*)(nsIInputStream*, void*, char const*, unsigned int, unsigned int, unsigned int*), void*, unsigned int, unsigned int*) [nsBufferedStreams.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 462 + 0x7]
[task 2024-10-23T22:20:45.557Z] 22:20:45     INFO -       rbx = 0x00007f1faafbcbf4    rbp = 0x00007f1faafbcbe0
[task 2024-10-23T22:20:45.557Z] 22:20:45     INFO -       rsp = 0x00007f1faafbcb90    r12 = 0x00007f1fb4061798
[task 2024-10-23T22:20:45.557Z] 22:20:45     INFO -       r13 = 0x0000000000000000    r14 = 0x00007f1fb4061700
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -       r15 = 0x0000000000000047    rip = 0x00007f1fc602908d
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -   8  libxul.so!mozilla::css::StreamLoader::OnDataAvailable(nsIRequest*, nsIInputStream*, unsigned long, unsigned int) [StreamLoader.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 225 + 0x1d]
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -       rbx = 0x00007f1faba8b6a0    rbp = 0x00007f1faafbcc00
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -       rsp = 0x00007f1faafbcbf0    r12 = 0x0000000000000000
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -       r13 = 0x0000000000000047    r14 = 0x00007f1fb40617b0
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -       r15 = 0x00007f1fac279100    rip = 0x00007f1fcad565a4
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -   9  libxul.so!nsBaseChannel::OnDataAvailable(nsIRequest*, nsIInputStream*, unsigned long, unsigned int) [nsBaseChannel.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 850 + 0xf]
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -       rbx = 0x00007f1faba8b6a0    rbp = 0x00007f1faafbcc60
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -       rsp = 0x00007f1faafbcc10    r12 = 0x0000000000000000
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -       r13 = 0x0000000000000047    r14 = 0x00007f1fb40617b0
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -       r15 = 0x00007f1fac279100    rip = 0x00007f1fc60258bc
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -  10  libxul.so!nsInputStreamPump::OnStateTransfer() [nsInputStreamPump.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 585 + 0xf]
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -       rbx = 0x00007f1faba8b6a0    rbp = 0x00007f1faafbcce0
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -       rsp = 0x00007f1faafbcc70    r12 = 0x0000000000000047
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -       r13 = 0xaaaaaaaaaaaaaaaa    r14 = 0x00007f1faba8b740
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -       r15 = 0x0000000000000000    rip = 0x00007f1fc6049599
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -  11  libxul.so!nsInputStreamPump::OnInputStreamReady(nsIAsyncInputStream*) [nsInputStreamPump.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 412 + 0x7]
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -       rbx = 0x00007f1faba8b6a0    rbp = 0x00007f1faafbcd30
[task 2024-10-23T22:20:45.558Z] 22:20:45     INFO -       rsp = 0x00007f1faafbccf0    r12 = 0x00007f1fac279a00
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       r13 = 0x00007f1faafbe300    r14 = 0x00007f1faba8b740
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       r15 = 0x00007f1fc301262c    rip = 0x00007f1fc6048ca8
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -  12  libxul.so!{virtual override thunk({offset(-24)}, nsInputStreamPump::OnInputStreamReady(nsIAsyncInputStream*))} [nsInputStreamPump.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 0 + 0xc]
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       rbx = 0x00007f1fb6fd9040    rbp = 0x00007f1faafbcd40
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       rsp = 0x00007f1faafbcd40    r12 = 0x00007f1fac279a00
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       r13 = 0x00007f1faafbe300    r14 = 0x00007f1fb6fd9090
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       r15 = 0x00007f1fb6fd90f0    rip = 0x00007f1fc6049ffd
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -  13  libxul.so!mozilla::dom::BlobURLInputStream::OnInputStreamReady(nsIAsyncInputStream*) [BlobURLInputStream.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 294 + 0x8]
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       rbx = 0x00007f1fb6fd9040    rbp = 0x00007f1faafbcd80
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       rsp = 0x00007f1faafbcd50    r12 = 0x00007f1fac279a00
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       r13 = 0x00007f1faafbe300    r14 = 0x00007f1fb6fd9090
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       r15 = 0x00007f1fb6fd90f0    rip = 0x00007f1fc9144d6c
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -  14  libxul.so!mozilla::(anonymous namespace)::InputStreamCallbackRunnable::Run() [RemoteLazyInputStream.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 58 + 0x5]
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       rbx = 0x00007f1faba8f840    rbp = 0x00007f1faafbcda0
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       rsp = 0x00007f1faafbcd90    r12 = 0x00007f1fac279a00
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       r13 = 0x00007f1faafbe300    r14 = 0xaaaaaaaaaaaaaaaa
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       r15 = 0x00007f1faafbe0d0    rip = 0x00007f1fc91388ac
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -  15  libxul.so!mozilla::TaskQueue::Runner::Run() [TaskQueue.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 257 + 0x5]
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       rbx = 0x00007f1faba94068    rbp = 0x00007f1faafbcec0
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       rsp = 0x00007f1faafbcdb0    r12 = 0x00007f1fac279a00
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       r13 = 0x00007f1faafbe300    r14 = 0xaaaaaaaaaaaaaaaa
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -       r15 = 0x00007f1faafbe0d0    rip = 0x00007f1fc5e27336
[task 2024-10-23T22:20:45.559Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -  16  libxul.so!nsThreadPool::Run() [nsThreadPool.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 456 + 0x5]
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       rbx = 0x00007f1fb6fa5a00    rbp = 0x00007f1faafbd070
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       rsp = 0x00007f1faafbced0    r12 = 0x00007f1faafbcf28
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       r13 = 0x0000000000000000    r14 = 0x00007f1faafbcfc0
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       r15 = 0x00007f1faafbcf50    rip = 0x00007f1fc5e4fa86
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -  17  libxul.so!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 1149 + 0x5]
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       rbx = 0x00007f1fabae8f40    rbp = 0x00007f1faafbd190
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       rsp = 0x00007f1faafbd080    r12 = 0x0000018b8b171008
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       r13 = 0x00007f1fabae9048    r14 = 0xaaaaaaaaaaaaaaaa
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       r15 = 0x00000000ffffffff    rip = 0x00007f1fc5e46027
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -  18  libxul.so!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 480 + 0xf]
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       rbx = 0x0000000000000000    rbp = 0x00007f1faafbd1c0
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       rsp = 0x00007f1faafbd1a0    r12 = 0x00007f1faafbd1d8
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       r13 = 0x00007f1fac2aae70    r14 = 0x00007f1faafbd270
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       r15 = 0x00007f1fabae8f40    rip = 0x00007f1fc5e4cb10
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -  19  libxul.so!mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [MessagePump.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 299 + 0x9]
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       rbx = 0x00007f1fac2aae40    rbp = 0x00007f1faafbd210
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       rsp = 0x00007f1faafbd1d0    r12 = 0x00007f1faafbd1d8
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       r13 = 0x00007f1fac2aae70    r14 = 0x00007f1faafbd270
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       r15 = 0x00007f1fabae8f40    rip = 0x00007f1fc67f7d27
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -  20  libxul.so!MessageLoop::RunHandler() [message_loop.cc:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 362]
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -      Found by: inlining
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -  21  libxul.so!MessageLoop::Run() [message_loop.cc:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 344 + 0x4]
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       rbx = 0x00007f1fabae3ee0    rbp = 0x00007f1faafbd240
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       rsp = 0x00007f1faafbd220    r12 = 0x00007f1fabae3ee8
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       r13 = 0x0000000000000002    r14 = 0x000000000000000e
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       r15 = 0x00007f1faafbd270    rip = 0x00007f1fc677aba2
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -  22  libxul.so!nsThread::ThreadFunc(void*) [nsThread.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 366 + 0x7]
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       rbx = 0x00007f1fabae3ee0    rbp = 0x00007f1faafbd470
[task 2024-10-23T22:20:45.560Z] 22:20:45     INFO -       rsp = 0x00007f1faafbd250    r12 = 0x00007f1fabae3ee8
[task 2024-10-23T22:20:45.561Z] 22:20:45     INFO -       r13 = 0x0000000000000002    r14 = 0x000000000000000e
[task 2024-10-23T22:20:45.561Z] 22:20:45     INFO -       r15 = 0x00007f1faafbd270    rip = 0x00007f1fc5e41554
[task 2024-10-23T22:20:45.561Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.561Z] 22:20:45     INFO -  23  libnspr4.so!_pt_root [ptthread.c:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 191 + 0x6]
[task 2024-10-23T22:20:45.561Z] 22:20:45     INFO -       rbx = 0x00007f1fabae2dc0    rbp = 0x00007f1faafbd4c0
[task 2024-10-23T22:20:45.561Z] 22:20:45     INFO -       rsp = 0x00007f1faafbd480    r12 = 0x00007f1faafbe030
[task 2024-10-23T22:20:45.561Z] 22:20:45     INFO -       r13 = 0x0000000000000002    r14 = 0x00007f1fb6f421c0
[task 2024-10-23T22:20:45.562Z] 22:20:45     INFO -       r15 = 0x00007f1fcf013cd0    rip = 0x00007f1fcf00c6e0
[task 2024-10-23T22:20:45.562Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.562Z] 22:20:45     INFO -  24  plugin-container!set_alt_signal_stack_and_start(PthreadCreateParams*) [pthread_create_interposer.cpp:2cea94c2cade577bfcdce696a2c0b4a1534e093e : 81 + 0x5]
[task 2024-10-23T22:20:45.563Z] 22:20:45     INFO -       rbx = 0x00007f1fabae2dc0    rbp = 0x00007f1faafbd570
[task 2024-10-23T22:20:45.563Z] 22:20:45     INFO -       rsp = 0x00007f1faafbd4d0    r12 = 0x00007f1faafbd640
[task 2024-10-23T22:20:45.563Z] 22:20:45     INFO -       r13 = 0x0000000000000000    r14 = 0x00007f1faafbd4e0
[task 2024-10-23T22:20:45.563Z] 22:20:45     INFO -       r15 = 0x00007f1fcf00c550    rip = 0x000055eb0590019d
[task 2024-10-23T22:20:45.564Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.564Z] 22:20:45     INFO -  25  libpthread.so.0 + 0x76da
[task 2024-10-23T22:20:45.564Z] 22:20:45     INFO -       rbx = 0x0000000000000000    rbp = 0x0000000000000000
[task 2024-10-23T22:20:45.564Z] 22:20:45     INFO -       rsp = 0x00007f1faafbd580    r12 = 0x00007f1faafbd640
[task 2024-10-23T22:20:45.565Z] 22:20:45     INFO -       r13 = 0x0000000000000000    r14 = 0x00007f1faba79240
[task 2024-10-23T22:20:45.565Z] 22:20:45     INFO -       r15 = 0x00007ffda49eff70    rip = 0x00007f1fc16356db
[task 2024-10-23T22:20:45.571Z] 22:20:45     INFO -      Found by: call frame info
[task 2024-10-23T22:20:45.571Z] 22:20:45     INFO -  26  libc.so.6 + 0x121a3e
[task 2024-10-23T22:20:45.571Z] 22:20:45     INFO -       rsp = 0x00007f1faafbd640    rip = 0x00007f1fc135ea3f
[task 2024-10-23T22:20:45.571Z] 22:20:45     INFO -      Found by: stack scanning
[task 2024-10-23T22:20:45.571Z] 22:20:45     INFO -  Thread 0 Web Content

Artur Iunusov

Updated

•

1 year ago

Severity: -- → S3

Priority: -- → P3

Comment hidden (Intermittent Failures Robot)

Jens Stutte [:jstutte]

Assignee

Comment 2

•

1 year ago

It could be that bug 1776209 erred in moving the RLISThreadIsInOrBeyondShutdown out of the StaticMutexAutoLock lock(gRemoteLazyThreadMutex); scope wrt to where the former check lived and we see a (rare) race here.

Keywords: regression

Regressed by: 1776209

Jens Stutte [:jstutte]

Assignee

Updated

•

1 year ago

Assignee: nobody → jstutte

Jens Stutte [:jstutte]

Assignee

Comment 3

•

1 year ago

Attached file Bug 1926722 - Avoid a potential race between RLISThreadIsInOrBeyondShutdown checks and mThread usage. r?#dom-storage-reviewers (obsolete) — Details

Jens Stutte [:jstutte]

Assignee

Comment 4

•

1 year ago

Attached file Bug 1926722 - Refactoring: Make RemoteLazyInputStreamThread's lifecycle more sound. r?#dom-storage-reviewers — Details

BugBot [:suhaib / :marco/ :calixte]

Comment 5

•

1 year ago

Set release status flags based on info from the regressing bug 1776209

status-firefox132: --- → affected

status-firefox133: --- → affected

status-firefox134: --- → affected

status-firefox-esr128: --- → affected

Phabricator Automation

Updated

•

1 year ago

Attachment #9433635 - Attachment description: Bug 1926722 - Refactoring: Add thread safety annotations to RemoteLazyInputStreamThread. r?#dom-storage-reviewers → Bug 1926722 - Refactoring: Make RemoteLazyInputStreamThread's lifecycle more sound. r?#dom-storage-reviewers

Phabricator Automation

Updated

•

1 year ago

Attachment #9433590 - Attachment is obsolete: true

Jens Stutte [:jstutte]

Assignee

Updated

•

1 year ago

Blocks: 1924819

Nika Layzell [:nika] (ni? for response)

Updated

•

1 year ago

Blocks: 1928768

Pulsebot

Comment 6

•

1 year ago

Pushed by jstutte@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/70210dd7915c Refactoring: Make RemoteLazyInputStreamThread's lifecycle more sound. r=dom-storage-reviewers,asuth,xpcom-reviewers,nika

amarc

Comment 7

•

1 year ago

Backed out for causing LeakSanitizer failures @ nsThread

[task 2024-11-05T10:39:50.039Z] 10:39:50     INFO - TEST-START | /IndexedDB/writer-starvation.htm
[task 2024-11-05T10:39:50.066Z] 10:39:50     INFO - Closing window 6fab3ee6-eb30-48b7-9e89-cbc019f325d5
[task 2024-11-05T10:39:51.599Z] 10:39:51     INFO - PID 963 | -----------------------------------------------------
[task 2024-11-05T10:39:51.599Z] 10:39:51     INFO - PID 963 | Suppressions used:
[task 2024-11-05T10:39:51.599Z] 10:39:51     INFO - PID 963 |   count      bytes template
[task 2024-11-05T10:39:51.599Z] 10:39:51     INFO - PID 963 |      31      16288 nsComponentManagerImpl
[task 2024-11-05T10:39:51.599Z] 10:39:51     INFO - PID 963 |       2        288 libfontconfig.so
[task 2024-11-05T10:39:51.599Z] 10:39:51     INFO - PID 963 |       1       9496 style::sharing::SHARING_CACHE_KEY
[task 2024-11-05T10:39:51.599Z] 10:39:51     INFO - PID 963 |       1       4104 style::bloom::BLOOM_KEY
[task 2024-11-05T10:39:51.599Z] 10:39:51     INFO - PID 963 | -----------------------------------------------------
[task 2024-11-05T10:39:51.982Z] 10:39:51     INFO - .
[task 2024-11-05T10:39:51.983Z] 10:39:51     INFO - TEST-OK | /IndexedDB/writer-starvation.htm | took 1943ms
[task 2024-11-05T10:39:51.984Z] 10:39:51     INFO - Restarting browser for new test group
[task 2024-11-05T10:39:51.986Z] 10:39:51     INFO - PID 963 | 1730803191983	Marionette	INFO	Stopped listening on port 38530
[task 2024-11-05T10:39:52.400Z] 10:39:52     INFO - PID 963 | -----------------------------------------------------
[task 2024-11-05T10:39:52.401Z] 10:39:52     INFO - PID 963 | Suppressions used:
[task 2024-11-05T10:39:52.403Z] 10:39:52     INFO - PID 963 |   count      bytes template
[task 2024-11-05T10:39:52.403Z] 10:39:52     INFO - PID 963 |      31      16288 nsComponentManagerImpl
[task 2024-11-05T10:39:52.404Z] 10:39:52     INFO - PID 963 |       2        288 libfontconfig.so
[task 2024-11-05T10:39:52.405Z] 10:39:52     INFO - PID 963 | -----------------------------------------------------
[task 2024-11-05T10:39:52.691Z] 10:39:52     INFO - PID 963 | -----------------------------------------------------
[task 2024-11-05T10:39:52.691Z] 10:39:52     INFO - PID 963 | Suppressions used:
[task 2024-11-05T10:39:52.691Z] 10:39:52     INFO - PID 963 |   count      bytes template
[task 2024-11-05T10:39:52.691Z] 10:39:52     INFO - PID 963 |      31      16288 nsComponentManagerImpl
[task 2024-11-05T10:39:52.692Z] 10:39:52     INFO - PID 963 |       2        288 libfontconfig.so
[task 2024-11-05T10:39:52.693Z] 10:39:52     INFO - PID 963 |       1       9496 style::sharing::SHARING_CACHE_KEY
[task 2024-11-05T10:39:52.694Z] 10:39:52     INFO - PID 963 |       1       4104 style::bloom::BLOOM_KEY
[task 2024-11-05T10:39:52.695Z] 10:39:52     INFO - PID 963 | -----------------------------------------------------
[task 2024-11-05T10:39:53.371Z] 10:39:53     INFO - Browser exited with return code -15
[task 2024-11-05T10:39:53.372Z] 10:39:53     INFO - ERROR | LeakSanitizer | SUMMARY: AddressSanitizer: 5832 byte(s) leaked in 14 allocation(s).
[task 2024-11-05T10:39:53.372Z] 10:39:53     INFO - LeakSanitizer | To show the addresses of leaked objects add report_objects=1 to LSAN_OPTIONS
[task 2024-11-05T10:39:53.373Z] 10:39:53     INFO - This can be done in testing/mozbase/mozrunner/mozrunner/utils.py
[task 2024-11-05T10:39:53.373Z] 10:39:53     INFO - Allowed depth was 4
[task 2024-11-05T10:39:53.376Z] 10:39:53     INFO - TEST-FAIL | LeakSanitizer | leak at mozilla::RemoteLazyInputStreamThread::GetOrCreate, mozilla::BindChildActor, mozilla::RemoteLazyInputStream::IPCRead, Read
[task 2024-11-05T10:39:53.376Z] 10:39:53     INFO - INFO | LeakSanitizer | Frame mozilla::RemoteLazyInputStreamThread::GetOrCreate matched a expected leak
[task 2024-11-05T10:39:53.376Z] 10:39:53     INFO - TEST-FAIL | LeakSanitizer | leak at MakeAndAddRef, NS_NewCancelableRunnableFunction, CallbackHolder, nsPipeInputStream::AsyncWait
[task 2024-11-05T10:39:53.376Z] 10:39:53     INFO - INFO | LeakSanitizer | Frame NS_NewCancelableRunnableFunction matched a expected leak
[task 2024-11-05T10:39:53.377Z] 10:39:53     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at nsThread::nsThread, nsThreadManager::NewNamedThread, NS_NewNamedThread, NS_NewNamedThread
[task 2024-11-05T10:39:53.377Z] 10:39:53     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at MakeUnique, nsThreadManager::NewNamedThread, NS_NewNamedThread, NS_NewNamedThread
[task 2024-11-05T10:39:53.377Z] 10:39:53     INFO - TEST-FAIL | LeakSanitizer | leak at PR_NewMonitor, ReentrantMonitor, nsPipe::nsPipe, NS_NewPipe2
[task 2024-11-05T10:39:53.377Z] 10:39:53     INFO - INFO | LeakSanitizer | Frame PR_NewMonitor matched a expected leak
[task 2024-11-05T10:39:53.377Z] 10:39:53     INFO - TEST-FAIL | LeakSanitizer | leak at nsThreadManager::NewNamedThread, NS_NewNamedThread, NS_NewNamedThread, mozilla::RemoteLazyInputStreamThread::GetOrCreate
[task 2024-11-05T10:39:53.377Z] 10:39:53     INFO - INFO | LeakSanitizer | Frame mozilla::RemoteLazyInputStreamThread::GetOrCreate matched a expected leak
[task 2024-11-05T10:39:53.377Z] 10:39:53     INFO - TEST-FAIL | LeakSanitizer | leak at Malloc, nsTArray_base, EnsureCapacity, AppendElementInternal
[task 2024-11-05T10:39:53.377Z] 10:39:53     INFO - INFO | LeakSanitizer | Frame Malloc matched a expected leak
[task 2024-11-05T10:39:53.377Z] 10:39:53     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at Alloc, nsTSubstring, nsTSubstring, nsTSubstring
[task 2024-11-05T10:39:53.378Z] 10:39:53     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at NewPage, mozilla::Queue, mozilla::detail::EventQueueInternal, mozilla::ThreadEventQueue::PutEventInternal
[task 2024-11-05T10:39:53.378Z] 10:39:53     INFO - TEST-FAIL | LeakSanitizer | leak at nsSegmentedBuffer::AppendNewSegment, nsPipe::GetWriteSegment, nsPipeOutputStream::WriteSegments, nsStreamCopierOB::DoCopy
[task 2024-11-05T10:39:53.378Z] 10:39:53     INFO - INFO | LeakSanitizer | Frame nsSegmentedBuffer::AppendNewSegment matched a expected leak
[task 2024-11-05T10:39:53.378Z] 10:39:53     INFO - TEST-FAIL | LeakSanitizer | leak at NS_NewPipe2, mozilla::RemoteLazyInputStream::EnsureAsyncRemoteStream, operator, std::_Function_handler
[task 2024-11-05T10:39:53.378Z] 10:39:53     INFO - INFO | LeakSanitizer | Frame NS_NewPipe2 matched a expected leak
[task 2024-11-05T10:39:53.378Z] 10:39:53     INFO - Closing logging queue
[task 2024-11-05T10:39:53.378Z] 10:39:53     INFO - queue closed
[task 2024-11-05T10:39:53.440Z] 10:39:53     INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2024-11-05T10:39:53.501Z] 10:39:53     INFO - LSan enabled.
[task 2024-11-05T10:39:53.502Z] 10:39:53     INFO - INFO | runtests.py | ASan running in default memory configuration
[task 2024-11-05T10:39:53.502Z] 10:39:53     INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox --marionette about:blank -profile /tmp/tmpcgxgp9lf
[task 2024-11-05T10:39:53.514Z] 10:39:53     INFO - PID 969 | ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2024-11-05T10:39:53.515Z] 10:39:53     INFO - PID 969 | 1730802177014	Marionette	INFO	Marionette enabled
[task 2024-11-05T10:39:53.516Z] 10:39:53     INFO - PID 969 | ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2024-11-05T10:39:53.516Z] 10:39:53     INFO - PID 969 | 1730802177291	Marionette	INFO	Listening on port 36409
[task 2024-11-05T10:39:53.516Z] 10:39:53     INFO - PID 969 | Crash Annotation GraphicsCriticalError: |[0][GFX1-]: Calling WaitFlushedEvent::Run: is delayed: 2683 (t=6.5719) [GFX1-]: Calling WaitFlushedEvent::Run: is delayed: 2683
[task 2024-11-05T10:39:53.516Z] 10:39:53     INFO - PID 969 | console.error: ({})
[task 2024-11-05T10:39:53.516Z] 10:39:53     INFO - PID 969 | [ERROR error_support::handling] logins-unexpected: Error parsing URL: relative URL with a cannot-be-a-base base
[task 2024-11-05T10:39:53.516Z] 10:39:53     INFO - PID 969 | [ERROR error_support::handling] suggest-unexpected: Error from Remote Settings: Remote settings error: Error parsing URL: relative URL with a cannot-be-a-base base
[task 2024-11-05T10:39:53.516Z] 10:39:53     INFO - PID 969 | console.error: URLBar - QuickSuggest.SuggestBackendRust: "Error initializing SuggestStore:"
[task 2024-11-05T10:39:53.516Z] 10:39:53     INFO - PID 969 | console.error: URLBar - QuickSuggest.SuggestBackendRust: (new Error("reason: Error from Remote Settings: Remote settings error: Error parsing URL: relative URL with a cannot-be-a-base base", "resource://gre/modules/RustSuggest.sys.mjs", 1501))
[task 2024-11-05T10:39:53.516Z] 10:39:53     INFO - Starting runner
[task 2024-11-05T10:39:54.423Z] 10:39:54     INFO - TEST-START | /content-security-policy/img-src/css-filter-blocked.tentative.html

Flags: needinfo?(jstutte)

Nika Layzell [:nika] (ni? for response)

Comment 8

•

1 year ago

I think the new leaks are somewhat to be expected. It appears that this particular test already has a number of allowed leaks, including the actual RemoteLazyInputStreamThread object:

[task 2024-11-05T10:39:53.377Z] 10:39:53     INFO - TEST-FAIL | LeakSanitizer | leak at nsThreadManager::NewNamedThread, NS_NewNamedThread, NS_NewNamedThread, mozilla::RemoteLazyInputStreamThread::GetOrCreate
[task 2024-11-05T10:39:53.377Z] 10:39:53     INFO - INFO | LeakSanitizer | Frame mozilla::RemoteLazyInputStreamThread::GetOrCreate matched a expected leak

The change here is that now we aren't nulling out the reference from the RemoteLazyInputStreamThread to the nsThread during shutdown, so after the change we now also are leaking the thread, the thread's event queue, and its name string which we weren't before:

> The thread (https://searchfox.org/mozilla-central/rev/fcf53e1685bfb990b5abc7312ac1daf617f0991f/xpcom/threads/nsThreadManager.cpp#601)
[task 2024-11-05T10:39:53.377Z] 10:39:53     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at nsThread::nsThread, nsThreadManager::NewNamedThread, NS_NewNamedThread, NS_NewNamedThread
> The event queue object (https://searchfox.org/mozilla-central/rev/fcf53e1685bfb990b5abc7312ac1daf617f0991f/xpcom/threads/nsThreadManager.cpp#599)
[task 2024-11-05T10:39:53.377Z] 10:39:53     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at MakeUnique, nsThreadManager::NewNamedThread, NS_NewNamedThread, NS_NewNamedThread
> The name string (https://searchfox.org/mozilla-central/rev/fcf53e1685bfb990b5abc7312ac1daf617f0991f/xpcom/threads/nsThread.cpp#667)
[task 2024-11-05T10:39:53.377Z] 10:39:53     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at Alloc, nsTSubstring, nsTSubstring, nsTSubstring
> Event queue page
[task 2024-11-05T10:39:53.378Z] 10:39:53     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at NewPage, mozilla::Queue, mozilla::detail::EventQueueInternal, mozilla::ThreadEventQueue::PutEventInternal

I think the root leak is probably that the async wait callback was perhaps dispatched to the thread after shutdown or similar and thus leaked:

[task 2024-11-05T10:39:53.376Z] 10:39:53     INFO - TEST-FAIL | LeakSanitizer | leak at MakeAndAddRef, NS_NewCancelableRunnableFunction, CallbackHolder, nsPipeInputStream::AsyncWait

TL;DR this isn't a new leak, and while we should probably fix the leak eventually, I don't think this should block landing the patch, and we can instead add a new exemption for now.

Andrew McCreight [:mccr8]

Comment 9

•

1 year ago

FYI, the ignore list for this WPT directory is here.

Jens Stutte [:jstutte]

Assignee

Updated

•

1 year ago

Comment 10

•

1 year ago

Pushed by jstutte@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/b4b92028f41c Refactoring: Make RemoteLazyInputStreamThread's lifecycle more sound. r=dom-storage-reviewers,asuth,xpcom-reviewers,nika

Jens Stutte [:jstutte]

Assignee

Comment 11

•

1 year ago

While this specific test is known to not be a real problem, the ignore list is getting a bit long and might hide other problems with tests in that directory. Probably looking into bug 1929555 soonish would be a good measure of hygiene, as the WPT sync bot touched this file very recently, too.

Flags: needinfo?(jstutte)

Serban Stanca [:SerbanS]

Comment 12

•

1 year ago

bugherder

https://hg.mozilla.org/mozilla-central/rev/b4b92028f41c

Status: NEW → RESOLVED

Closed: 1 year ago

status-firefox134: affected → fixed

Resolution: --- → FIXED

Target Milestone: --- → 134 Branch

Donal Meehan [:dmeehan]

Updated

•

1 year ago

status-firefox132: affected → wontfix

status-firefox133: affected → wontfix

status-firefox-esr115: --- → wontfix

status-firefox-esr128: affected → wontfix

Bug 1926722 - Avoid a potential race between RLISThreadIsInOrBeyondShutdown checks and mThread usage. r?#dom-storage-reviewers 1 year ago Jens Stutte [:jstutte] 48 bytes, text/x-phabricator-request		Details \| Review
Bug 1926722 - Refactoring: Make RemoteLazyInputStreamThread's lifecycle more sound. r?#dom-storage-reviewers 1 year ago Jens Stutte [:jstutte] 48 bytes, text/x-phabricator-request		Details \| Review