Open Bug 1456626 Opened 7 years ago Updated 2 years ago

nsJARChannel::asyncOpen can still block

Categories

(Core :: Networking: JAR, enhancement, P3)

Product:
Core
Component:
Networking: JAR
Type:
enhancement

Tracking

()

Project Flags:
Performance Impact medium

People

(Reporter: florian, Unassigned)

References

(Blocks 1 open bug)

Details

(Keywords: perf, perf:responsiveness, perf:startup, Whiteboard: [necko-triaged])

Attachments

(1 file)

Bug 1456626, use dedicated background thread for nsJARChannel::asyncOpen to avoid blocking
47 bytes, text/x-phabricator-request
Details | Review
See this startup profile https://perfht.ml/2vHLNRA where we are blocked for 18ms. It seems asyncOpen can block on creating new threads.
Keywords: perf
Priority: -- → P3
See Also: → 1391356
Whiteboard: [qf] → [qf][necko-triaged]
Whiteboard: [qf][necko-triaged] → [qf:p1][qf:f64][necko-triaged]
Whiteboard: [qf:p1][qf:f64][necko-triaged] → [qf:p1:f64][necko-triaged]
Whiteboard: [qf:p1:f64][necko-triaged] → [qf:p3:responsiveness][necko-triaged]
Whiteboard: [qf:p3:responsiveness][necko-triaged] → [qf:p3:responsiveness][necko-triaged][fxperf]

Tentatively marking P2 given this affects startup.

Whiteboard: [qf:p3:responsiveness][necko-triaged][fxperf] → [qf:p3:responsiveness][necko-triaged][fxperf:p2]

I wonder if this could be improved by moving this off to the background thread pool.

Blocks: convert-one-off-thread-to-pool
Assignee: nobody → emalysz
Status: NEW → ASSIGNED
Pushed by cbrindusan@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/85d3ad4be91a use dedicated background thread for nsJARChannel::asyncOpen to avoid blocking r=valentin,michal,froydnj
Backout by csabou@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/9ab38af0a849 Backed out changeset 85d3ad4be91a for causing leaks. CLOSED TREE

Push with failures: https://treeherder.mozilla.org/#/jobs?repo=autoland&resultStatus=testfailed%2Cbusted%2Cexception&revision=85d3ad4be91a6dba0944b09acaf8c9639e57b475&searchStr=web&selectedTaskRun=SEAAWp9bQJGIWXLgYnGPYw-0

Failure log: https://treeherder.mozilla.org/logviewer.html#?job_id=301741739&repo=autoland

Backout link: https://hg.mozilla.org/integration/autoland/rev/9ab38af0a849

[task 2020-05-11T16:08:28.309Z] 16:08:28     INFO - TEST-START | /referrer-policy/4K-1/gen/top.http-rp/unsafe-url/script-tag.http.html
[task 2020-05-11T16:08:28.325Z] 16:08:28     INFO - Closing window 31
[task 2020-05-11T16:08:28.482Z] 16:08:28     INFO - PID 29175 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-05-11T16:08:28.806Z] 16:08:28     INFO - PROCESS LEAKS None
[task 2020-05-11T16:08:28.806Z] 16:08:28     INFO - ERROR | LeakSanitizer | SUMMARY: AddressSanitizer: 42264 byte(s) leaked in 255 allocation(s).
[task 2020-05-11T16:08:28.806Z] 16:08:28     INFO - LeakSanitizer | To show the addresses of leaked objects add report_objects=1 to LSAN_OPTIONS
[task 2020-05-11T16:08:28.807Z] 16:08:28     INFO - This can be done in testing/mozbase/mozrunner/mozrunner/utils.py
[task 2020-05-11T16:08:28.807Z] 16:08:28     INFO - Allowed depth was 4
[task 2020-05-11T16:08:28.807Z] 16:08:28     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at Alloc, nsTSubstring, nsTSubstring, nsTSubstring
[task 2020-05-11T16:08:28.807Z] 16:08:28     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at nsJARURI::Mutator::SetSpecBaseCharset, std::function, operator, NS_MutateURI::Apply
[task 2020-05-11T16:08:28.807Z] 16:08:28     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at Alloc, nsTSubstring, nsTSubstring, mozilla::net::nsStandardURL::BuildNormalizedSpec
[task 2020-05-11T16:08:28.807Z] 16:08:28     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at PLDHashTable::Add, mozilla::net::nsLoadGroup::AddRequest, nsJARChannel::OpenLocalFile, nsJARChannel::AsyncOpen
[task 2020-05-11T16:08:28.807Z] 16:08:28     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at mozilla::net::nsStandardURL::TemplatedMutator, mozilla::net::nsStandardURL::TemplatedMutator, std::function, operator
[task 2020-05-11T16:08:28.808Z] 16:08:28     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at NS_NewLoadGroup, mozilla::dom::FetchRequest, SandboxFetch, SandboxFetchPromise
[task 2020-05-11T16:08:28.808Z] 16:08:28     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at NS_NewNativeLocalFile, net_GetFileFromURLSpec, mozilla::net::nsStandardURL::GetFile, nsJARChannel::LookupFile
[task 2020-05-11T16:08:28.808Z] 16:08:28     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at mozilla::net::CookieJarSettings::Create, mozilla::dom::FetchRequest, SandboxFetch, SandboxFetchPromise
[task 2020-05-11T16:08:28.808Z] 16:08:28     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at nsLocalFile::Clone, mozilla::net::nsStandardURL::GetFile, nsJARChannel::LookupFile, nsJARChannel::AsyncOpen
[task 2020-05-11T16:08:28.808Z] 16:08:28     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at mozilla::net::nsIOService::NewChannelFromURIWithProxyFlagsInternal, mozilla::net::nsIOService::NewChannelFromURIWithClientAndController, NS_NewChannelInternal, NS_NewChannel
[task 2020-05-11T16:08:28.808Z] 16:08:28     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at nsJARProtocolHandler::NewChannel, mozilla::net::nsIOService::NewChannelFromURIWithProxyFlagsInternal, NS_NewChannelInternal, mozilla::net::SubstitutingProtocolHandler::NewChannel
[task 2020-05-11T16:08:28.811Z] 16:08:28     INFO - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at mozilla::net::SubstitutingURL::Mutator::Create, mozilla::net::nsStandardURL::TemplatedMutator, std::function, operator
[task 2020-05-11T16:08:29.684Z] 16:08:29     INFO - PID 29175 | -----------------------------------------------------
[task 2020-05-11T16:08:29.685Z] 16:08:29     INFO - PID 29175 | Suppressions used:
[task 2020-05-11T16:08:29.685Z] 16:08:29     INFO - PID 29175 |   count      bytes template
[task 2020-05-11T16:08:29.685Z] 16:08:29     INFO - PID 29175 |      24        744 nsComponentManagerImpl
[task 2020-05-11T16:08:29.687Z] 16:08:29     INFO - PID 29175 |     633      18287 libfontconfig.so
[task 2020-05-11T16:08:29.688Z] 16:08:29     INFO - PID 29175 | -----------------------------------------------------
[task 2020-05-11T16:08:30.941Z] 16:08:30     INFO - ............
[task 2020-05-11T16:08:30.941Z] 16:08:30     INFO - TEST-OK | /referrer-policy/4K-1/gen/top.http-rp/unsafe-url/script-tag.http.html | took 2632ms
Flags: needinfo?(emalysz)
Pushed by btara@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/7cdd5e64521e use dedicated background thread for nsJARChannel::asyncOpen to avoid blocking r=valentin,michal,froydnj

Backed out changeset 7cdd5e64521e (bug 1456626) for build crash on nsJARChannel::OpenLocalFile

Push with failures: https://treeherder.mozilla.org/#/jobs?repo=autoland&selectedTaskRun=JMNwFgnGTOOLWCOGk5IR6Q-0&searchStr=os%2Cx%2C10.14%2Cshippable%2Copt%2Cprofile-guided%2Coptimization%2Cbuilds%2Cgenerate-profile-macosx64-shippable%2Fopt%2Cbpgo%28run%29&fromchange=1785974f69f21f44e54a644440d439925d1f8fe3&tochange=095d17ab204cf3c9bdffcf5f3fb7748ab08bd497

Backout link: https://hg.mozilla.org/integration/autoland/rev/095d17ab204cf3c9bdffcf5f3fb7748ab08bd497

Failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=303311979&repo=autoland&lineNumber=222

task 2020-05-22T01:44:41.700Z] ./mach python build/pgo/profileserver.py --binary $MOZ_FETCHES_DIR/*.app/Contents/MacOS/firefox
[task 2020-05-22T01:44:41.700Z] + ./mach python build/pgo/profileserver.py --binary '/Users/task_1590106472/fetches/Firefox Nightly.app/Contents/MacOS/firefox'
[task 2020-05-22T01:44:49.140Z] mozcrash INFO | Copy/paste: /Users/task_1590106472/fetches/minidump_stackwalk/minidump_stackwalk /tmp/tmpdlpY_A/minidumps/B6C32F1C-D3D4-4E30-8B49-DECD27D08D6C.dmp /Users/task_1590106472/fetches
[task 2020-05-22T01:44:58.184Z] mozcrash INFO | Saved minidump as ../../artifacts/B6C32F1C-D3D4-4E30-8B49-DECD27D08D6C.dmp
[task 2020-05-22T01:44:58.184Z] mozcrash INFO | Saved app info as ../../artifacts/B6C32F1C-D3D4-4E30-8B49-DECD27D08D6C.extra
[task 2020-05-22T01:44:58.185Z] Firefox exited with code 1 during profile initialization
[task 2020-05-22T01:44:58.185Z] Firefox output (../../artifacts/profile-run-1.log):
[task 2020-05-22T01:44:58.185Z] _RegisterApplication(), FAILED TO establish the default connection to the WindowServer, _CGSDefaultConnection() is NULL.
[task 2020-05-22T01:44:58.185Z] 
[task 2020-05-22T01:44:58.185Z] ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-05-22T01:44:58.185Z] 
[task 2020-05-22T01:44:58.185Z] 
[task 2020-05-22T01:44:58.185Z] ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-05-22T01:44:58.185Z] 
[task 2020-05-22T01:44:58.185Z] 
[task 2020-05-22T01:44:58.185Z] ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-05-22T01:44:58.185Z] 
[task 2020-05-22T01:44:58.185Z] 
[task 2020-05-22T01:44:58.185Z] ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-05-22T01:44:58.185Z] 
[task 2020-05-22T01:44:58.185Z] LLVM Profile Error: Failed to write file "default_2548_random_15823542666410206714_0.profraw": Operation not permitted
[task 2020-05-22T01:44:58.185Z] LLVM Profile Error: Failed to write file "default_2548_random_17658368279926514297_0.profraw": Operation not permitted
[task 2020-05-22T01:44:58.185Z] LLVM Profile Error: Failed to write file "default_2548_random_16714855670707467815_0.profraw": Operation not permitted
[task 2020-05-22T01:44:58.185Z] LLVM Profile Error: Failed to write file "default_2548_random_3399697745366209065_0.profraw": Operation not permitted
[task 2020-05-22T01:44:58.185Z] LLVM Profile Error: Failed to write file "default_2548_random_14778015700672522025_0.profraw": Operation not permitted
[task 2020-05-22T01:44:58.185Z] [2020-05-22T01:44:48Z ERROR xulstore::persist] removeDocument error: unavailable
[task 2020-05-22T01:44:58.185Z] 
[task 2020-05-22T01:44:58.185Z] mozcrash checking /tmp/tmpdlpY_A/minidumps for minidumps...
[task 2020-05-22T01:44:58.185Z] PROCESS-CRASH | Profile initialization | application crashed [@ nsJARChannel::OpenLocalFile()]
[task 2020-05-22T01:44:58.185Z] Crash dump filename: /tmp/tmpdlpY_A/minidumps/B6C32F1C-D3D4-4E30-8B49-DECD27D08D6C.dmp
[task 2020-05-22T01:44:58.185Z] Operating system: Mac OS X
[task 2020-05-22T01:44:58.185Z]                   10.14.5 18F132
[task 2020-05-22T01:44:58.185Z] CPU: amd64
[task 2020-05-22T01:44:58.185Z]      family 6 model 69 stepping 1
[task 2020-05-22T01:44:58.185Z]      4 CPUs
[task 2020-05-22T01:44:58.185Z] 
[task 2020-05-22T01:44:58.185Z] GPU: UNKNOWN
[task 2020-05-22T01:44:58.185Z] 
[task 2020-05-22T01:44:58.185Z] Crash reason:  EXC_BAD_ACCESS / KERN_INVALID_ADDRESS
[task 2020-05-22T01:44:58.185Z] Crash address: 0x20
[task 2020-05-22T01:44:58.185Z] Process uptime: 6 seconds
[task 2020-05-22T01:44:58.185Z] 
[task 2020-05-22T01:44:58.185Z] Thread 0 (crashed)
[task 2020-05-22T01:44:58.185Z]  0  XUL!nsJARChannel::OpenLocalFile() [nsJARChannel.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 389 + 0xe]
[task 2020-05-22T01:44:58.185Z]     rax = 0x0000000000000000   rdx = 0x00007ffeeb33a660
[task 2020-05-22T01:44:58.185Z]     rcx = 0x0000000000000000   rbx = 0x0000000107668d00
[task 2020-05-22T01:44:58.185Z]     rsi = 0x000000010f829d90   rdi = 0x00000001231bcc30
[task 2020-05-22T01:44:58.185Z]     rbp = 0x00007ffeeb33a940   rsp = 0x00007ffeeb33a770
[task 2020-05-22T01:44:58.185Z]      r8 = 0x000000000d7bc026    r9 = 0x0000000107668d70
[task 2020-05-22T01:44:58.185Z]     r10 = 0xb353fd16f25b7bda   r11 = 0x000000009f09cc84
[task 2020-05-22T01:44:58.185Z]     r12 = 0x0000000107668d00   r13 = 0x00000001231bcc10
[task 2020-05-22T01:44:58.185Z]     r14 = 0x0000000107ec19b0   r15 = 0x00000001231bcc10
[task 2020-05-22T01:44:58.185Z]     rip = 0x0000000108b51b24
[task 2020-05-22T01:44:58.185Z]     Found by: given as instruction pointer in context
[task 2020-05-22T01:44:58.186Z]  1  XUL!nsJARChannel::AsyncOpen(nsIStreamListener*) [nsJARChannel.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 895 + 0xf]
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33a9a0   rsp = 0x00007ffeeb33a950
[task 2020-05-22T01:44:58.186Z]     rip = 0x0000000108b53c9a
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z]  2  XUL!mozilla::dom::FetchDriver::HttpFetch(nsTSubstring<char> const&) [FetchDriver.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 830 + 0x2e]
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33ab80   rsp = 0x00007ffeeb33a9b0
[task 2020-05-22T01:44:58.186Z]     rip = 0x000000010a8a6e7e
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z]  3  XUL!mozilla::dom::FetchDriver::Fetch(mozilla::dom::AbortSignalImpl*, mozilla::dom::FetchDriverObserver*) [FetchDriver.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 472 + 0x10]
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33abc0   rsp = 0x00007ffeeb33ab90
[task 2020-05-22T01:44:58.186Z]     rip = 0x000000010a8a377b
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z]  4  XUL!mozilla::dom::FetchRequest(nsIGlobalObject*, mozilla::dom::RequestOrUSVString const&, mozilla::dom::RequestInit const&, mozilla::dom::CallerType, mozilla::ErrorResult&) [Fetch.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 519 + 0x12]
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33aee0   rsp = 0x00007ffeeb33abd0
[task 2020-05-22T01:44:58.186Z]     rip = 0x000000010a8a322a
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z]  5  XUL!SandboxFetchPromise(JSContext*, unsigned int, JS::Value*) [Sandbox.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 335 + 0x2e8]
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33b100   rsp = 0x00007ffeeb33aef0
[task 2020-05-22T01:44:58.186Z]     rip = 0x0000000108b15ed7
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z]  6  XUL!js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [Interpreter.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 585 + 0x44]
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33b1c0   rsp = 0x00007ffeeb33b110
[task 2020-05-22T01:44:58.186Z]     rip = 0x000000010d30ca83
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z]  7  XUL!Interpret(JSContext*, js::RunState&) [Interpreter.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 652 + 0xd]
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33b600   rsp = 0x00007ffeeb33b1d0
[task 2020-05-22T01:44:58.186Z]     rip = 0x000000010d303cd0
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z]  8  XUL!js::RunScript(JSContext*, js::RunState&) [Interpreter.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 465 + 0x12]
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33b650   rsp = 0x00007ffeeb33b610
[task 2020-05-22T01:44:58.186Z]     rip = 0x000000010d2f7f84
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z]  9  XUL!js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [Interpreter.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 620 + 0x8]
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33b710   rsp = 0x00007ffeeb33b660
[task 2020-05-22T01:44:58.186Z]     rip = 0x000000010d30cdd5
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z] 10  XUL!<name omitted> [Interpreter.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 665 + 0xb]
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33b730   rsp = 0x00007ffeeb33b720
[task 2020-05-22T01:44:58.186Z]     rip = 0x000000010d30d823
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z] 11  XUL!js::jit::InvokeFunction(JSContext*, JS::Handle<JSObject*>, bool, bool, unsigned int, JS::Value*, JS::MutableHandle<JS::Value>) [VMFunctions.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 269 + 0x24]
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33b8a0   rsp = 0x00007ffeeb33b740
[task 2020-05-22T01:44:58.186Z]     rip = 0x000000010db2b41a
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z] 12  XUL!js::jit::InvokeFromInterpreterStub(JSContext*, js::jit::InterpreterStubExitFrameLayout*) [VMFunctions.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 289 + 0x10]
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33b900   rsp = 0x00007ffeeb33b8b0
[task 2020-05-22T01:44:58.186Z]     rip = 0x000000010db2b816
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z] 13  0x32ac2094aed4
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33b960   rsp = 0x00007ffeeb33b910
[task 2020-05-22T01:44:58.186Z]     rip = 0x000032ac2094aed4
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z] 14  0x131d458a0
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33ba08   rsp = 0x00007ffeeb33b970
[task 2020-05-22T01:44:58.186Z]     rip = 0x0000000131d458a0
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z] 15  0x32ac2094a315
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33ba90   rsp = 0x00007ffeeb33ba18
[task 2020-05-22T01:44:58.186Z]     rip = 0x000032ac2094a315
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z] 16  0x1316cd4a8
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33bb18   rsp = 0x00007ffeeb33baa0
[task 2020-05-22T01:44:58.186Z]     rip = 0x00000001316cd4a8
[task 2020-05-22T01:44:58.186Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.186Z] 17  0x32ac20965c6e
[task 2020-05-22T01:44:58.186Z]     rbp = 0x00007ffeeb33bb60   rsp = 0x00007ffeeb33bb28
[task 2020-05-22T01:44:58.187Z]     rip = 0x000032ac20965c6e
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 18  0x122695b88
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33bc28   rsp = 0x00007ffeeb33bb70
[task 2020-05-22T01:44:58.187Z]     rip = 0x0000000122695b88
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 19  0x32ac2094a49f
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33bc90   rsp = 0x00007ffeeb33bc38
[task 2020-05-22T01:44:58.187Z]     rip = 0x000032ac2094a49f
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 20  XUL!js::jit::MaybeEnterJit(JSContext*, js::RunState&) [Jit.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 196 + 0x15b]
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33be30   rsp = 0x00007ffeeb33bca0
[task 2020-05-22T01:44:58.187Z]     rip = 0x000000010dd59e75
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 21  XUL!Interpret(JSContext*, js::RunState&) [Interpreter.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 3358 + 0x5]
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33c270   rsp = 0x00007ffeeb33be40
[task 2020-05-22T01:44:58.187Z]     rip = 0x000000010d304065
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 22  XUL!js::RunScript(JSContext*, js::RunState&) [Interpreter.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 465 + 0x12]
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33c2c0   rsp = 0x00007ffeeb33c280
[task 2020-05-22T01:44:58.187Z]     rip = 0x000000010d2f7f84
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 23  XUL!js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [Interpreter.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 620 + 0x8]
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33c380   rsp = 0x00007ffeeb33c2d0
[task 2020-05-22T01:44:58.187Z]     rip = 0x000000010d30cdd5
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 24  XUL!<name omitted> [Interpreter.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 665 + 0xb]
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33c3a0   rsp = 0x00007ffeeb33c390
[task 2020-05-22T01:44:58.187Z]     rip = 0x000000010d30d823
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 25  XUL!js::jit::InvokeFunction(JSContext*, JS::Handle<JSObject*>, bool, bool, unsigned int, JS::Value*, JS::MutableHandle<JS::Value>) [VMFunctions.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 269 + 0x24]
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33c510   rsp = 0x00007ffeeb33c3b0
[task 2020-05-22T01:44:58.187Z]     rip = 0x000000010db2b41a
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 26  XUL!js::jit::InvokeFromInterpreterStub(JSContext*, js::jit::InterpreterStubExitFrameLayout*) [VMFunctions.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 289 + 0x10]
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33c570   rsp = 0x00007ffeeb33c520
[task 2020-05-22T01:44:58.187Z]     rip = 0x000000010db2b816
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 27  0x32ac2094aed4
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33c5e8   rsp = 0x00007ffeeb33c580
[task 2020-05-22T01:44:58.187Z]     rip = 0x000032ac2094aed4
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 28  0x12c4055e0
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33c688   rsp = 0x00007ffeeb33c5f8
[task 2020-05-22T01:44:58.187Z]     rip = 0x000000012c4055e0
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 29  0x32ac20955703
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33c738   rsp = 0x00007ffeeb33c698
[task 2020-05-22T01:44:58.187Z]     rip = 0x000032ac20955703
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 30  0x32ac2094a49f
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33c7a0   rsp = 0x00007ffeeb33c748
[task 2020-05-22T01:44:58.187Z]     rip = 0x000032ac2094a49f
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 31  XUL!js::jit::MaybeEnterJit(JSContext*, js::RunState&) [Jit.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 196 + 0x15b]
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33c940   rsp = 0x00007ffeeb33c7b0
[task 2020-05-22T01:44:58.187Z]     rip = 0x000000010dd59e75
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 32  XUL!js::RunScript(JSContext*, js::RunState&) [Interpreter.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 450 + 0xb]
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33c990   rsp = 0x00007ffeeb33c950
[task 2020-05-22T01:44:58.187Z]     rip = 0x000000010d2f7ecc
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 33  XUL!js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [Interpreter.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 620 + 0x8]
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33ca50   rsp = 0x00007ffeeb33c9a0
[task 2020-05-22T01:44:58.187Z]     rip = 0x000000010d30cdd5
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 34  XUL!<name omitted> [Interpreter.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 665 + 0xb]
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33ca70   rsp = 0x00007ffeeb33ca60
[task 2020-05-22T01:44:58.187Z]     rip = 0x000000010d30d823
[task 2020-05-22T01:44:58.187Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.187Z] 35  XUL!js::CallSelfHostedFunction(JSContext*, JS::Handle<js::PropertyName*>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>) [SelfHosting.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 1675 + 0x17]
[task 2020-05-22T01:44:58.187Z]     rbp = 0x00007ffeeb33cad0   rsp = 0x00007ffeeb33ca80
[task 2020-05-22T01:44:58.188Z]     rip = 0x000000010d613c04
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 36  XUL!js::AsyncGeneratorResume(JSContext*, JS::Handle<js::AsyncGeneratorObject*>, js::CompletionKind, JS::Handle<JS::Value>) [AsyncIteration.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 393 + 0x11]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33cb80   rsp = 0x00007ffeeb33cae0
[task 2020-05-22T01:44:58.188Z]     rip = 0x000000010d42504e
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 37  XUL!PromiseReactionJob(JSContext*, unsigned int, JS::Value*) [Promise.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 1826 + 0x5f]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33cca0   rsp = 0x00007ffeeb33cb90
[task 2020-05-22T01:44:58.188Z]     rip = 0x000000010d4d71e3
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 38  XUL!js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [Interpreter.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 585 + 0x44]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33cd60   rsp = 0x00007ffeeb33ccb0
[task 2020-05-22T01:44:58.188Z]     rip = 0x000000010d30ca83
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 39  XUL!<name omitted> [Interpreter.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 665 + 0xb]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33cd80   rsp = 0x00007ffeeb33cd70
[task 2020-05-22T01:44:58.188Z]     rip = 0x000000010d30d823
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 40  XUL!JS::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::HandleValueArray const&, JS::MutableHandle<JS::Value>) [jsapi.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 2840 + 0x26]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33ce70   rsp = 0x00007ffeeb33cd90
[task 2020-05-22T01:44:58.188Z]     rip = 0x000000010d3afdc8
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 41  XUL!mozilla::dom::PromiseJobCallback::Call(mozilla::dom::BindingCallContext&, JS::Handle<JS::Value>, mozilla::ErrorResult&) [PromiseBinding.cpp: : 28 + 0xb]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33cef0   rsp = 0x00007ffeeb33ce80
[task 2020-05-22T01:44:58.188Z]     rip = 0x0000000109c3be04
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 42  XUL!mozilla::PromiseJobRunnable::Run(mozilla::AutoSlowOperation&) [CycleCollectedJSContext.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 209 + 0x70]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33d120   rsp = 0x00007ffeeb33cf00
[task 2020-05-22T01:44:58.188Z]     rip = 0x0000000107c964ed
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 43  XUL!mozilla::CycleCollectedJSContext::PerformMicroTaskCheckPoint(bool) [CycleCollectedJSContext.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 640 + 0x24]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33d1f0   rsp = 0x00007ffeeb33d130
[task 2020-05-22T01:44:58.188Z]     rip = 0x0000000107c803d6
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 44  XUL!mozilla::CycleCollectedJSContext::AfterProcessTask(unsigned int) [CycleCollectedJSContext.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 459 + 0x7]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33d210   rsp = 0x00007ffeeb33d200
[task 2020-05-22T01:44:58.188Z]     rip = 0x0000000107c80ce7
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 45  XUL!XPCJSContext::AfterProcessTask(unsigned int) [XPCJSContext.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 1343 + 0xb]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33d230   rsp = 0x00007ffeeb33d220
[task 2020-05-22T01:44:58.188Z]     rip = 0x0000000108b03626
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 46  XUL!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 1239 + 0x31]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33d740   rsp = 0x00007ffeeb33d240
[task 2020-05-22T01:44:58.188Z]     rip = 0x0000000107d86e7f
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 47  XUL!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 501 + 0x26]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33d780   rsp = 0x00007ffeeb33d750
[task 2020-05-22T01:44:58.188Z]     rip = 0x0000000107d8b1c6
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 48  XUL!nsThread::Shutdown() [nsThread.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 891 + 0x82]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33d7d0   rsp = 0x00007ffeeb33d790
[task 2020-05-22T01:44:58.188Z]     rip = 0x0000000107d85ac7
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 49  XUL!nsThreadPool::Shutdown() [nsThreadPool.cpp:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 399 + 0x1e]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33d820   rsp = 0x00007ffeeb33d7e0
[task 2020-05-22T01:44:58.188Z]     rip = 0x0000000107d8e141
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 50  XUL!mozilla::MozPromise<CopyableTArray<bool>, bool, false>::ThenValue<nsThreadManager::Shutdown()::$_4, nsThreadManager::Shutdown()::$_5>::DoResolveOrRejectInternal(mozilla::MozPromise<CopyableTArray<bool>, bool, false>::ResolveOrRejectValue&) [MozPromise.h:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 771 + 0x60]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33d860   rsp = 0x00007ffeeb33d830
[task 2020-05-22T01:44:58.188Z]     rip = 0x0000000107d9d516
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
[task 2020-05-22T01:44:58.188Z] 51  XUL!mozilla::MozPromise<CopyableTArray<bool>, bool, false>::ThenValueBase::ResolveOrRejectRunnable::Run() [MozPromise.h:7cdd5e64521e1f67aa626464142a80eaaa6a4f29 : 410 + 0x22]
[task 2020-05-22T01:44:58.188Z]     rbp = 0x00007ffeeb33d890   rsp = 0x00007ffeeb33d870
[task 2020-05-22T01:44:58.188Z]     rip = 0x0000000107d9accb
[task 2020-05-22T01:44:58.188Z]     Found by: previous frame's frame pointer
...
Assignee: emalysz → nobody
Status: ASSIGNED → NEW
Flags: needinfo?(emalysz)
Performance Impact: --- → P3
Keywords: perf:responsiveness
Whiteboard: [qf:p3:responsiveness][necko-triaged][fxperf:p2] → [necko-triaged][fxperf:p2]
Performance Impact: P3 → P2
Keywords: perf:startup
Whiteboard: [necko-triaged][fxperf:p2] → [necko-triaged]
Severity: normal → S3
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: