1772462 - Intermittent /html/semantics/scripting-1/the-script-element/moving-between-documents/ordering/delay-load-event-1.html | Script elements (parser-blocking) does not delay the load event in the new Document after move - assert_less_than: Load event should no

Status: RESOLVED INCOMPLETE

(Core :: DOM: Core & HTML, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2022-06-03T01:36:50.808Z] 01:36:50     INFO - TEST-START | /html/semantics/scripting-1/the-script-element/moving-between-documents/ordering/delay-load-event-1.html
[task 2022-06-03T01:36:50.821Z] 01:36:50     INFO - Closing window f1b1f022-4f10-4816-adf8-7d6fe1c6e0bd
[task 2022-06-03T01:36:50.855Z] 01:36:50     INFO - PID 19345 | [Child 20997, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:499
[task 2022-06-03T01:36:50.969Z] 01:36:50     INFO - PID 19345 | [Child 20997, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:499
[task 2022-06-03T01:36:53.969Z] 01:36:53     INFO - PID 19345 | JavaScript error: http://web-platform.test:8000/html/semantics/scripting-1/the-script-element/resources/throw.js?pipe=trickle(d2), line 1: SyntaxError: Document.querySelector: ':::not-going-to-be-valid' is not a valid selector
[task 2022-06-03T01:36:54.422Z] 01:36:54     INFO - PID 19345 | JavaScript error: http://web-platform.test:8000/html/semantics/scripting-1/the-script-element/resources/throw.js?pipe=trickle(d3), line 1: SyntaxError: Document.querySelector: ':::not-going-to-be-valid' is not a valid selector
[task 2022-06-03T01:36:54.489Z] 01:36:54     INFO - 
[task 2022-06-03T01:36:54.491Z] 01:36:54     INFO - TEST-PASS | /html/semantics/scripting-1/the-script-element/moving-between-documents/ordering/delay-load-event-1.html | Script elements (parser-blocking) still delay the load event in the original Document after move 
[task 2022-06-03T01:36:54.491Z] 01:36:54     INFO - TEST-UNEXPECTED-FAIL | /html/semantics/scripting-1/the-script-element/moving-between-documents/ordering/delay-load-event-1.html | Script elements (parser-blocking) does not delay the load event in the new Document after move - assert_less_than: Load event should not be delayed until moved script is loaded expected a number less than 2500 but got 2540
[task 2022-06-03T01:36:54.491Z] 01:36:54     INFO - runDelayEventTest/window.onloadIframe<@http://web-platform.test:8000/html/semantics/scripting-1/the-script-element/moving-between-documents/ordering/helper.js:23:21
[task 2022-06-03T01:36:54.491Z] 01:36:54     INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:2590:25
[task 2022-06-03T01:36:54.491Z] 01:36:54     INFO - Test.prototype.step_func_done/<@http://web-platform.test:8000/resources/testharness.js:2665:32
[task 2022-06-03T01:36:54.491Z] 01:36:54     INFO - onload@http://web-platform.test:8000/html/semantics/scripting-1/the-script-element/moving-between-documents/ordering/delay-load-event-iframe.html:1:8
[task 2022-06-03T01:36:54.491Z] 01:36:54     INFO - TEST-ERROR | /html/semantics/scripting-1/the-script-element/moving-between-documents/ordering/delay-load-event-1.html | took 3683ms
[task 2022-06-03T01:36:54.493Z] 01:36:54     INFO - PID 19345 | 1654220214491	Marionette	INFO	Stopped listening on port 48845
[task 2022-06-03T01:36:54.561Z] 01:36:54     INFO - PID 19345 | [Child 19459, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-06-03T01:36:54.564Z] 01:36:54     INFO - PID 19345 | [Child 19459, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-06-03T01:36:54.578Z] 01:36:54     INFO - PID 19345 | [Child 19459, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-06-03T01:36:54.587Z] 01:36:54     INFO - PID 19345 | [Child 19459, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-06-03T01:36:54.590Z] 01:36:54     INFO - PID 19345 | [Child 19459, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-06-03T01:36:54.591Z] 01:36:54     INFO - PID 19345 | [Child 19459, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-06-03T01:36:54.595Z] 01:36:54     INFO - PID 19345 | [Child 19459, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-06-03T01:36:54.725Z] 01:36:54     INFO - PID 19345 | [Child 20926, Main Thread] WARNING: DispatchEvent called on non-current inner window, dropping. Please check the window in the caller instead.: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowInner.cpp:4306
[task 2022-06-03T01:36:54.726Z] 01:36:54     INFO - PID 19345 | [Child 19512, Main Thread] WARNING: DispatchEvent called on non-current inner window, dropping. Please check the window in the caller instead.: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowInner.cpp:4306
[task 2022-06-03T01:36:54.729Z] 01:36:54     INFO - PID 19345 | [Child 20971, Main Thread] WARNING: DispatchEvent called on non-current inner window, dropping. Please check the window in the caller instead.: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowInner.cpp:4306
[task 2022-06-03T01:36:54.729Z] 01:36:54     INFO - PID 19345 | [Child 20997, Main Thread] WARNING: DispatchEvent called on non-current inner window, dropping. Please check the window in the caller instead.: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowInner.cpp:4306
[task 2022-06-03T01:36:54.729Z] 01:36:54     INFO - PID 19345 | [Parent 19345, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:499
[task 2022-06-03T01:36:54.762Z] 01:36:54     INFO - PID 19345 | [Child 20997, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:499
[task 2022-06-03T01:36:54.786Z] 01:36:54     INFO - PID 19345 | [Parent 19345, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:365
[task 2022-06-03T01:36:54.809Z] 01:36:54     INFO - PID 19345 | [Child 19459, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_StartedGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:509
[task 2022-06-03T01:36:54.829Z] 01:36:54     INFO - PID 19345 | [Parent 19345, IPDL Background] WARNING: IPC Connection Error: [Parent][PBackgroundParent] RunMessage(msgname=PRemoteWorkerService::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1908
[task 2022-06-03T01:36:54.838Z] 01:36:54     INFO - PID 19345 | [Parent 19345, Compositor] WARNING: IPC Connection Error: [Parent][PCompositorManagerParent] RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1908
[task 2022-06-03T01:36:54.839Z] 01:36:54     INFO - PID 19345 | [Parent 19345, Compositor] WARNING: IPC Connection Error: [Parent][PImageBridgeParent] RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1908
[task 2022-06-03T01:36:54.848Z] 01:36:54     INFO - PID 19345 | [Child 19459, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_DoneGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:509
[task 2022-06-03T01:36:54.856Z] 01:36:54     INFO - PID 19345 | [Child 20971, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_StartedGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:509
[task 2022-06-03T01:36:54.870Z] 01:36:54     INFO - PID 19345 | [Parent 19345, IPDL Background] WARNING: IPC Connection Error: [Parent][PBackgroundParent] RunMessage(msgname=PRemoteWorkerService::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1908
[task 2022-06-03T01:36:54.872Z] 01:36:54     INFO - PID 19345 | [Parent 19345, IPDL Background] WARNING: IPC Connection Error: [Parent][PBackgroundParent] RunMessage(msgname=PRemoteWorkerService::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1908
<...>
[task 2022-06-03T01:36:55.812Z] 01:36:55     INFO - PID 19345 | [Parent 19345, IPDL Background] WARNING: cache: '0.016293s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3808
[task 2022-06-03T01:36:55.814Z] 01:36:55     INFO - PID 19345 | [Parent 19345, IPDL Background] WARNING: sdb: '0.016331s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3808
[task 2022-06-03T01:36:55.814Z] 01:36:55     INFO - PID 19345 | [Parent 19345, IPDL Background] WARNING: ls: '0.016343s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3808
[task 2022-06-03T01:36:55.814Z] 01:36:55     INFO - PID 19345 | [Parent 19345, IPDL Background] WARNING: quota manager shutdown step: '0.017188s: shutdownAndJoinIOThread', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3808
[task 2022-06-03T01:36:55.820Z] 01:36:55     INFO - PID 19345 | [Parent 19345, IPDL Background] WARNING: quota manager shutdown step: '0.033565s: invalidatePendingDirectoryLocks', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3808
[task 2022-06-03T01:36:55.821Z] 01:36:55     INFO - PID 19345 | [Parent 19345, IPDL Background] WARNING: quota manager shutdown step: '0.033610s: stopCrashBrowserTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3808
[task 2022-06-03T01:36:58.485Z] 01:36:58     INFO - PID 19345 | [Parent 19345, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-06-03T01:36:58.512Z] 01:36:58     INFO - PID 19345 | [Parent 19345, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-06-03T01:36:58.538Z] 01:36:58     INFO - PID 19345 | [Parent 19345, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4571
[task 2022-06-03T01:36:58.558Z] 01:36:58     INFO - Browser exited with return code 0
[task 2022-06-03T01:36:58.562Z] 01:36:58     INFO - PROCESS LEAKS /tmp/tmph3gxlenw/runtests_leaks_1195.log
[task 2022-06-03T01:36:58.562Z] 01:36:58     INFO - leakcheck | Processing log file /tmp/tmph3gxlenw/runtests_leaks_1195.log for scope /html/semantics/scripting-1
[task 2022-06-03T01:36:58.562Z] 01:36:58     INFO - TEST-INFO | leakcheck | default process: leak threshold set at 3123200 bytes
[task 2022-06-03T01:36:58.563Z] 01:36:58     INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 10000 bytes
[task 2022-06-03T01:36:58.563Z] 01:36:58     INFO - TEST-INFO | leakcheck | gmplugin process: leak threshold set at 20000 bytes
[task 2022-06-03T01:36:58.563Z] 01:36:58     INFO - TEST-INFO | leakcheck | gpu process: leak threshold set at 10000 bytes
[task 2022-06-03T01:36:58.564Z] 01:36:58     INFO - TEST-INFO | leakcheck | vr process: leak threshold set at 0 bytes
[task 2022-06-03T01:36:58.564Z] 01:36:58     INFO - TEST-INFO | leakcheck | rdd process: leak threshold set at 400 bytes
[task 2022-06-03T01:36:58.565Z] 01:36:58     INFO - TEST-INFO | leakcheck | socket process: leak threshold set at 0 bytes
[task 2022-06-03T01:36:58.565Z] 01:36:58     INFO - TEST-INFO | leakcheck | sandboxbroker process: leak threshold set at 0 bytes
[task 2022-06-03T01:36:58.565Z] 01:36:58     INFO - TEST-INFO | leakcheck | forkserver process: leak threshold set at 0 bytes
[task 2022-06-03T01:36:58.566Z] 01:36:58     INFO - TEST-INFO | leakcheck | utility process: leak threshold set at 0 bytes
[task 2022-06-03T01:36:58.566Z] 01:36:58     INFO - leakcheck | Processing leak log file /tmp/tmph3gxlenw/runtests_leaks_1195_tab_pid21558.log
[task 2022-06-03T01:36:58.567Z] 01:36:58     INFO - TEST-PASS | leakcheck | tab no leaks detected!

Comment 1

[Intermittent Failures Robot]

1 failures in 2917 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=1772462&startday=2022-05-30&endday=2022-06-05&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

[Treeherder Bug Filer]

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

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-esr102: 1

Platform and build breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1772462&startday=2022-06-27&endday=2022-07-03&tree=all

Comment 5

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

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

Comment 6

[Treeherder Bug Filer]

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

Comment 7

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-esr102: 1

Platform and build breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1772462&startday=2022-08-29&endday=2022-09-04&tree=all

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-beta: 1

Platform and build breakdown:

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

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

Comment 9

[Intermittent Failures Robot]

1 failures in 2909 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-qr: 1
  • debug: 1

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

Comment 10

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

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

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

Comment 11

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1772462&startday=2022-10-10&endday=2022-10-16&tree=all

Comment 12

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

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