Closed Bug 2011113 Opened 1 month ago Closed 1 month ago

Intermittent Page Page.waitForNetworkIdle should work with delayed response (page.spec.js) | expected PASS

Categories

(Remote Protocol :: WebDriver BiDi, defect, P5)

defect
Points:
1

Tracking

(firefox149 fixed)

RESOLVED FIXED
149 Branch
Tracking Status
firefox149 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: whimboo)

References

Details

(Keywords: intermittent-failure, Whiteboard: [webdriver:m19])

Attachments

(1 file)

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


[task 2026-01-18T23:27:47.826+00:00] TEST-START | Page Page.waitForNetworkIdle should work with delayed response (page.spec.js)
[task 2026-01-18T23:27:47.826+00:00] PID 730 | ["test-start",{"title":"should work with delayed response","fullTitle":"Page Page.waitForNetworkIdle should work with delayed response","file":"/builds/worker/checkouts/gecko/remote/test/puppeteer/test/build/page.spec.js","currentRetry":0}]
[task 2026-01-18T23:27:47.827+00:00] PID 730 | 1768778867827	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"success","id":2703,"result":{}}
[task 2026-01-18T23:27:47.827+00:00] PID 730 | 1768778867827	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"success","id":2704,"result":{}}
[task 2026-01-18T23:27:47.828+00:00] PID 730 | 1768778867828	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"script.realmDestroyed","params":{"realm":"22b1fb7a-adad-486a-9101-f986264faddb"}}
[task 2026-01-18T23:27:47.828+00:00] PID 730 | 1768778867828	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"script.realmDestroyed","params":{"realm":"78cd99b0-3b16-4839-9b40-b82ce7707686"}}
[task 2026-01-18T23:27:47.828+00:00] PID 730 | 1768778867828	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 -> {"id":2706,"method":"browser.createUserContext","params":{}}
[task 2026-01-18T23:27:47.828+00:00] PID 730 | 1768778867828	RemoteAgent	TRACE	Received command browser.createUserContext for destination ROOT
[task 2026-01-18T23:27:47.828+00:00] PID 730 | 1768778867828	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"success","id":2706,"result":{"userContext":"14674d0b-96d8-4fe0-a40f-29cdff6ac70e"}}
[task 2026-01-18T23:27:47.868+00:00] PID 730 | 1768778867868	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 -> {"id":2707,"method":"browsingContext.create","params":{"type":"tab","userContext":"14674d0b-96d8-4fe0-a40f-29cdff6ac70e"}}
[task 2026-01-18T23:27:47.868+00:00] PID 730 | 1768778867868	RemoteAgent	TRACE	Received command browsingContext.create for destination ROOT
[task 2026-01-18T23:27:47.869+00:00] PID 730 | 1768778867868	RemoteAgent	TRACE	Received command browsingContext._awaitVisibilityState for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.871+00:00] PID 730 | 1768778867870	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"browsingContext.contextCreated","params":{"children":null,"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","originalOpener":null,"url":"about:blank","userContext":"14674d0b-96d8-4fe0-a40f-29cdff6ac70e","clientWindow":"de026644-25ba-47be-a711-1cf26bd63280","parent":null}}
[task 2026-01-18T23:27:47.871+00:00] PID 730 | 1768778867870	RemoteAgent	TRACE	ParentWebProgressListener Start watching updates for browsing context [context=264]
[task 2026-01-18T23:27:47.871+00:00] PID 730 | 1768778867870	RemoteAgent	TRACE	ParentWebProgressListener The web progress was not monitored yet, adding a progress listener [context=264]
[task 2026-01-18T23:27:47.877+00:00] PID 730 | 1768778867876	RemoteAgent	TRACE	Received DOM event TabSelect for [object XULElement]
[task 2026-01-18T23:27:47.880+00:00] PID 730 | 1768778867880	RemoteAgent	TRACE	[264] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=5000 waitForExplicitStart=false
[task 2026-01-18T23:27:47.880+00:00] PID 730 | 1768778867880	RemoteAgent	TRACE	[264] ProgressListener Setting unload timer (5000ms)
[task 2026-01-18T23:27:47.880+00:00] PID 730 | 1768778867880	RemoteAgent	TRACE	[264] Wait for initial navigation: isUncommittedInitial=true, isLoadingDocument=false
[task 2026-01-18T23:27:47.880+00:00] PID 730 | 1768778867880	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"script.realmCreated","params":{"realm":"5ebbd9f0-b60d-48df-b5bc-46942acb8a85","origin":"null","context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","type":"window"}}
[task 2026-01-18T23:27:47.881+00:00] PID 730 | 1768778867881	RemoteAgent	TRACE	Received DOM event visibilitychange for [object HTMLDocument]
[task 2026-01-18T23:27:47.883+00:00] PID 730 | 1768778867882	RemoteAgent	TRACE	Received command browsingContext._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.883+00:00] PID 730 | 1768778867883	RemoteAgent	TRACE	Received command network._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.884+00:00] PID 730 | 1768778867884	RemoteAgent	TRACE	Received command log._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.885+00:00] PID 730 | 1768778867884	RemoteAgent	TRACE	Received command script._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.885+00:00] PID 730 | 1768778867884	RemoteAgent	TRACE	Received command input._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.885+00:00] PID 730 | 1768778867885	RemoteAgent	TRACE	Created MessageHandler WINDOW_GLOBAL for session 3755630e-1507-41ac-ba4e-34f02e08f919
[task 2026-01-18T23:27:47.885+00:00] PID 730 | 1768778867885	RemoteAgent	TRACE	ParentWebProgressListener Loading state: flags: 983041, status: 0,  isStart: true, isStop: false, isNetwork: true, isBindingAborted: false, targetURI: about:blank [context=264]
[task 2026-01-18T23:27:47.886+00:00] PID 730 | 1768778867885	RemoteAgent	TRACE	ParentWebProgressListener Skip initial navigation to about:blank [context=264]
[task 2026-01-18T23:27:47.886+00:00] PID 730 | 1768778867885	RemoteAgent	TRACE	WebDriverDocumentInsertedChild actor created for PID 17871
[task 2026-01-18T23:27:47.886+00:00] PID 730 | 1768778867886	RemoteAgent	TRACE	[264] ProgressListener Loading state: isStart=true isStop=false status=0x0, loadType=0x1, seenStartFlag=false
[task 2026-01-18T23:27:47.886+00:00] PID 730 | 1768778867886	RemoteAgent	TRACE	[264] ProgressListener Started loading about:blank
[task 2026-01-18T23:27:47.886+00:00] PID 730 | 1768778867886	RemoteAgent	TRACE	[264] ProgressListener Cleared the unload timer
[task 2026-01-18T23:27:47.887+00:00] PID 730 | 1768778867887	RemoteAgent	TRACE	[2a7a0774-61e8-4609-a7d8-60865c4a167d] Skipping this navigation for url: about:blank, since it's an initial navigation.
[task 2026-01-18T23:27:47.890+00:00] PID 730 | 1768778867890	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"browsingContext.domContentLoaded","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","timestamp":1768778867890,"url":"about:blank","navigation":"c180f2e6-9a64-453a-9c4b-c78622d9a058"}}
[task 2026-01-18T23:27:47.891+00:00] PID 730 | 1768778867890	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"browsingContext.load","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","timestamp":1768778867890,"url":"about:blank","navigation":"c180f2e6-9a64-453a-9c4b-c78622d9a058"}}
[task 2026-01-18T23:27:47.891+00:00] PID 730 | 1768778867891	RemoteAgent	TRACE	ParentWebProgressListener Loading state: flags: 786448, status: 0,  isStart: false, isStop: true, isNetwork: true, isBindingAborted: false, targetURI: about:blank [context=264]
[task 2026-01-18T23:27:47.891+00:00] PID 730 | 1768778867891	RemoteAgent	TRACE	[2a7a0774-61e8-4609-a7d8-60865c4a167d] Navigation finished for url: about:blank (c180f2e6-9a64-453a-9c4b-c78622d9a058)
[task 2026-01-18T23:27:47.891+00:00] PID 730 | 1768778867891	RemoteAgent	TRACE	[264] ProgressListener Loading state: isStart=false isStop=true status=0x0, loadType=0x1, seenStartFlag=true
[task 2026-01-18T23:27:47.891+00:00] PID 730 | 1768778867891	RemoteAgent	TRACE	[264] ProgressListener Stop: has error=false url=about:blank
[task 2026-01-18T23:27:47.892+00:00] PID 730 | 1768778867892	RemoteAgent	TRACE	Received command browsingContext._awaitVisibilityState for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.892+00:00] PID 730 | 1768778867892	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"success","id":2707,"result":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d"}}
[task 2026-01-18T23:27:47.912+00:00] PID 730 | 1768778867912	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 -> {"id":2708,"method":"browsingContext.setViewport","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","viewport":{"width":800,"height":600},"devicePixelRatio":null}}
[task 2026-01-18T23:27:47.912+00:00] PID 730 | 1768778867912	RemoteAgent	TRACE	Received command browsingContext.setViewport for destination ROOT
[task 2026-01-18T23:27:47.914+00:00] PID 730 | 1768778867914	RemoteAgent	TRACE	Received command _configuration._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.915+00:00] PID 730 | 1768778867915	RemoteAgent	TRACE	Received command _configuration._applySessionData for destination ROOT
[task 2026-01-18T23:27:47.915+00:00] PID 730 | 1768778867915	RemoteAgent	TRACE	Received command _configuration._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.916+00:00] PID 730 | 1768778867916	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 -> {"id":2709,"method":"emulation.setScreenOrientationOverride","params":{"screenOrientation":{"natural":"portrait","type":"portrait-primary"},"contexts":["2a7a0774-61e8-4609-a7d8-60865c4a167d"]}}
[task 2026-01-18T23:27:47.916+00:00] PID 730 | 1768778867916	RemoteAgent	TRACE	Received command emulation.setScreenOrientationOverride for destination ROOT
[task 2026-01-18T23:27:47.918+00:00] PID 730 | 1768778867918	RemoteAgent	TRACE	Received command _configuration._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.919+00:00] PID 730 | 1768778867918	RemoteAgent	TRACE	Received command _configuration._applySessionData for destination ROOT
[task 2026-01-18T23:27:47.919+00:00] PID 730 | 1768778867919	RemoteAgent	TRACE	Received command _configuration._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.919+00:00] PID 730 | 1768778867919	RemoteAgent	TRACE	Received command browsingContext._awaitViewportDimensions for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.919+00:00] PID 730 | 1768778867919	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"success","id":2709,"result":{}}
[task 2026-01-18T23:27:47.964+00:00] PID 730 | 1768778867964	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"success","id":2708,"result":{}}
[task 2026-01-18T23:27:47.965+00:00] PID 730 | 1768778867965	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 -> {"id":2710,"method":"browsingContext.navigate","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","url":"http://localhost:37295/empty.html","wait":"interactive"}}
[task 2026-01-18T23:27:47.965+00:00] PID 730 | 1768778867965	RemoteAgent	TRACE	Received command browsingContext.navigate for destination ROOT
[task 2026-01-18T23:27:47.965+00:00] PID 730 | 1768778867965	RemoteAgent	TRACE	Received command browsingContext._getBaseURL for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.965+00:00] PID 730 | 1768778867965	RemoteAgent	TRACE	Received command browsingContext._getBaseURL for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.967+00:00] PID 730 | 1768778867967	RemoteAgent	TRACE	Received command browsingContext._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.967+00:00] PID 730 | 1768778867967	RemoteAgent	TRACE	Received command browsingContext._applySessionData for destination ROOT
[task 2026-01-18T23:27:47.968+00:00] PID 730 | 1768778867967	RemoteAgent	TRACE	Received command browsingContext._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.968+00:00] PID 730 | 1768778867968	RemoteAgent	TRACE	[264] ProgressListener Start: expectNavigation=true resolveWhenStarted=false unloadTimeout=200 waitForExplicitStart=true
[task 2026-01-18T23:27:47.968+00:00] PID 730 | 1768778867968	RemoteAgent	TRACE	[264] ProgressListener Skip setting the unload timer
[task 2026-01-18T23:27:47.969+00:00] PID 730 | 1768778867968	RemoteAgent	TRACE	[2a7a0774-61e8-4609-a7d8-60865c4a167d] Navigation started for url: http://localhost:37295/empty.html (4bfc80cb-7f2b-43ad-9fc7-52c84f007a05)
[task 2026-01-18T23:27:47.969+00:00] PID 730 | 1768778867969	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"browsingContext.navigationStarted","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","navigation":"4bfc80cb-7f2b-43ad-9fc7-52c84f007a05","timestamp":1768778867968,"url":"http://localhost:37295/empty.html"}}
[task 2026-01-18T23:27:47.969+00:00] PID 730 | 1768778867969	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"network.beforeRequestSent","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","isBlocked":false,"navigation":"4bfc80cb-7f2b-43ad-9fc7-52c84f007a05","redirectCount":0,"request":{"request":"571-14699abd-d21b-4a69-b816-5ac94eeb0abf","url":"http://localhost:37295/empty.html","method":"GET","bodySize":0,"headersSize":0,"headers":[{"name":"Host","value":{"type":"string","value":"localhost:37295"}},{"name":"User-Agent","value":{"type":"string","value":"Mozilla/5.0 (X11; Linux x86_64; rv:149.0) Gecko/20100101 Firefox/149.0"}},{"name":"Accept","value":{"type":"string","value":"text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8"}},{"name":"Accept-Language","value":{"type":"string","value":"en-US,en;q=0.9"}},{"name":"Accept-Encoding","value":{"type":"string","value":"gzip, deflate, br, zstd"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Upgrade-Insecure-Requests","value":{"type":"string","value":"1"}},{"name":"Sec-Fetch-Dest","value":{"type":"string","value":"document"}},{"name":"Sec-Fetch-Mode","value":{"type":"string","value":"navigate"}},{"name":"Sec-Fetch-Site","value":{"type":"string","value":"none"}},{"name":"Sec-Fetch-User","value":{"type":"string","value":"?1"}}],"cookies":[],"destination":"document","initiatorType":null,"timings":{"timeOrigin":0,"requestTime":1768778867968.292,"redirectStart":0,"redirectEnd":0,"fetchStart":0,"dnsStart":0,"dnsEnd":0,"connectStart":0,"connectEnd":0,"tlsStart":0,"tlsEnd":0,"requestStart":0,"responseStart":0,"responseEnd":0}},"timestamp":1768778867969,"initiator":{"type":"other"}}}
[task 2026-01-18T23:27:47.970+00:00] PID 730 | 1768778867969	RemoteAgent	TRACE	ParentWebProgressListener Loading state: flags: 983041, status: 0,  isStart: true, isStop: false, isNetwork: true, isBindingAborted: false, targetURI: http://localhost:37295/empty.html [context=264]
[task 2026-01-18T23:27:47.970+00:00] PID 730 | 1768778867969	RemoteAgent	TRACE	[2a7a0774-61e8-4609-a7d8-60865c4a167d] Skipping already tracked navigation, navigationId: 4bfc80cb-7f2b-43ad-9fc7-52c84f007a05
[task 2026-01-18T23:27:47.970+00:00] PID 730 | 1768778867970	RemoteAgent	TRACE	[264] ProgressListener Loading state: isStart=true isStop=false status=0x0, loadType=0x200001, seenStartFlag=false
[task 2026-01-18T23:27:47.970+00:00] PID 730 | 1768778867970	RemoteAgent	TRACE	[264] ProgressListener Started loading http://localhost:37295/empty.html
[task 2026-01-18T23:27:47.971+00:00] PID 730 | 1768778867971	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"network.responseStarted","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","isBlocked":false,"navigation":"4bfc80cb-7f2b-43ad-9fc7-52c84f007a05","redirectCount":0,"request":{"request":"571-14699abd-d21b-4a69-b816-5ac94eeb0abf","url":"http://localhost:37295/empty.html","method":"GET","bodySize":0,"headersSize":449,"headers":[{"name":"Host","value":{"type":"string","value":"localhost:37295"}},{"name":"User-Agent","value":{"type":"string","value":"Mozilla/5.0 (X11; Linux x86_64; rv:149.0) Gecko/20100101 Firefox/149.0"}},{"name":"Accept","value":{"type":"string","value":"text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8"}},{"name":"Accept-Language","value":{"type":"string","value":"en-US,en;q=0.9"}},{"name":"Accept-Encoding","value":{"type":"string","value":"gzip, deflate, br, zstd"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Upgrade-Insecure-Requests","value":{"type":"string","value":"1"}},{"name":"Sec-Fetch-Dest","value":{"type":"string","value":"document"}},{"name":"Sec-Fetch-Mode","value":{"type":"string","value":"navigate"}},{"name":"Sec-Fetch-Site","value":{"type":"string","value":"none"}},{"name":"Sec-Fetch-User","value":{"type":"string","value":"?1"}},{"name":"Priority","value":{"type":"string","value":"u=0, i"}}],"cookies":[],"destination":"document","initiatorType":null,"timings":{"timeOrigin":0,"requestTime":1768778867968.292,"redirectStart":0,"redirectEnd":0,"fetchStart":1768778867969.719,"dnsStart":1768778867969.719,"dnsEnd":1768778867969.749,"connectStart":1768778867969.827,"connectEnd":1768778867969.95,"tlsStart":0,"tlsEnd":1768778867969.95,"requestStart":1768778867970.032,"responseStart":1768778867970.838,"responseEnd":1768778867970.884}},"timestamp":1768778867971,"response":{"url":"http://localhost:37295/empty.html","protocol":"http/1.1","status":200,"statusText":"OK","fromCache":false,"headers":[{"name":"Cache-Control","value":{"type":"string","value":"no-cache, no-store"}},{"name":"Content-Type","value":{"type":"string","value":"text/html; charset=utf-8"}},{"name":"Date","value":{"type":"string","value":"Sun, 18 Jan 2026 23:27:47 GMT"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Content-Length","value":{"type":"string","value":"15"}}],"mimeType":"text/html;charset=utf-8","bytesReceived":175,"headersSize":175,"bodySize":0,"content":{"size":0}}}}
[task 2026-01-18T23:27:47.972+00:00] PID 730 | 1768778867972	RemoteAgent	TRACE	Received DOM event pagehide for [object HTMLDocument]
[task 2026-01-18T23:27:47.972+00:00] PID 730 | 1768778867972	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"network.responseCompleted","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","isBlocked":false,"navigation":"4bfc80cb-7f2b-43ad-9fc7-52c84f007a05","redirectCount":0,"request":{"request":"571-14699abd-d21b-4a69-b816-5ac94eeb0abf","url":"http://localhost:37295/empty.html","method":"GET","bodySize":0,"headersSize":449,"headers":[{"name":"Host","value":{"type":"string","value":"localhost:37295"}},{"name":"User-Agent","value":{"type":"string","value":"Mozilla/5.0 (X11; Linux x86_64; rv:149.0) Gecko/20100101 Firefox/149.0"}},{"name":"Accept","value":{"type":"string","value":"text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8"}},{"name":"Accept-Language","value":{"type":"string","value":"en-US,en;q=0.9"}},{"name":"Accept-Encoding","value":{"type":"string","value":"gzip, deflate, br, zstd"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Upgrade-Insecure-Requests","value":{"type":"string","value":"1"}},{"name":"Sec-Fetch-Dest","value":{"type":"string","value":"document"}},{"name":"Sec-Fetch-Mode","value":{"type":"string","value":"navigate"}},{"name":"Sec-Fetch-Site","value":{"type":"string","value":"none"}},{"name":"Sec-Fetch-User","value":{"type":"string","value":"?1"}},{"name":"Priority","value":{"type":"string","value":"u=0, i"}}],"cookies":[],"destination":"document","initiatorType":null,"timings":{"timeOrigin":0,"requestTime":1768778867968.292,"redirectStart":0,"redirectEnd":0,"fetchStart":1768778867968.613,"dnsStart":1768778867968.613,"dnsEnd":1768778867969.749,"connectStart":1768778867969.827,"connectEnd":1768778867969.95,"tlsStart":0,"tlsEnd":1768778867969.95,"requestStart":1768778867970.032,"responseStart":1768778867970.838,"responseEnd":1768778867970.884}},"timestamp":1768778867972,"response":{"url":"http://localhost:37295/empty.html","protocol":"http/1.1","status":200,"statusText":"OK","fromCache":false,"headers":[{"name":"Cache-Control","value":{"type":"string","value":"no-cache, no-store"}},{"name":"Content-Type","value":{"type":"string","value":"text/html; charset=utf-8"}},{"name":"Date","value":{"type":"string","value":"Sun, 18 Jan 2026 23:27:47 GMT"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Content-Length","value":{"type":"string","value":"15"}}],"mimeType":"text/html;charset=utf-8","bytesReceived":190,"headersSize":175,"bodySize":15,"content":{"size":0}}}}
[task 2026-01-18T23:27:47.974+00:00] PID 730 | 1768778867973	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"script.realmDestroyed","params":{"realm":"5ebbd9f0-b60d-48df-b5bc-46942acb8a85"}}
[task 2026-01-18T23:27:47.975+00:00] PID 730 | 1768778867975	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"script.realmCreated","params":{"realm":"6fe69286-507d-40a7-9230-dd66eb0e9149","origin":"http://localhost:37295","context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","type":"window"}}
[task 2026-01-18T23:27:47.975+00:00] PID 730 | 1768778867975	RemoteAgent	TRACE	Received command browsingContext._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.975+00:00] PID 730 | 1768778867975	RemoteAgent	TRACE	Received command network._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.975+00:00] PID 730 | 1768778867975	RemoteAgent	TRACE	Received command log._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.975+00:00] PID 730 | 1768778867975	RemoteAgent	TRACE	Received command script._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.975+00:00] PID 730 | 1768778867975	RemoteAgent	TRACE	Received command input._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.976+00:00] PID 730 | 1768778867975	RemoteAgent	TRACE	Received command _configuration._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.976+00:00] PID 730 | 1768778867975	RemoteAgent	TRACE	Received command _configuration._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.976+00:00] PID 730 | 1768778867976	RemoteAgent	TRACE	Created MessageHandler WINDOW_GLOBAL for session 3755630e-1507-41ac-ba4e-34f02e08f919
[task 2026-01-18T23:27:47.976+00:00] PID 730 | 1768778867976	RemoteAgent	TRACE	MessageHandler WINDOW_GLOBAL for session 3755630e-1507-41ac-ba4e-34f02e08f919 is being destroyed
[task 2026-01-18T23:27:47.976+00:00] PID 730 | 1768778867976	RemoteAgent	TRACE	Unregistered MessageHandler WINDOW_GLOBAL for session 3755630e-1507-41ac-ba4e-34f02e08f919
[task 2026-01-18T23:27:47.979+00:00] PID 730 | 1768778867978	RemoteAgent	TRACE	[2a7a0774-61e8-4609-a7d8-60865c4a167d] Navigation committed for url: http://localhost:37295/empty.html (4bfc80cb-7f2b-43ad-9fc7-52c84f007a05)
[task 2026-01-18T23:27:47.979+00:00] PID 730 | 1768778867978	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"browsingContext.navigationCommitted","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","navigation":"4bfc80cb-7f2b-43ad-9fc7-52c84f007a05","timestamp":1768778867978,"url":"http://localhost:37295/empty.html"}}
[task 2026-01-18T23:27:47.979+00:00] PID 730 | 1768778867979	RemoteAgent	TRACE	Received command browsingContext._updateNavigableViewport for destination ROOT
[task 2026-01-18T23:27:47.983+00:00] PID 730 | 1768778867983	RemoteAgent	TRACE	Received command network._setDecodedBodySize for destination ROOT
[task 2026-01-18T23:27:47.983+00:00] PID 730 | 1768778867983	RemoteAgent	TRACE	network.interceptEvent returned null, skipping event: network._beforeStopRequest, data: [object Object]
[task 2026-01-18T23:27:47.984+00:00] PID 730 | 1768778867984	RemoteAgent	TRACE	[264] ProgressListener Stop if started: seenStartFlag=true
[task 2026-01-18T23:27:47.984+00:00] PID 730 | 1768778867984	RemoteAgent	TRACE	[264] ProgressListener Stop: has error=false url=http://localhost:37295/empty.html
[task 2026-01-18T23:27:47.986+00:00] PID 730 | 1768778867986	RemoteAgent	TRACE	Received command browsingContext._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.986+00:00] PID 730 | 1768778867986	RemoteAgent	TRACE	Received command browsingContext._applySessionData for destination ROOT
[task 2026-01-18T23:27:47.986+00:00] PID 730 | 1768778867986	RemoteAgent	TRACE	Received command browsingContext._applySessionData for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:47.986+00:00] PID 730 | 1768778867986	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"browsingContext.domContentLoaded","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","timestamp":1768778867983,"url":"http://localhost:37295/empty.html","navigation":"4bfc80cb-7f2b-43ad-9fc7-52c84f007a05"}}
[task 2026-01-18T23:27:47.987+00:00] PID 730 | 1768778867987	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"network.beforeRequestSent","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","isBlocked":false,"navigation":null,"redirectCount":0,"request":{"request":"572-14699abd-d21b-4a69-b816-5ac94eeb0abf","url":"http://localhost:37295/favicon.ico","method":"GET","bodySize":0,"headersSize":0,"headers":[{"name":"Host","value":{"type":"string","value":"localhost:37295"}},{"name":"User-Agent","value":{"type":"string","value":"Mozilla/5.0 (X11; Linux x86_64; rv:149.0) Gecko/20100101 Firefox/149.0"}},{"name":"Accept","value":{"type":"string","value":"image/avif,image/webp,image/png,image/svg+xml,image/*;q=0.8,*/*;q=0.5"}},{"name":"Accept-Language","value":{"type":"string","value":"en-US,en;q=0.9"}},{"name":"Accept-Encoding","value":{"type":"string","value":"gzip, deflate, br, zstd"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Referer","value":{"type":"string","value":"http://localhost:37295/empty.html"}},{"name":"Sec-Fetch-Dest","value":{"type":"string","value":"image"}},{"name":"Sec-Fetch-Mode","value":{"type":"string","value":"no-cors"}},{"name":"Sec-Fetch-Site","value":{"type":"string","value":"same-origin"}}],"cookies":[],"destination":"image","initiatorType":null,"timings":{"timeOrigin":0,"requestTime":1768778867984.012,"redirectStart":0,"redirectEnd":0,"fetchStart":0,"dnsStart":0,"dnsEnd":0,"connectStart":0,"connectEnd":0,"tlsStart":0,"tlsEnd":0,"requestStart":0,"responseStart":0,"responseEnd":0}},"timestamp":1768778867987,"initiator":{"type":"other"}}}
[task 2026-01-18T23:27:47.988+00:00] PID 730 | 1768778867987	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"browsingContext.load","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","timestamp":1768778867984,"url":"http://localhost:37295/empty.html","navigation":"4bfc80cb-7f2b-43ad-9fc7-52c84f007a05"}}
[task 2026-01-18T23:27:47.988+00:00] PID 730 | 1768778867988	RemoteAgent	TRACE	ParentWebProgressListener Loading state: flags: 786448, status: 0,  isStart: false, isStop: true, isNetwork: true, isBindingAborted: false, targetURI: http://localhost:37295/empty.html [context=264]
[task 2026-01-18T23:27:47.988+00:00] PID 730 | 1768778867988	RemoteAgent	TRACE	[2a7a0774-61e8-4609-a7d8-60865c4a167d] Navigation finished for url: http://localhost:37295/empty.html (4bfc80cb-7f2b-43ad-9fc7-52c84f007a05)
[task 2026-01-18T23:27:47.989+00:00] PID 730 | 1768778867988	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"success","id":2710,"result":{"navigation":"4bfc80cb-7f2b-43ad-9fc7-52c84f007a05","url":"http://localhost:37295/empty.html"}}
[task 2026-01-18T23:27:47.989+00:00] PID 730 | 1768778867989	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"network.responseStarted","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","isBlocked":false,"navigation":null,"redirectCount":0,"request":{"request":"572-14699abd-d21b-4a69-b816-5ac94eeb0abf","url":"http://localhost:37295/favicon.ico","method":"GET","bodySize":0,"headersSize":450,"headers":[{"name":"Host","value":{"type":"string","value":"localhost:37295"}},{"name":"User-Agent","value":{"type":"string","value":"Mozilla/5.0 (X11; Linux x86_64; rv:149.0) Gecko/20100101 Firefox/149.0"}},{"name":"Accept","value":{"type":"string","value":"image/avif,image/webp,image/png,image/svg+xml,image/*;q=0.8,*/*;q=0.5"}},{"name":"Accept-Language","value":{"type":"string","value":"en-US,en;q=0.9"}},{"name":"Accept-Encoding","value":{"type":"string","value":"gzip, deflate, br, zstd"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Referer","value":{"type":"string","value":"http://localhost:37295/empty.html"}},{"name":"Sec-Fetch-Dest","value":{"type":"string","value":"image"}},{"name":"Sec-Fetch-Mode","value":{"type":"string","value":"no-cors"}},{"name":"Sec-Fetch-Site","value":{"type":"string","value":"same-origin"}},{"name":"Priority","value":{"type":"string","value":"u=6"}}],"cookies":[],"destination":"image","initiatorType":null,"timings":{"timeOrigin":0,"requestTime":1768778867984.012,"redirectStart":0,"redirectEnd":0,"fetchStart":0,"dnsStart":0,"dnsEnd":0,"connectStart":0,"connectEnd":0,"tlsStart":0,"tlsEnd":0,"requestStart":1768778867987.8,"responseStart":1768778867988.468,"responseEnd":1768778867988.504}},"timestamp":1768778867989,"response":{"url":"http://localhost:37295/favicon.ico","protocol":"http/1.1","status":200,"statusText":"OK","fromCache":false,"headers":[{"name":"Cache-Control","value":{"type":"string","value":"no-cache, no-store"}},{"name":"Content-Type","value":{"type":"string","value":"image/vnd.microsoft.icon"}},{"name":"Date","value":{"type":"string","value":"Sun, 18 Jan 2026 23:27:47 GMT"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Content-Length","value":{"type":"string","value":"70"}}],"mimeType":"image/vnd.microsoft.icon","bytesReceived":175,"headersSize":175,"bodySize":0,"content":{"size":0}}}}
[task 2026-01-18T23:27:47.990+00:00] PID 730 | 1768778867989	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"network.responseCompleted","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","isBlocked":false,"navigation":null,"redirectCount":0,"request":{"request":"572-14699abd-d21b-4a69-b816-5ac94eeb0abf","url":"http://localhost:37295/favicon.ico","method":"GET","bodySize":0,"headersSize":450,"headers":[{"name":"Host","value":{"type":"string","value":"localhost:37295"}},{"name":"User-Agent","value":{"type":"string","value":"Mozilla/5.0 (X11; Linux x86_64; rv:149.0) Gecko/20100101 Firefox/149.0"}},{"name":"Accept","value":{"type":"string","value":"image/avif,image/webp,image/png,image/svg+xml,image/*;q=0.8,*/*;q=0.5"}},{"name":"Accept-Language","value":{"type":"string","value":"en-US,en;q=0.9"}},{"name":"Accept-Encoding","value":{"type":"string","value":"gzip, deflate, br, zstd"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Referer","value":{"type":"string","value":"http://localhost:37295/empty.html"}},{"name":"Sec-Fetch-Dest","value":{"type":"string","value":"image"}},{"name":"Sec-Fetch-Mode","value":{"type":"string","value":"no-cors"}},{"name":"Sec-Fetch-Site","value":{"type":"string","value":"same-origin"}},{"name":"Priority","value":{"type":"string","value":"u=6"}}],"cookies":[],"destination":"image","initiatorType":null,"timings":{"timeOrigin":0,"requestTime":1768778867984.012,"redirectStart":0,"redirectEnd":0,"fetchStart":0,"dnsStart":0,"dnsEnd":0,"connectStart":0,"connectEnd":0,"tlsStart":0,"tlsEnd":0,"requestStart":1768778867987.8,"responseStart":1768778867988.468,"responseEnd":1768778867988.504}},"timestamp":1768778867989,"response":{"url":"http://localhost:37295/favicon.ico","protocol":"http/1.1","status":200,"statusText":"OK","fromCache":false,"headers":[{"name":"Cache-Control","value":{"type":"string","value":"no-cache, no-store"}},{"name":"Content-Type","value":{"type":"string","value":"image/vnd.microsoft.icon"}},{"name":"Date","value":{"type":"string","value":"Sun, 18 Jan 2026 23:27:47 GMT"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Content-Length","value":{"type":"string","value":"70"}}],"mimeType":"image/vnd.microsoft.icon","bytesReceived":245,"headersSize":175,"bodySize":70,"content":{"size":0}}}}
[task 2026-01-18T23:27:47.990+00:00] PID 730 | 1768778867990	RemoteAgent	TRACE	Received command network._setDecodedBodySize for destination ROOT
[task 2026-01-18T23:27:47.990+00:00] PID 730 | 1768778867990	RemoteAgent	TRACE	network.interceptEvent returned null, skipping event: network._beforeStopRequest, data: [object Object]
[task 2026-01-18T23:27:48.011+00:00] PID 730 | 1768778868010	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 -> {"id":2711,"method":"script.callFunction","params":{"functionDeclaration":"async () => {\n                    await fetch('/fetch-request-b.js');\n                }\n//# sourceURL=pptr:evaluate;Context.% ... 0(file%3A%2F%2F%2Fbuilds%2Fworker%2Fcheckouts%2Fgecko%2Fremote%2Ftest%2Fpuppeteer%2Ftest%2Fbuild%2Fpage.spec.js%3A1026%3A22)\n","awaitPromise":true,"target":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d"},"arguments":[],"resultOwnership":"none","userActivation":true,"serializationOptions":{}}}
[task 2026-01-18T23:27:48.011+00:00] PID 730 | 1768778868010	RemoteAgent	TRACE	Received command script.callFunction for destination ROOT
[task 2026-01-18T23:27:48.011+00:00] PID 730 | 1768778868011	RemoteAgent	TRACE	Received command script.callFunctionDeclaration for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:48.012+00:00] PID 730 | 1768778868012	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"network.beforeRequestSent","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","isBlocked":false,"navigation":null,"redirectCount":0,"request":{"request":"574-14699abd-d21b-4a69-b816-5ac94eeb0abf","url":"http://localhost:37295/fetch-request-b.js","method":"GET","bodySize":0,"headersSize":0,"headers":[{"name":"Host","value":{"type":"string","value":"localhost:37295"}},{"name":"User-Agent","value":{"type":"string","value":"Mozilla/5.0 (X11; Linux x86_64; rv:149.0) Gecko/20100101 Firefox/149.0"}},{"name":"Accept","value":{"type":"string","value":"*/*"}},{"name":"Accept-Language","value":{"type":"string","value":"en-US,en;q=0.9"}},{"name":"Accept-Encoding","value":{"type":"string","value":"gzip, deflate, br, zstd"}},{"name":"Referer","value":{"type":"string","value":"http://localhost:37295/empty.html"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Sec-Fetch-Dest","value":{"type":"string","value":"empty"}},{"name":"Sec-Fetch-Mode","value":{"type":"string","value":"cors"}},{"name":"Sec-Fetch-Site","value":{"type":"string","value":"same-origin"}}],"cookies":[],"destination":"","initiatorType":"fetch","timings":{"timeOrigin":0,"requestTime":1768778868011.983,"redirectStart":0,"redirectEnd":0,"fetchStart":0,"dnsStart":0,"dnsEnd":0,"connectStart":0,"connectEnd":0,"tlsStart":0,"tlsEnd":0,"requestStart":0,"responseStart":0,"responseEnd":0}},"timestamp":1768778868012,"initiator":{"type":"other"}}}
[task 2026-01-18T23:27:48.311+00:00] PID 730 | 1768778868310	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"network.responseStarted","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","isBlocked":false,"navigation":null,"redirectCount":0,"request":{"request":"574-14699abd-d21b-4a69-b816-5ac94eeb0abf","url":"http://localhost:37295/fetch-request-b.js","method":"GET","bodySize":0,"headersSize":388,"headers":[{"name":"Host","value":{"type":"string","value":"localhost:37295"}},{"name":"User-Agent","value":{"type":"string","value":"Mozilla/5.0 (X11; Linux x86_64; rv:149.0) Gecko/20100101 Firefox/149.0"}},{"name":"Accept","value":{"type":"string","value":"*/*"}},{"name":"Accept-Language","value":{"type":"string","value":"en-US,en;q=0.9"}},{"name":"Accept-Encoding","value":{"type":"string","value":"gzip, deflate, br, zstd"}},{"name":"Referer","value":{"type":"string","value":"http://localhost:37295/empty.html"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Sec-Fetch-Dest","value":{"type":"string","value":"empty"}},{"name":"Sec-Fetch-Mode","value":{"type":"string","value":"cors"}},{"name":"Sec-Fetch-Site","value":{"type":"string","value":"same-origin"}},{"name":"Priority","value":{"type":"string","value":"u=4"}}],"cookies":[],"destination":"","initiatorType":"fetch","timings":{"timeOrigin":0,"requestTime":1768778868011.983,"redirectStart":0,"redirectEnd":0,"fetchStart":0,"dnsStart":0,"dnsEnd":0,"connectStart":0,"connectEnd":0,"tlsStart":0,"tlsEnd":0,"requestStart":1768778868012.93,"responseStart":1768778868309.943,"responseEnd":1768778868309.99}},"timestamp":1768778868310,"response":{"url":"http://localhost:37295/fetch-request-b.js","protocol":"http/1.1","status":200,"statusText":"OK","fromCache":false,"headers":[{"name":"Date","value":{"type":"string","value":"Sun, 18 Jan 2026 23:27:48 GMT"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Content-Length","value":{"type":"string","value":"0"}}],"mimeType":"application/x-unknown-content-type","bytesReceived":99,"headersSize":99,"bodySize":0,"content":{"size":0}}}}
[task 2026-01-18T23:27:48.311+00:00] PID 730 | 1768778868311	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"network.responseCompleted","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","isBlocked":false,"navigation":null,"redirectCount":0,"request":{"request":"574-14699abd-d21b-4a69-b816-5ac94eeb0abf","url":"http://localhost:37295/fetch-request-b.js","method":"GET","bodySize":0,"headersSize":388,"headers":[{"name":"Host","value":{"type":"string","value":"localhost:37295"}},{"name":"User-Agent","value":{"type":"string","value":"Mozilla/5.0 (X11; Linux x86_64; rv:149.0) Gecko/20100101 Firefox/149.0"}},{"name":"Accept","value":{"type":"string","value":"*/*"}},{"name":"Accept-Language","value":{"type":"string","value":"en-US,en;q=0.9"}},{"name":"Accept-Encoding","value":{"type":"string","value":"gzip, deflate, br, zstd"}},{"name":"Referer","value":{"type":"string","value":"http://localhost:37295/empty.html"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Sec-Fetch-Dest","value":{"type":"string","value":"empty"}},{"name":"Sec-Fetch-Mode","value":{"type":"string","value":"cors"}},{"name":"Sec-Fetch-Site","value":{"type":"string","value":"same-origin"}},{"name":"Priority","value":{"type":"string","value":"u=4"}}],"cookies":[],"destination":"","initiatorType":"fetch","timings":{"timeOrigin":0,"requestTime":1768778868011.983,"redirectStart":0,"redirectEnd":0,"fetchStart":0,"dnsStart":0,"dnsEnd":0,"connectStart":0,"connectEnd":0,"tlsStart":0,"tlsEnd":0,"requestStart":1768778868012.93,"responseStart":1768778868309.943,"responseEnd":1768778868309.99}},"timestamp":1768778868311,"response":{"url":"http://localhost:37295/fetch-request-b.js","protocol":"http/1.1","status":200,"statusText":"OK","fromCache":false,"headers":[{"name":"Date","value":{"type":"string","value":"Sun, 18 Jan 2026 23:27:48 GMT"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Content-Length","value":{"type":"string","value":"0"}}],"mimeType":"text/plain","bytesReceived":99,"headersSize":99,"bodySize":0,"content":{"size":0}}}}
[task 2026-01-18T23:27:48.312+00:00] PID 730 | 1768778868312	RemoteAgent	TRACE	WebDriverProcessData actor created for PID 17871
[task 2026-01-18T23:27:48.313+00:00] PID 730 | 1768778868313	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"success","id":2711,"result":{"realm":"6fe69286-507d-40a7-9230-dd66eb0e9149","type":"success","result":{"type":"undefined"}}}
[task 2026-01-18T23:27:48.313+00:00] PID 730 | 1768778868313	RemoteAgent	TRACE	Received command network._setDecodedBodySize for destination ROOT
[task 2026-01-18T23:27:48.313+00:00] PID 730 | 1768778868313	RemoteAgent	TRACE	network.interceptEvent returned null, skipping event: network._beforeStopRequest, data: [object Object]
[task 2026-01-18T23:27:48.411+00:00] TEST-UNEXPECTED-FAIL | Page Page.waitForNetworkIdle should work with delayed response (page.spec.js) | expected PASS
[task 2026-01-18T23:27:48.412+00:00] TEST-INFO took 585ms
[task 2026-01-18T23:27:48.412+00:00] PID 730 | ["fail",{"title":"should work with delayed response","fullTitle":"Page Page.waitForNetworkIdle should work with delayed response","file":"/builds/worker/checkouts/gecko/remote/test/puppeteer/test/build/page.spec.js","duration":586,"currentRetry":0,"err":"expect(received).toBeGreaterThan(expected)\n\nExpected: > 400\nReceived:   400","stack":"Error: expect(received).toBeGreaterThan(expected)\n\nExpected: > 400\nReceived:   400\n    at Context.<anonymous> (file:///builds/worker/checkouts/gecko/remote/test/puppeteer/test/src/page.spec.ts:1124:23)"}]
[task 2026-01-18T23:27:48.412+00:00] PID 730 | 1768778868411	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 -> {"id":2712,"method":"browser.removeUserContext","params":{"userContext":"14674d0b-96d8-4fe0-a40f-29cdff6ac70e"}}
[task 2026-01-18T23:27:48.412+00:00] PID 730 | 1768778868411	RemoteAgent	TRACE	Received command browser.removeUserContext for destination ROOT
[task 2026-01-18T23:27:48.418+00:00] PID 730 | 1768778868417	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"browsingContext.contextDestroyed","params":{"children":[],"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","originalOpener":null,"url":"http://localhost:37295/empty.html","userContext":"14674d0b-96d8-4fe0-a40f-29cdff6ac70e","clientWindow":"de026644-25ba-47be-a711-1cf26bd63280","parent":null}}
[task 2026-01-18T23:27:48.418+00:00] PID 730 | 1768778868418	RemoteAgent	TRACE	ParentWebProgressListener Stop watching updates for browsing context [context=264]
[task 2026-01-18T23:27:48.418+00:00] PID 730 | 1768778868418	RemoteAgent	TRACE	ParentWebProgressListener All browsing contexts for this web progress deleted, removing the progress listener [context=264]
[task 2026-01-18T23:27:48.418+00:00] PID 730 | 1768778868418	RemoteAgent	TRACE	ParentWebProgressListener Removing the web progress from monitored web progress [context=264]
[task 2026-01-18T23:27:48.418+00:00] PID 730 | 1768778868418	RemoteAgent	TRACE	[2a7a0774-61e8-4609-a7d8-60865c4a167d] Navigation already marked as finished, navigationId: 4bfc80cb-7f2b-43ad-9fc7-52c84f007a05
[task 2026-01-18T23:27:48.419+00:00] PID 730 | 1768778868418	RemoteAgent	TRACE	MessageHandler WINDOW_GLOBAL for session 3755630e-1507-41ac-ba4e-34f02e08f919 is being destroyed
[task 2026-01-18T23:27:48.419+00:00] PID 730 | 1768778868419	RemoteAgent	TRACE	Unregistered MessageHandler WINDOW_GLOBAL for session 3755630e-1507-41ac-ba4e-34f02e08f919
[task 2026-01-18T23:27:48.420+00:00] PID 730 | 1768778868419	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"success","id":2712,"result":{}}
[task 2026-01-18T23:27:48.420+00:00] TEST-START | Page Page.waitForNetworkIdle should be cancelable (page.spec.js)

I think this should be in Remote Protocol

Component: Networking → WebDriver BiDi
Product: Core → Remote Protocol

The related test can be found at:
https://searchfox.org/firefox-main/rev/0fc599421fc27ac61c501f277cb440777f85b18a/remote/test/puppeteer/test/src/page.spec.ts#1100-1127

The failure here is:

[task 2026-01-18T23:27:48.412+00:00] PID 730 | ["fail",{"title":"should work with delayed response","fullTitle":"Page Page.waitForNetworkIdle should work with delayed response","file":"/builds/worker/checkouts/gecko/remote/test/puppeteer/test/build/page.spec.js","duration":586,"currentRetry":0,"err":"expect(received).toBeGreaterThan(expected)\n\nExpected: > 400\nReceived: 400","stack":"Error: expect(received).toBeGreaterThan(expected)\n\nExpected: > 400\nReceived: 400\n at Context.<anonymous> (file:///builds/worker/checkouts/gecko/remote/test/puppeteer/test/src/page.spec.ts:1124:23)"}]

So this is the check for the timestamp of networkidle which is expected to be larger than 400ms but we have exactly 400ms.

Maybe the vendoring of Puppeteer 24.35.0 changed some internal timings in Puppeteer, which caused this failure to happen more often now.

Depends on: 1998377

Relevant lines in the log actually are:
https://treeherder.mozilla.org/logviewer?job_id=544201333&repo=mozilla-central&task=QC-sQl9HQ3yaxg4idteEOQ.0&lineNumber=38991-39000

[task 2026-01-18T23:27:48.011+00:00] PID 730 | 1768778868010	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 -> {"id":2711,"method":"script.callFunction","params":{"functionDeclaration":"async () => {\n                    await fetch('/fetch-request-b.js');\n                }\n//# sourceURL=pptr:evaluate;Context.% ... 0(file%3A%2F%2F%2Fbuilds%2Fworker%2Fcheckouts%2Fgecko%2Fremote%2Ftest%2Fpuppeteer%2Ftest%2Fbuild%2Fpage.spec.js%3A1026%3A22)\n","awaitPromise":true,"target":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d"},"arguments":[],"resultOwnership":"none","userActivation":true,"serializationOptions":{}}}
[task 2026-01-18T23:27:48.011+00:00] PID 730 | 1768778868010	RemoteAgent	TRACE	Received command script.callFunction for destination ROOT
[task 2026-01-18T23:27:48.011+00:00] PID 730 | 1768778868011	RemoteAgent	TRACE	Received command script.callFunctionDeclaration for destination WINDOW_GLOBAL
[task 2026-01-18T23:27:48.012+00:00] PID 730 | 1768778868012	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"network.beforeRequestSent","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","isBlocked":false,"navigation":null,"redirectCount":0,"request":{"request":"574-14699abd-d21b-4a69-b816-5ac94eeb0abf","url":"http://localhost:37295/fetch-request-b.js","method":"GET","bodySize":0,"headersSize":0,"headers":[{"name":"Host","value":{"type":"string","value":"localhost:37295"}},{"name":"User-Agent","value":{"type":"string","value":"Mozilla/5.0 (X11; Linux x86_64; rv:149.0) Gecko/20100101 Firefox/149.0"}},{"name":"Accept","value":{"type":"string","value":"*/*"}},{"name":"Accept-Language","value":{"type":"string","value":"en-US,en;q=0.9"}},{"name":"Accept-Encoding","value":{"type":"string","value":"gzip, deflate, br, zstd"}},{"name":"Referer","value":{"type":"string","value":"http://localhost:37295/empty.html"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Sec-Fetch-Dest","value":{"type":"string","value":"empty"}},{"name":"Sec-Fetch-Mode","value":{"type":"string","value":"cors"}},{"name":"Sec-Fetch-Site","value":{"type":"string","value":"same-origin"}}],"cookies":[],"destination":"","initiatorType":"fetch","timings":{"timeOrigin":0,"requestTime":1768778868011.983,"redirectStart":0,"redirectEnd":0,"fetchStart":0,"dnsStart":0,"dnsEnd":0,"connectStart":0,"connectEnd":0,"tlsStart":0,"tlsEnd":0,"requestStart":0,"responseStart":0,"responseEnd":0}},"timestamp":1768778868012,"initiator":{"type":"other"}}}
[task 2026-01-18T23:27:48.311+00:00] PID 730 | 1768778868310	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"network.responseStarted","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","isBlocked":false,"navigation":null,"redirectCount":0,"request":{"request":"574-14699abd-d21b-4a69-b816-5ac94eeb0abf","url":"http://localhost:37295/fetch-request-b.js","method":"GET","bodySize":0,"headersSize":388,"headers":[{"name":"Host","value":{"type":"string","value":"localhost:37295"}},{"name":"User-Agent","value":{"type":"string","value":"Mozilla/5.0 (X11; Linux x86_64; rv:149.0) Gecko/20100101 Firefox/149.0"}},{"name":"Accept","value":{"type":"string","value":"*/*"}},{"name":"Accept-Language","value":{"type":"string","value":"en-US,en;q=0.9"}},{"name":"Accept-Encoding","value":{"type":"string","value":"gzip, deflate, br, zstd"}},{"name":"Referer","value":{"type":"string","value":"http://localhost:37295/empty.html"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Sec-Fetch-Dest","value":{"type":"string","value":"empty"}},{"name":"Sec-Fetch-Mode","value":{"type":"string","value":"cors"}},{"name":"Sec-Fetch-Site","value":{"type":"string","value":"same-origin"}},{"name":"Priority","value":{"type":"string","value":"u=4"}}],"cookies":[],"destination":"","initiatorType":"fetch","timings":{"timeOrigin":0,"requestTime":1768778868011.983,"redirectStart":0,"redirectEnd":0,"fetchStart":0,"dnsStart":0,"dnsEnd":0,"connectStart":0,"connectEnd":0,"tlsStart":0,"tlsEnd":0,"requestStart":1768778868012.93,"responseStart":1768778868309.943,"responseEnd":1768778868309.99}},"timestamp":1768778868310,"response":{"url":"http://localhost:37295/fetch-request-b.js","protocol":"http/1.1","status":200,"statusText":"OK","fromCache":false,"headers":[{"name":"Date","value":{"type":"string","value":"Sun, 18 Jan 2026 23:27:48 GMT"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Content-Length","value":{"type":"string","value":"0"}}],"mimeType":"application/x-unknown-content-type","bytesReceived":99,"headersSize":99,"bodySize":0,"content":{"size":0}}}}
[task 2026-01-18T23:27:48.311+00:00] PID 730 | 1768778868311	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"event","method":"network.responseCompleted","params":{"context":"2a7a0774-61e8-4609-a7d8-60865c4a167d","isBlocked":false,"navigation":null,"redirectCount":0,"request":{"request":"574-14699abd-d21b-4a69-b816-5ac94eeb0abf","url":"http://localhost:37295/fetch-request-b.js","method":"GET","bodySize":0,"headersSize":388,"headers":[{"name":"Host","value":{"type":"string","value":"localhost:37295"}},{"name":"User-Agent","value":{"type":"string","value":"Mozilla/5.0 (X11; Linux x86_64; rv:149.0) Gecko/20100101 Firefox/149.0"}},{"name":"Accept","value":{"type":"string","value":"*/*"}},{"name":"Accept-Language","value":{"type":"string","value":"en-US,en;q=0.9"}},{"name":"Accept-Encoding","value":{"type":"string","value":"gzip, deflate, br, zstd"}},{"name":"Referer","value":{"type":"string","value":"http://localhost:37295/empty.html"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Sec-Fetch-Dest","value":{"type":"string","value":"empty"}},{"name":"Sec-Fetch-Mode","value":{"type":"string","value":"cors"}},{"name":"Sec-Fetch-Site","value":{"type":"string","value":"same-origin"}},{"name":"Priority","value":{"type":"string","value":"u=4"}}],"cookies":[],"destination":"","initiatorType":"fetch","timings":{"timeOrigin":0,"requestTime":1768778868011.983,"redirectStart":0,"redirectEnd":0,"fetchStart":0,"dnsStart":0,"dnsEnd":0,"connectStart":0,"connectEnd":0,"tlsStart":0,"tlsEnd":0,"requestStart":1768778868012.93,"responseStart":1768778868309.943,"responseEnd":1768778868309.99}},"timestamp":1768778868311,"response":{"url":"http://localhost:37295/fetch-request-b.js","protocol":"http/1.1","status":200,"statusText":"OK","fromCache":false,"headers":[{"name":"Date","value":{"type":"string","value":"Sun, 18 Jan 2026 23:27:48 GMT"}},{"name":"Connection","value":{"type":"string","value":"keep-alive"}},{"name":"Content-Length","value":{"type":"string","value":"0"}}],"mimeType":"text/plain","bytesReceived":99,"headersSize":99,"bodySize":0,"content":{"size":0}}}}
[task 2026-01-18T23:27:48.312+00:00] PID 730 | 1768778868312	RemoteAgent	TRACE	WebDriverProcessData actor created for PID 17871
[task 2026-01-18T23:27:48.313+00:00] PID 730 | 1768778868313	RemoteAgent	DEBUG	WebDriverBiDiConnection db5dbc6b-3411-4c2f-9a56-0980a0c36f21 <- {"type":"success","id":2711,"result":{"realm":"6fe69286-507d-40a7-9230-dd66eb0e9149","type":"success","result":{"type":"undefined"}}}
[task 2026-01-18T23:27:48.313+00:00] PID 730 | 1768778868313	RemoteAgent	TRACE	Received command network._setDecodedBodySize for destination ROOT
[task 2026-01-18T23:27:48.313+00:00] PID 730 | 1768778868313	RemoteAgent	TRACE	network.interceptEvent returned null, skipping event: network._beforeStopRequest, data: [object Object]
[task 2026-01-18T23:27:48.411+00:00] TEST-UNEXPECTED-FAIL | Page Page.waitForNetworkIdle should work with delayed response (page.spec.js) | expected PASS

Here we have a 300ms delay before serving the content as expected and the 100ms delay for the networkidle. Maybe the check needs to be >= 400ms?

I've spoken with Alex from Puppeteer and based on his reply it should indeed by >= 400ms. Lets fix it in mozilla-central and provide an upstream PR.

Assignee: nobody → hskupin
Status: NEW → ASSIGNED
Assignee: hskupin → nobody
Status: ASSIGNED → NEW
Assignee: nobody → hskupin
Status: NEW → ASSIGNED
Points: --- → 1
Whiteboard: [webdriver:m19]
Pushed by hskupin@mozilla.com: https://github.com/mozilla-firefox/firefox/commit/8f70c0cf2b24 https://hg.mozilla.org/integration/autoland/rev/c29e19946fb4 [puppeteer] Fix test "Page.waitForNetworkIdle should work with delayed response" to wait for 400ms or greater. r=Sasha
Status: ASSIGNED → RESOLVED
Closed: 1 month ago
Resolution: --- → FIXED
Target Milestone: --- → 149 Branch
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: