1675708 - Intermittent [TV] FATAL ERROR: AsyncShutdown timeout in profile-before-change Conditions: [{"name":"ServiceWorkerRegistrar: Flushing data","state":{"shuttingDown":false,"saveDataRunnableDispatched":false},"filename":"/builds/worker/checkouts/gecko/d

Status: RESOLVED INCOMPLETE

(Core :: DOM: Service Workers, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: smolnar [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=320919658&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/XXyH0mK7Sx-IfBaCObkbPw/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/XXyH0mK7Sx-IfBaCObkbPw/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

---

"INFO - ###!!! [Parent][MessageChannel] Error: (msgtype=0xAD0001,name=PVsync::Msg_Notify) Channel error: cannot send/recv
[task 2020-11-06T05:04:33.284Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.314Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.314Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.314Z] 05:04:33     INFO - ###!!! [Parent][MessageChannel] Error: (msgtype=0xAD0001,name=PVsync::Msg_Notify) Channel error: cannot send/recv
[task 2020-11-06T05:04:33.314Z] 05:04:33     INFO - [Parent 2908, Main Thread] ###!!! ABORT: file /builds/worker/checkouts/gecko/dom/serviceworkers/ServiceWorkerRegistrar.cpp:1116
[task 2020-11-06T05:04:33.315Z] 05:04:33     INFO - [Parent 2908, Main Thread] ###!!! ABORT: file /builds/worker/checkouts/gecko/dom/serviceworkers/ServiceWorkerRegistrar.cpp:1116
[task 2020-11-06T05:04:33.315Z] 05:04:33     INFO - FATAL ERROR: AsyncShutdown timeout in profile-before-change Conditions: [{"name":"ServiceWorkerRegistrar: Flushing data","state":{"shuttingDown":false,"saveDataRunnableDispatched":false},"filename":"/builds/worker/checkouts/gecko/dom/serviceworkers/ServiceWorkerRegistrar.cpp","lineNumber":1116,"stack":"ServiceWorkerRegistrar: Flushing data"},{"name":"ShieldRecipeClient: Cleaning up","state":"(none)","filename":"resource://normandy/lib/CleanupManager.jsm","lineNumber":43,"stack":["resource://normandy/lib/CleanupManager.jsm:cleanup:43","resource://normandy/Normandy.jsm:uninit:158","resource:///modules/BrowserGlue.jsm:_onQuitApplicationGranted:2168","resource:///modules/BrowserGlue.jsm:BG_observe:1063","resource://reftest/reftest.jsm:onStopped:863","resource://reftest/httpd.jsm:_notifyStopped:829","resource://reftest/httpd.jsm:run:497"]}] At least one completion condition failed to complete within a reasonable amount of time. Causing a crash to ensure that we do not leave the user with an unresponsive process draining resources.
[task 2020-11-06T05:04:33.315Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.316Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.316Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.316Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.316Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.316Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.317Z] 05:04:33     INFO - ###!!! [Parent][MessageChannel] Error: (msgtype=0xAD0001,name=PVsync::Msg_Notify) Channel error: cannot send/recv
[task 2020-11-06T05:04:33.317Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.317Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.317Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.317Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.318Z] 05:04:33     INFO - ###!!! [Parent][MessageChannel] Error: (msgtype=0xAD0001,name=PVsync::Msg_Notify) Channel error: cannot send/recv
...
INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.591Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.592Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.594Z] 05:04:33     INFO - ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2020-11-06T05:04:33.786Z] 05:04:33    ERROR - TEST-UNEXPECTED-FAIL | editor/libeditor/crashtests/1578916.html (finished) | application terminated with exit code 1
[task 2020-11-06T05:04:33.786Z] 05:04:33     INFO - REFTEST INFO | Downloading symbols from: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/EM-UeNbbRpeoBItGrPdoQQ/artifacts/public/build/target.crashreporter-symbols.zip
[task 2020-11-06T05:04:37.461Z] 05:04:37     INFO - REFTEST INFO | Copy/paste: /Users/cltbld/tasks/task_1604629510/fetches/minidump_stackwalk/minidump_stackwalk /var/folders/mp/g89019sn7r3_bk6cfl_vpqxh000017/T/tmpwh56wT.mozrunner/minidumps/0B9F4029-24AC-4F67-A134-EBF9C15D1FBC.dmp /var/folders/mp/g89019sn7r3_bk6cfl_vpqxh000017/T/tmpmRM8su
[task 2020-11-06T05:04:41.827Z] 05:04:41     INFO - REFTEST INFO | Saved minidump as /Users/cltbld/tasks/task_1604629510/build/blobber_upload_dir/0B9F4029-24AC-4F67-A134-EBF9C15D1FBC.dmp
[task 2020-11-06T05:04:41.827Z] 05:04:41     INFO - REFTEST INFO | Saved app info as /Users/cltbld/tasks/task_1604629510/build/blobber_upload_dir/0B9F4029-24AC-4F67-A134-EBF9C15D1FBC.extra
[task 2020-11-06T05:04:41.950Z] 05:04:41     INFO - REFTEST PROCESS-CRASH | editor/libeditor/crashtests/1578916.html (finished) | application crashed [@ nsDebugImpl::Abort(char const*, int)]
[task 2020-11-06T05:04:41.950Z] 05:04:41     INFO - Mozilla crash reason: MOZ_CRASH()
[task 2020-11-06T05:04:41.950Z] 05:04:41     INFO - Crash dump filename: /var/folders/mp/g89019sn7r3_bk6cfl_vpqxh000017/T/tmpwh56wT.mozrunner/minidumps/0B9F4029-24AC-4F67-A134-EBF9C15D1FBC.dmp"```

Comment 1

[Intermittent Failures Robot]

1 failures in 4128 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform breakdown:

• macosx1014-64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1675708&startday=2020-11-02&endday=2020-11-08&tree=all

Comment 2

[Intermittent Failures Robot]

1 failures in 4040 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform breakdown:

• macosx1014-64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1675708&startday=2020-11-09&endday=2020-11-15&tree=all

Comment 3

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Comment 4

[Alexandru Michis [:malexandru]]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=331702905&repo=autoland&lineNumber=20380

Comment 5

[Jens Stutte [:jstutte]]

(In reply to Alexandru Michis [:malexandru] from comment #4)

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=331702905&repo=autoland&lineNumber=20380

This crash reads now:

[task 2021-03-02T07:32:33.005Z] 07:32:33     INFO - [Parent 1417, Main Thread] ###!!! ABORT: file /builds/worker/checkouts/gecko/dom/serviceworkers/ServiceWorkerRegistrar.cpp:1116
[task 2021-03-02T07:32:33.005Z] 07:32:33     INFO - FATAL ERROR: AsyncShutdown timeout in profile-before-change Conditions: [{"name":"ServiceWorkerRegistrar: Flushing data","state":{"saveDataRunnableDispatched":false,"shuttingDown":false},"filename":"/builds/worker/checkouts/gecko/dom/serviceworkers/ServiceWorkerRegistrar.cpp","lineNumber":1116,"stack":"ServiceWorkerRegistrar: Flushing data"},{"name":"ShieldRecipeClient: Cleaning up","state":"(none)","filename":"resource://normandy/lib/CleanupManager.jsm","lineNumber":43,"stack":["resource://normandy/lib/CleanupManager.jsm:cleanup:43","resource://normandy/Normandy.jsm:uninit:162","resource:///modules/BrowserGlue.jsm:_onQuitApplicationGranted:1991","resource:///modules/BrowserGlue.jsm:BG_observe:1031","resource://reftest/reftest.jsm:onStopped:883","resource://reftest/httpd.jsm:_notifyStopped:829","resource://reftest/httpd.jsm:run:497"]}] At least one completion condition failed to complete within a reasonable amount of time. Causing a crash to ensure that we do not leave the user with an unresponsive process draining resources.

It is more verbose, not sure if this tells us more now.

Comment 6

[Intermittent Failures Robot]

1 failures in 3683 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• macosx1014-64-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1675708&startday=2021-03-01&endday=2021-03-07&tree=all

Comment 7

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Comment 8

[Intermittent Failures Robot]

1 failures in 3125 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• macosx1014-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1675708&startday=2021-03-29&endday=2021-04-04&tree=all

Comment 9

[Cristian Brindusan [:cbrindusan]]

New occurrence:
https://treeherder.mozilla.org/logviewer?job_id=342789749&repo=autoland&lineNumber=41614

Comment 10

[Intermittent Failures Robot]

4 failures in 2888 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 4

Platform and build breakdown:

• macosx1015-64-qr: 4
  • opt: 2
  • debug: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1675708&startday=2021-06-14&endday=2021-06-20&tree=all

Comment 11

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Comment 12

[Atila Butkovits]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=348353368&repo=autoland&lineNumber=43284

Comment 13

[Intermittent Failures Robot]

2 failures in 3025 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 2

Platform and build breakdown:

• macosx1015-64-qr: 2
  • opt: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1675708&startday=2021-08-09&endday=2021-08-15&tree=all

Comment 14

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Comment 15

[Cristian Tuns]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=355237104&repo=autoland&lineNumber=39898

Comment 16

[Cosmin Sabou [:CosminS]]

Bug 1736506 was filed for the above TVs, closing this one.