Closed Bug 1770849 Opened 3 years ago Closed 2 years ago

Intermittent remote/cdp/test/browser/page/browser_navigate.js | Page.navigate does not return a loaderId for same document navigation -

Categories

(Remote Protocol :: CDP, defect, P5)

defect

Tracking

(firefox-esr91 unaffected, firefox100 unaffected, firefox101 unaffected, firefox102 wontfix, firefox103 wontfix)

RESOLVED DUPLICATE of bug 1776024
Tracking Status
firefox-esr91 --- unaffected
firefox100 --- unaffected
firefox101 --- unaffected
firefox102 --- wontfix
firefox103 --- wontfix

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug, Regression)

Details

(Keywords: intermittent-failure, regression)

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


[task 2022-05-23T19:42:33.290Z] 19:42:33     INFO - TEST-PASS | remote/cdp/test/browser/page/browser_navigate.js | Expected URL loaded - 
[task 2022-05-23T19:42:33.291Z] 19:42:33     INFO - CDP client closed
[task 2022-05-23T19:42:33.291Z] 19:42:33     INFO - Leaving test bound testAbout
[task 2022-05-23T19:42:33.292Z] 19:42:33     INFO - Entering test bound testSameDocumentNavigation
[task 2022-05-23T19:42:33.292Z] 19:42:33     INFO - Buffered messages logged at 19:42:31
[task 2022-05-23T19:42:33.293Z] 19:42:33     INFO - CDP client instantiated
[task 2022-05-23T19:42:33.293Z] 19:42:33     INFO - TEST-PASS | remote/cdp/test/browser/page/browser_navigate.js | Page.navigate returns loaderId - 
[task 2022-05-23T19:42:33.294Z] 19:42:33     INFO - Check that Page.navigate can navigate to an anchor
[task 2022-05-23T19:42:33.294Z] 19:42:33     INFO - Buffered messages finished
[task 2022-05-23T19:42:33.295Z] 19:42:33     INFO - TEST-UNEXPECTED-FAIL | remote/cdp/test/browser/page/browser_navigate.js | Page.navigate does not return a loaderId for same document navigation - 
[task 2022-05-23T19:42:33.296Z] 19:42:33     INFO - Stack trace:
[task 2022-05-23T19:42:33.296Z] 19:42:33     INFO - chrome://mochikit/content/browser-test.js:test_ok:1394
[task 2022-05-23T19:42:33.296Z] 19:42:33     INFO - chrome://mochitests/content/browser/remote/cdp/test/browser/page/browser_navigate.js:testSameDocumentNavigation:275
[task 2022-05-23T19:42:33.297Z] 19:42:33     INFO - TEST-PASS | remote/cdp/test/browser/page/browser_navigate.js | Page.navigate returned the expected frame id - 
[task 2022-05-23T19:42:33.298Z] 19:42:33     INFO - TEST-PASS | remote/cdp/test/browser/page/browser_navigate.js | navigatedWithinDocument returns the expected frameId - 
[task 2022-05-23T19:42:33.299Z] 19:42:33     INFO - TEST-PASS | remote/cdp/test/browser/page/browser_navigate.js | navigatedWithinDocument returns the expected url - 
[task 2022-05-23T19:42:33.299Z] 19:42:33     INFO - TEST-PASS | remote/cdp/test/browser/page/browser_navigate.js | Expected URL loaded - 
[task 2022-05-23T19:42:33.300Z] 19:42:33     INFO - Check that navigating to the same hash URL does not timeout
[task 2022-05-23T19:42:33.301Z] 19:42:33     INFO - GECKO(5894) | 1653334951845	CDP	TRACE	CDPConnection 1af524bb-6a40-4598-9b5d-39b56abe2fdf -> {
[task 2022-05-23T19:42:33.301Z] 19:42:33     INFO - GECKO(5894) | 	"id": 5,
[task 2022-05-23T19:42:33.302Z] 19:42:33     INFO - GECKO(5894) | 	"method": "Page.navigate",
[task 2022-05-23T19:42:33.302Z] 19:42:33     INFO - GECKO(5894) | 	"params": {
[task 2022-05-23T19:42:33.303Z] 19:42:33     INFO - GECKO(5894) | 		"url": "https://example.com/browser/remote/cdp/test/browser/page/doc_empty.html#hash"
[task 2022-05-23T19:42:33.303Z] 19:42:33     INFO - GECKO(5894) | 	}
[task 2022-05-23T19:42:33.303Z] 19:42:33     INFO - GECKO(5894) | }
[task 2022-05-23T19:42:33.304Z] 19:42:33     INFO - GECKO(5894) | 1653334951845	CDP	TRACE	CDPConnection 1af524bb-6a40-4598-9b5d-39b56abe2fdf <- {
[task 2022-05-23T19:42:33.305Z] 19:42:33     INFO - GECKO(5894) | 	"id": 5,
[task 2022-05-23T19:42:33.305Z] 19:42:33     INFO - GECKO(5894) | 	"result": {
[task 2022-05-23T19:42:33.306Z] 19:42:33     INFO - GECKO(5894) | 		"frameId": "275"
[task 2022-05-23T19:42:33.306Z] 19:42:33     INFO - GECKO(5894) | 	}
[task 2022-05-23T19:42:33.307Z] 19:42:33     INFO - GECKO(5894) | }
[task 2022-05-23T19:42:33.307Z] 19:42:33     INFO - TEST-PASS | remote/cdp/test/browser/page/browser_navigate.js | Page.navigate does not return a loaderId for same document navigation - 

:jdescottes, since you are the author of the regressor, bug 1636453, could you take a look?
For more information, please visit auto_nag documentation.

Flags: needinfo?(jdescottes)

Set release status flags based on info from the regressing bug 1636453

I triggered some more jobs and it looks like it might be a low intermittent failure:
https://treeherder.mozilla.org/jobs?repo=autoland&revision=ad7a8c63d82003c8e359924bedaf4815d4b7cdd0&searchStr=tv%2Clinux%2Copt

So not sure if it makes sense to spend the time to immediately investigate and fix it. I'll leave the needinfo for Julian to decide.

Let's keep an eye on this. I analyzed the log of the failure and the navigate call which incorrectly returns a loader id actually returns the following payload:

[task 2022-05-23T19:42:33.070Z] 19:42:33     INFO - GECKO(5894) | 1653334951828 CDP TRACE CDPConnection 1af524bb-6a40-4598-9b5d-39b56abe2fdf <- {
[task 2022-05-23T19:42:33.070Z] 19:42:33     INFO - GECKO(5894) |   "id": 4,
[task 2022-05-23T19:42:33.071Z] 19:42:33     INFO - GECKO(5894) |   "result": {
[task 2022-05-23T19:42:33.072Z] 19:42:33     INFO - GECKO(5894) |     "frameId": "275",
[task 2022-05-23T19:42:33.072Z] 19:42:33     INFO - GECKO(5894) |     "loaderId": "12657268621626",
[task 2022-05-23T19:42:33.073Z] 19:42:33     INFO - GECKO(5894) |     "errorText": "NS_ERROR_FAILURE"
[task 2022-05-23T19:42:33.074Z] 19:42:33     INFO - GECKO(5894) |   }
[task 2022-05-23T19:42:33.074Z] 19:42:33     INFO - GECKO(5894) | }

So it's not as if we are returning a loaderId for a usual hash navigation, but the navigation actually crashes, and therefore we get a loaderId. I don't see any other error message in the logs which would explain why the navigation failed, but at least this means the logic added in bug 1636453 is fine, and this is rather a navigation / test issue.

Flags: needinfo?(jdescottes)

Started happening on tier 1 jobs on central

Summary: Intermittent TV-fis remote/cdp/test/browser/page/browser_navigate.js | Page.navigate does not return a loaderId for same document navigation - → Intermittent remote/cdp/test/browser/page/browser_navigate.js | Page.navigate does not return a loaderId for same document navigation -
Has Regression Range: --- → yes

Set release status flags based on info from the regressing bug 1636453

Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.