Closed Bug 1706548 Opened 3 years ago Closed 3 years ago

Intermittent PROCESS-CRASH | Main app process exited normally | application crashed [@ mozilla::detail::ConditionVariableImpl::wait_for(mozilla::detail::MutexImpl&, mozilla::BaseTimeDuration<mozilla::TimeDurationValueCalculator> const&)]

Categories

(Core :: DOM: Service Workers, defect)

defect

Tracking

()

RESOLVED INVALID

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: crash, intermittent-failure)

Crash Data

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


[task 2021-04-21T05:14:59.086Z] 05:14:59     INFO - TEST-OK | dom/tests/mochitest/fetch/test_fetch_cors_sw_empty_reroute.html | took 2313ms
[task 2021-04-21T05:14:59.097Z] 05:14:59     INFO - TEST-START | dom/tests/mochitest/fetch/test_fetch_cors_sw_reroute.html
[task 2021-04-21T05:14:59.305Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.305Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.305Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.306Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.315Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.321Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.328Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.329Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.369Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.369Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.405Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.405Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.405Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.405Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.405Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.405Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.405Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.405Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.405Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.406Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.420Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.420Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.435Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.435Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.435Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.435Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.436Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.436Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.440Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.441Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.441Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.441Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.441Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.441Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.441Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.441Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.441Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.445Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.446Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.447Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.447Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.484Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.496Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.519Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.553Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.555Z] 05:14:59     INFO -  *** error running SJS at /opt/worker/tasks/task_161898163929366/build/tests/mochitest/tests/dom/security/test/cors/file_CrossSiteXHR_server.sjs: [Exception... "Component is not available"  nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)"  location: "JS frame :: /opt/worker/tasks/task_161898163929366/build/tests/bin/components/httpd.js :: getHeaderValues :: line 5194"  data: no] on line 2325
[task 2021-04-21T05:14:59.604Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.638Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.684Z] 05:14:59     INFO -  *** error running SJS at /opt/worker/tasks/task_161898163929366/build/tests/mochitest/tests/dom/security/test/cors/file_CrossSiteXHR_server.sjs: [Exception... "Component is not available"  nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)"  location: "JS frame :: /opt/worker/tasks/task_161898163929366/build/tests/bin/components/httpd.js :: getHeaderValues :: line 5194"  data: no] on line 2325
[task 2021-04-21T05:14:59.684Z] 05:14:59     INFO -  *** error running SJS at /opt/worker/tasks/task_161898163929366/build/tests/mochitest/tests/dom/security/test/cors/file_CrossSiteXHR_server.sjs: [Exception... "Component is not available"  nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)"  location: "JS frame :: /opt/worker/tasks/task_161898163929366/build/tests/bin/components/httpd.js :: getHeaderValues :: line 5194"  data: no] on line 2325
[task 2021-04-21T05:14:59.736Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.737Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.737Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.738Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.773Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.773Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.774Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.774Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.774Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.774Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.775Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.788Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.788Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.788Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.788Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.789Z] 05:14:59     INFO - GECKO(1720) | JavaScript error: , line 0: NetworkError: FetchEvent.respondWith() Promise rejected
[task 2021-04-21T05:14:59.835Z] 05:14:59     INFO - GECKO(1720) | OK
[task 2021-04-21T05:15:00.179Z] 05:15:00     INFO -  *** error running SJS at /opt/worker/tasks/task_161898163929366/build/tests/mochitest/tests/dom/security/test/cors/file_CrossSiteXHR_server.sjs: [Exception... "Component is not available"  nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)"  location: "JS frame :: /opt/worker/tasks/task_161898163929366/build/tests/bin/components/httpd.js :: getHeaderValues :: line 5194"  data: no] on line 2325
[task 2021-04-21T05:15:00.664Z] 05:15:00     INFO -  *** error running SJS at /opt/worker/tasks/task_161898163929366/build/tests/mochitest/tests/dom/security/test/cors/file_CrossSiteXHR_server.sjs: [Exception... "Component is not available"  nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)"  location: "JS frame :: /opt/worker/tasks/task_161898163929366/build/tests/bin/components/httpd.js :: getHeaderValues :: line 5194"  data: no] on line 2325
[task 2021-04-21T05:15:01.202Z] 05:15:01     INFO -  *** error running SJS at /opt/worker/tasks/task_161898163929366/build/tests/mochitest/tests/dom/security/test/cors/file_CrossSiteXHR_server.sjs: [Exception... "Component is not available"  nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)"  location: "JS frame :: /opt/worker/tasks/task_161898163929366/build/tests/bin/components/httpd.js :: getHeaderValues :: line 5194"  data: no] on line 2325
[task 2021-04-21T05:15:01.269Z] 05:15:01     INFO - GECKO(1720) | ###!!! [Parent][MessageChannel] Error: (msgtype=0x390144,name=PContent::Msg_AsyncMessage) Channel error: cannot send/recv
[task 2021-04-21T05:15:01.269Z] 05:15:01    ERROR - GECKO(1720) | A content process crashed and MOZ_CRASHREPORTER_SHUTDOWN is set, shutting down
[task 2021-04-21T05:15:01.396Z] 05:15:01     INFO - GECKO(1720) | 1618982101384	Marionette	TRACE	Received observer notification xpcom-will-shutdown
[task 2021-04-21T05:15:01.396Z] 05:15:01     INFO - GECKO(1720) | 1618982101384	Marionette	INFO	Stopped listening on port 2828
[task 2021-04-21T05:15:01.396Z] 05:15:01     INFO - GECKO(1720) | 1618982101384	Marionette	DEBUG	Marionette stopped listening
[task 2021-04-21T05:15:01.592Z] 05:15:01     INFO - GECKO(1720) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-04-21T05:15:01.721Z] 05:15:01     INFO - TEST-INFO | Main app process: exit 0
[task 2021-04-21T05:15:01.722Z] 05:15:01     INFO - runtests.py | Application ran for: 0:00:16.236555
[task 2021-04-21T05:15:01.722Z] 05:15:01     INFO - zombiecheck | Reading PID log: /var/folders/77/gc0tf_p909xc_ggph8xg_zp4000014/T/tmppn5Npopidlog
[task 2021-04-21T05:15:01.722Z] 05:15:01     INFO - ==> process 1720 launched child process 1721
[task 2021-04-21T05:15:01.722Z] 05:15:01     INFO - ==> process 1720 launched child process 1722
[task 2021-04-21T05:15:01.722Z] 05:15:01     INFO - ==> process 1720 launched child process 1723
[task 2021-04-21T05:15:01.723Z] 05:15:01     INFO - ==> process 1720 launched child process 1724
[task 2021-04-21T05:15:01.723Z] 05:15:01     INFO - ==> process 1720 launched child process 1725
[task 2021-04-21T05:15:01.723Z] 05:15:01     INFO - ==> process 1720 launched child process 1726
[task 2021-04-21T05:15:01.728Z] 05:15:01     INFO - ==> process 1720 launched child process 1727
[task 2021-04-21T05:15:01.728Z] 05:15:01     INFO - zombiecheck | Checking for orphan process with PID: 1721
[task 2021-04-21T05:15:01.728Z] 05:15:01     INFO - zombiecheck | Checking for orphan process with PID: 1722
[task 2021-04-21T05:15:01.728Z] 05:15:01     INFO - zombiecheck | Checking for orphan process with PID: 1723
[task 2021-04-21T05:15:01.728Z] 05:15:01     INFO - zombiecheck | Checking for orphan process with PID: 1724
[task 2021-04-21T05:15:01.728Z] 05:15:01     INFO - zombiecheck | Checking for orphan process with PID: 1725
[task 2021-04-21T05:15:01.728Z] 05:15:01     INFO - zombiecheck | Checking for orphan process with PID: 1726
[task 2021-04-21T05:15:01.728Z] 05:15:01     INFO - zombiecheck | Checking for orphan process with PID: 1727
[task 2021-04-21T05:15:01.728Z] 05:15:01     INFO - mozcrash Downloading symbols from: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Oj63r2i9TrOeW3aBajGjgg/artifacts/public/build/target.crashreporter-symbols.zip
[task 2021-04-21T05:15:05.875Z] 05:15:05     INFO - mozcrash Copy/paste: /opt/worker/tasks/task_161898163929366/fetches/minidump_stackwalk/minidump_stackwalk /var/folders/77/gc0tf_p909xc_ggph8xg_zp4000014/T/tmpR29vY6.mozrunner/minidumps/7BE7605C-F798-4B33-8A17-5BA9F0D8FB93.dmp /var/folders/77/gc0tf_p909xc_ggph8xg_zp4000014/T/tmp18nGW9
[task 2021-04-21T05:15:10.686Z] 05:15:10     INFO - mozcrash Saved minidump as /opt/worker/tasks/task_161898163929366/build/blobber_upload_dir/7BE7605C-F798-4B33-8A17-5BA9F0D8FB93.dmp
[task 2021-04-21T05:15:10.686Z] 05:15:10     INFO - mozcrash Saved app info as /opt/worker/tasks/task_161898163929366/build/blobber_upload_dir/7BE7605C-F798-4B33-8A17-5BA9F0D8FB93.extra
[task 2021-04-21T05:15:10.756Z] 05:15:10     INFO - PROCESS-CRASH | Main app process exited normally | application crashed [@ mozilla::detail::ConditionVariableImpl::wait_for(mozilla::detail::MutexImpl&, mozilla::BaseTimeDuration<mozilla::TimeDurationValueCalculator> const&)]
[task 2021-04-21T05:15:10.756Z] 05:15:10     INFO - Mozilla crash reason: MOZ_RELEASE_ASSERT(r == 0)
[task 2021-04-21T05:15:10.756Z] 05:15:10     INFO - Crash dump filename: /var/folders/77/gc0tf_p909xc_ggph8xg_zp4000014/T/tmpR29vY6.mozrunner/minidumps/7BE7605C-F798-4B33-8A17-5BA9F0D8FB93.dmp
[task 2021-04-21T05:15:10.756Z] 05:15:10     INFO - Operating system: Mac OS X
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO -                   10.15.7 19H524
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO - CPU: amd64
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO -      family 6 model 158 stepping 10
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO -      12 CPUs
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO - 
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO - GPU: UNKNOWN
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO - 
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO - Crash reason:  EXC_BAD_ACCESS / KERN_INVALID_ADDRESS
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO - Crash address: 0x0
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO - Process uptime: 15 seconds
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO - 
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO - Thread 6 (crashed)
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO -  0  libmozglue.dylib!mozilla::detail::ConditionVariableImpl::wait_for(mozilla::detail::MutexImpl&, mozilla::BaseTimeDuration<mozilla::TimeDurationValueCalculator> const&) [ConditionVariable_posix.cpp:3df0f92987d1bba705cbdf8c5fe366b9d3071bc4 : 115 + 0x11]
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO -     rax = 0x0000000103e27bf9   rdx = 0x000000010404d5b0
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO -     rcx = 0x0000000103e2a360   rbx = 0x000000010404d570
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO -     rsi = 0x0000090000000900   rdi = 0x000000010404d590
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO -     rbp = 0x000070000edfaec0   rsp = 0x000070000edfae80
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO -      r8 = 0x0000000000007066    r9 = 0xffffffff00000000
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO -     r10 = 0x000000010404d5a8   r11 = 0x000000010404d5f4
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO -     r12 = 0x7fffffffffffffff   r13 = 0x000000010404d610
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO -     r14 = 0x000000010404d590   r15 = 0x000000010404d5d8
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO -     rip = 0x0000000103dc5b92
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO -     Found by: given as instruction pointer in context
[task 2021-04-21T05:15:10.757Z] 05:15:10     INFO -  1  XUL!mozilla::BackgroundHangManager::MonitorThread(void*) [BackgroundHangMonitor.cpp:3df0f92987d1bba705cbdf8c5fe366b9d3071bc4 : 79 + 0x82]
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -     rbp = 0x000070000edfaf60   rsp = 0x000070000edfaed0
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -     rip = 0x000000010734919b
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -  2  libnss3.dylib!_pt_root [ptthread.c:3df0f92987d1bba705cbdf8c5fe366b9d3071bc4 : 201 + 0x8]
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -     rbp = 0x000070000edfafb0   rsp = 0x000070000edfaf70
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -     rip = 0x0000000103be85ca
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -  3  libsystem_pthread.dylib!_pthread_start + 0x94
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -     rbp = 0x000070000edfafd0   rsp = 0x000070000edfafc0
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -     rip = 0x00007fff68086109
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -  4  libsystem_pthread.dylib!thread_start + 0xf
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -     rbp = 0x000070000edfaff0   rsp = 0x000070000edfafe0
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -     rip = 0x00007fff68081b8b
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -  5  libnss3.dylib + 0xd6490
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -     rsp = 0x000070000edfb098   rip = 0x0000000103be8490
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -     Found by: stack scanning
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO - 
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO - Thread 0
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -  0  libsystem_kernel.dylib!__psynch_mutexwait + 0xa
[task 2021-04-21T05:15:10.758Z] 05:15:10     INFO -     rax = 0x000000000200012d   rdx = 0x0000000000000900
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     rcx = 0x00007ffeec0f3bd8   rbx = 0x0000000000000a02
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     rsi = 0x0000000000000a02   rdi = 0x000000010404d590
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     rbp = 0x00007ffeec0f3c10   rsp = 0x00007ffeec0f3bd8
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -      r8 = 0x00000000000020a0    r9 = 0x000000010404d5a8
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     r10 = 0x0000000000007066   r11 = 0x0000000000000202
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     r12 = 0x000000010404d5a8   r13 = 0x000000010404d5b0
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     r14 = 0x000000010404d590   r15 = 0x0000000000000900
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     rip = 0x00007fff67fc5062
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     Found by: given as instruction pointer in context
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -  1  libsystem_pthread.dylib!_pthread_mutex_firstfit_lock_slow + 0xde
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     rbp = 0x00007ffeec0f3c40   rsp = 0x00007ffeec0f3c20
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     rip = 0x00007fff68081937
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -  2  libmozglue.dylib!mozilla::detail::MutexImpl::lock() [Mutex_posix.cpp:3df0f92987d1bba705cbdf8c5fe366b9d3071bc4 : 118 + 0xb]
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     rbp = 0x00007ffeec0f3c60   rsp = 0x00007ffeec0f3c50
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     rip = 0x0000000103dc5e0b
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -  3  XUL!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:3df0f92987d1bba705cbdf8c5fe366b9d3071bc4 : 1159 + 0x1be]
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     rbp = 0x00007ffeec0f3ee0   rsp = 0x00007ffeec0f3c70
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     rip = 0x00000001063999b8
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.759Z] 05:15:10     INFO -  4  XUL!mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) [MessagePump.cpp:3df0f92987d1bba705cbdf8c5fe366b9d3071bc4 : 109 + 0x2b]
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     rbp = 0x00007ffeec0f3f40   rsp = 0x00007ffeec0f3ef0
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     rip = 0x00000001065d032e
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -  5  XUL!MessageLoop::Run() [message_loop.cc:3df0f92987d1bba705cbdf8c5fe366b9d3071bc4 : 310 + 0xc]
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     rbp = 0x00007ffeec0f3f80   rsp = 0x00007ffeec0f3f50
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     rip = 0x000000010659d1f0
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -  6  XUL!nsBaseAppShell::Run() [nsBaseAppShell.cpp:3df0f92987d1bba705cbdf8c5fe366b9d3071bc4 : 137 + 0xd]
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     rbp = 0x00007ffeec0f3fa0   rsp = 0x00007ffeec0f3f90
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     rip = 0x0000000106f291a9
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -  7  XUL!nsAppShell::Run() [nsAppShell.mm:3df0f92987d1bba705cbdf8c5fe366b9d3071bc4 : 731 + 0x8]
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     rbp = 0x00007ffeec0f3fd0   rsp = 0x00007ffeec0f3fb0
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     rip = 0x0000000106f451d9
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -  8  XUL!XRE_RunAppShell() [nsEmbedFunctions.cpp:3df0f92987d1bba705cbdf8c5fe366b9d3071bc4 : 906 + 0x6]
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     rbp = 0x00007ffeec0f4000   rsp = 0x00007ffeec0f3fe0
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     rip = 0x00000001073dbe41
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -  9  XUL!MessageLoop::Run() [message_loop.cc:3df0f92987d1bba705cbdf8c5fe366b9d3071bc4 : 310 + 0xc]
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     rbp = 0x00007ffeec0f4040   rsp = 0x00007ffeec0f4010
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     rip = 0x000000010659d1f0
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.760Z] 05:15:10     INFO - 10  XUL!XRE_InitChildProcess(int, char**, XREChildData const*) [nsEmbedFunctions.cpp:3df0f92987d1bba705cbdf8c5fe366b9d3071bc4 : 738 + 0x8]
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO -     rbp = 0x00007ffeec0f4320   rsp = 0x00007ffeec0f4050
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO -     rip = 0x00000001073dba16
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO - 11  plugin-container!main [MozillaRuntimeMain.cpp:3df0f92987d1bba705cbdf8c5fe366b9d3071bc4 : 72 + 0x25]
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO -     rbp = 0x00007ffeec0f4360   rsp = 0x00007ffeec0f4330
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO -     rip = 0x0000000103b0af4b
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO - 12  libdyld.dylib!start + 0x1
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO -     rbp = 0x00007ffeec0f4378   rsp = 0x00007ffeec0f4370
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO -     rip = 0x00007fff67e81cc9
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO -     Found by: previous frame's frame pointer
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO - 13  libdyld.dylib!start + 0x1
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO -     rbp = 0x00007ffeec0f4378   rsp = 0x00007ffeec0f4378
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO -     rip = 0x00007fff67e81cc9
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO -     Found by: stack scanning
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO - 
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO - Thread 1
[task 2021-04-21T05:15:10.761Z] 05:15:10     INFO -  0  libsystem_kernel.dylib!mach_msg_trap + 0xa```

The first error seems to be earlier (relation unclear, of course):

[task 2021-04-21T05:14:54.577Z] 05:14:54     INFO - TEST-START | dom/tests/mochitest/fetch/test_fetch_cors.html
[task 2021-04-21T05:14:55.006Z] 05:14:55     INFO -  *** error running SJS at /opt/worker/tasks/task_161898163929366/build/tests/mochitest/tests/dom/security/test/cors/file_CrossSiteXHR_server.sjs: [Exception... "Component is not available"  nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)"  location: "JS frame :: /opt/worker/tasks/task_161898163929366/build/tests/bin/components/httpd.js :: getHeaderValues :: line 5194"  data: no] on line 2325
[task 2021-04-21T05:14:55.079Z] 05:14:55     INFO -  *** error running SJS at /opt/worker/tasks/task_161898163929366/build/tests/mochitest/tests/dom/security/test/cors/file_CrossSiteXHR_server.sjs: [Exception... "Component is not available"  nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)"  location: "JS frame :: /opt/worker/tasks/task_161898163929366/build/tests/bin/components/httpd.js :: getHeaderValues :: line 5194"  data: no] on line 2325
[task 2021-04-21T05:14:55.079Z] 05:14:55     INFO -  *** error running SJS at /opt/worker/tasks/task_161898163929366/build/tests/mochitest/tests/dom/security/test/cors/file_CrossSiteXHR_server.sjs: [Exception... "Component is not available"  nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)"  location: "JS frame :: /opt/worker/tasks/task_161898163929366/build/tests/bin/components/httpd.js :: getHeaderValues :: line 5194"  data: no] on line 2325

Looking at the translation of the error message vs. the place we generate it here I see a semantical mismatch between the two.

file_CrossSiteXHR_server.sjs contains many getHeader("X") but no line 2325, so it is unclear, which header is missing here (and what this might mean to this specific bug).

(In reply to Jens Stutte [:jstutte] from comment #1)

Looking at the translation of the error message vs. the place we generate it here I see a semantical mismatch between the two.

According to the original error definition I'd say, the translation "Component is not available" is questionable. (The widespread use of such an unspecific "Something not available" might be questionable, too, but a misleading message is probably worse than a generic one.)

See Also: → 1706559
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INVALID
You need to log in before you can comment on or make changes to this bug.