1713481 - Intermittent /service-workers/service-worker/ServiceWorkerGlobalScope/update.https.html | Update a registration on ServiceWorkerGlobalScope - assert_equals: events seen by the worker expected "updatefound,activate,fetch,message,updatefound,fetch" but got

Status: RESOLVED INCOMPLETE

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

Description

[Treeherder Bug Filer]

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

---

[task 2021-05-29T22:31:50.854Z] 22:31:50     INFO - TEST-START | /service-workers/service-worker/ServiceWorkerGlobalScope/update.https.html
[task 2021-05-29T22:31:50.859Z] 22:31:50     INFO - Closing window 04c97c95-2fb3-49f7-ab0f-7a6f7389c3d7
[task 2021-05-29T22:31:50.957Z] 22:31:50     INFO - PID 31659 | [Child 32650, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.374Z] 22:31:51     INFO - PID 31659 | [Parent 31659, Socket Thread] WARNING: Unexpected input in Cache-control header value: file /builds/worker/checkouts/gecko/netwerk/protocol/http/CacheControlParser.cpp:66
[task 2021-05-29T22:31:51.378Z] 22:31:51     INFO - PID 31659 | [Parent 31659, Main Thread] WARNING: '!window', file /builds/worker/checkouts/gecko/dom/cache/CacheStorage.cpp:562
[task 2021-05-29T22:31:51.404Z] 22:31:51     INFO - PID 31659 | [Child 32650, Main Thread] WARNING: '!window', file /builds/worker/checkouts/gecko/dom/cache/CacheStorage.cpp:562
[task 2021-05-29T22:31:51.408Z] 22:31:51     INFO - PID 31659 | JavaScript error: https://web-platform.test:8443/service-workers/service-worker/ServiceWorkerGlobalScope/resources/update-worker.py, line 23: InvalidStateError: An attempt was made to use an object that is not, or is no longer, usable
[task 2021-05-29T22:31:51.463Z] 22:31:51     INFO - PID 31659 | [Child 32650, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.499Z] 22:31:51     INFO - PID 31659 | [Child 32650, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.510Z] 22:31:51     INFO - PID 31659 | [Child 32650, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.555Z] 22:31:51     INFO - PID 8425 | [Child 878, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.574Z] 22:31:51     INFO - PID 8425 | [Child 878, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.592Z] 22:31:51     INFO - PID 8425 | [Child 878, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.608Z] 22:31:51     INFO - PID 8425 | [Child 878, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.624Z] 22:31:51     INFO - PID 8425 | [Child 878, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.642Z] 22:31:51     INFO - PID 8425 | [Child 878, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.659Z] 22:31:51     INFO - PID 8425 | [Child 878, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.666Z] 22:31:51     INFO - PID 8425 | [Child 878, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.674Z] 22:31:51     INFO - PID 8425 | [Child 878, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.692Z] 22:31:51     INFO - PID 8425 | [Child 878, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.709Z] 22:31:51     INFO - PID 8425 | [Child 878, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.724Z] 22:31:51     INFO - PID 8425 | [Child 878, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.741Z] 22:31:51     INFO - PID 8425 | [Child 878, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.759Z] 22:31:51     INFO - PID 8425 | [Child 878, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:51.774Z] 22:31:51     INFO - PID 8425 | [Child 878, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-29T22:31:52.437Z] 22:31:52     INFO - PID 31659 | [Parent 31659, Main Thread] WARNING: '!window', file /builds/worker/checkouts/gecko/dom/cache/CacheStorage.cpp:562
[task 2021-05-29T22:31:52.441Z] 22:31:52     INFO - PID 31659 | [Parent 31659, Main Thread] WARNING: Unexpected input in Cache-control header value: file /builds/worker/checkouts/gecko/netwerk/protocol/http/CacheControlParser.cpp:66
[task 2021-05-29T22:31:52.443Z] 22:31:52     INFO - PID 31659 | [Parent 31659, Socket Thread] WARNING: Unexpected input in Cache-control header value: file /builds/worker/checkouts/gecko/netwerk/protocol/http/CacheControlParser.cpp:66
[task 2021-05-29T22:31:52.445Z] 22:31:52     INFO - PID 31659 | [Parent 31659, Main Thread] WARNING: '!window', file /builds/worker/checkouts/gecko/dom/cache/CacheStorage.cpp:562
[task 2021-05-29T22:31:52.474Z] 22:31:52     INFO - PID 31659 | [Child 31788, Main Thread] WARNING: '!window', file /builds/worker/checkouts/gecko/dom/cache/CacheStorage.cpp:562
[task 2021-05-29T22:31:52.494Z] 22:31:52     INFO - PID 31659 | [Parent 31659, Main Thread] WARNING: '!window', file /builds/worker/checkouts/gecko/dom/cache/CacheStorage.cpp:562
[task 2021-05-29T22:31:52.500Z] 22:31:52     INFO - PID 31659 | [Parent 31659, Main Thread] WARNING: Unexpected input in Cache-control header value: file /builds/worker/checkouts/gecko/netwerk/protocol/http/CacheControlParser.cpp:66
[task 2021-05-29T22:31:52.502Z] 22:31:52     INFO - PID 31659 | [Parent 31659, Socket Thread] WARNING: Unexpected input in Cache-control header value: file /builds/worker/checkouts/gecko/netwerk/protocol/http/CacheControlParser.cpp:66
[task 2021-05-29T22:31:52.506Z] 22:31:52     INFO - PID 31659 | [Parent 31659, Main Thread] WARNING: '!window', file /builds/worker/checkouts/gecko/dom/cache/CacheStorage.cpp:562
[task 2021-05-29T22:31:52.526Z] 22:31:52     INFO - PID 31659 | [Child 31788, Main Thread] WARNING: '!window', file /builds/worker/checkouts/gecko/dom/cache/CacheStorage.cpp:562
[task 2021-05-29T22:31:52.533Z] 22:31:52     INFO - PID 31659 | [Parent 31659, Main Thread] WARNING: '!window', file /builds/worker/checkouts/gecko/dom/cache/CacheStorage.cpp:562
[task 2021-05-29T22:31:52.534Z] 22:31:52     INFO - PID 31659 | [Parent 31659, Main Thread] WARNING: 'mProgress != Progress::ShutdownCompleted', file /builds/worker/checkouts/gecko/dom/serviceworkers/ServiceWorkerShutdownState.cpp:57
[task 2021-05-29T22:31:52.542Z] 22:31:52     INFO - PID 31659 | [Parent 31659, IPDL Background] WARNING: 'aResult.IsReject()', file /builds/worker/checkouts/gecko/dom/workers/remoteworkers/RemoteWorkerController.cpp:470
[task 2021-05-29T22:31:52.542Z] 22:31:52     INFO - PID 31659 | [Parent 31659, IPDL Background] WARNING: 'aResult.IsReject()', file /builds/worker/checkouts/gecko/dom/workers/remoteworkers/RemoteWorkerControllerParent.cpp:124
[task 2021-05-29T22:31:52.543Z] 22:31:52     INFO - PID 31659 | JavaScript error: , line 0: InvalidStateError: An attempt was made to use an object that is not, or is no longer, usable
[task 2021-05-29T22:31:52.563Z] 22:31:52     INFO - PID 31659 | [Child 31788, DOM Worker] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3357
[task 2021-05-29T22:31:52.645Z] 22:31:52     INFO - 
[task 2021-05-29T22:31:52.646Z] 22:31:52     INFO - TEST-UNEXPECTED-FAIL | /service-workers/service-worker/ServiceWorkerGlobalScope/update.https.html | Update a registration on ServiceWorkerGlobalScope - assert_equals: events seen by the worker expected "updatefound,activate,fetch,message,updatefound,fetch" but got "updatefound,activate,fetch,message,updatefound,updatefound,fetch"
[task 2021-05-29T22:31:52.647Z] 22:31:52     INFO - @https://web-platform.test:8443/service-workers/service-worker/ServiceWorkerGlobalScope/update.https.html:39:24
[task 2021-05-29T22:31:52.648Z] 22:31:52     INFO - TEST-OK | /service-workers/service-worker/ServiceWorkerGlobalScope/update.https.html | took 1791ms

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• linux1804-64: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1713481&startday=2021-05-24&endday=2021-05-30&tree=all

Comment 2

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

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

Comment 3

[Iulian Moraru]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=344233378&repo=try&lineNumber=7370

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1

Platform and build breakdown:

• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1713481&startday=2021-06-28&endday=2021-07-04&tree=all

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• android-em-7-0-x86_64-qr: 1
  • debug: 1

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

Comment 6

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

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

Comment 7

[Sandor Molnar[:smolnar]]

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

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1

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

Comment 9

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3

Platform and build breakdown:

• linux1804-64-asan-qr: 1
  • opt: 1
• linux1804-64-qr: 2
  • debug: 2

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

Comment 10

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform and build breakdown:

• linux1804-64-qr: 2
  • debug: 2

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

Comment 11

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3

Platform and build breakdown:

• linux1804-64-qr: 3
  • debug: 3

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

Comment 12

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1713481&startday=2021-09-27&endday=2021-10-03&tree=all

Comment 13

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

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

Comment 14

[Cristina Cozmuta (:CrissCozmuta)]

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

Comment 15

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1

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

Comment 16

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

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

Comment 17

[Treeherder Bug Filer]

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=385677047&repo=mozilla-esr91

Comment 18

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-esr91: 1

Platform and build breakdown:

• windows10-64-2004-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1713481&startday=2022-07-25&endday=2022-07-31&tree=all

Comment 19

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

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