Intermittent Page Page.waitForNetworkIdle should work with delayed response (page.spec.js) | expected PASS
Categories
(Remote Protocol :: WebDriver BiDi, defect, P5)
Tracking
(firefox149 fixed)
| 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)
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Comment 3•1 month ago
|
||
I think this should be in Remote Protocol
| Assignee | ||
Comment 4•1 month ago
|
||
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.
| Assignee | ||
Comment 5•1 month ago
|
||
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?
| Assignee | ||
Comment 6•1 month ago
|
||
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 | ||
Comment 7•1 month ago
|
||
Updated•1 month ago
|
| Assignee | ||
Comment 8•1 month ago
|
||
Upstream PR is at https://github.com/puppeteer/puppeteer/pull/14623
| Assignee | ||
Updated•1 month ago
|
| Assignee | ||
Updated•1 month ago
|
Comment 10•1 month ago
|
||
| bugherder | ||
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Description
•