Closed Bug 1791991 Opened 2 years ago Closed 2 years ago

Intermittent devtools/client/netmonitor/src/har/test/browser_net_har_copy_all_as_har.js | single tracking bug

Categories

(DevTools :: Netmonitor, defect, P5)

Product:
DevTools
Component:
Netmonitor
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure, intermittent-testcase, Whiteboard: [retriggered])

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

[task 2022-09-22T10:24:49.781Z] 10:24:49     INFO - TEST-PASS | devtools/client/netmonitor/src/har/test/browser_net_har_copy_all_as_har.js | Response body must not be truncated - 
[task 2022-09-22T10:24:49.782Z] 10:24:49     INFO - Navigating to "http://example.com/browser/devtools/client/netmonitor/test/html_simple-test-page.html"
[task 2022-09-22T10:24:49.783Z] 10:24:49     INFO - Waiting for page to be loaded…
[task 2022-09-22T10:24:49.784Z] 10:24:49     INFO - Navigating to "http://example.com/browser/devtools/client/netmonitor/test/html_simple-test-page.html"
[task 2022-09-22T10:24:49.785Z] 10:24:49     INFO - Waiting for page to be loaded…
[task 2022-09-22T10:24:49.786Z] 10:24:49     INFO - > Network event progress: NetworkEvent: 0/1, PayloadReady: 1/1, EventTimings: 0/0, got NetMonitor:PayloadReady for server0.conn0.netEvent83
[task 2022-09-22T10:24:49.787Z] 10:24:49     INFO - > Network event progress: NetworkEvent: 1/1, PayloadReady: 1/1, EventTimings: 0/0, got NetMonitor:NetworkEvent for server0.conn0.netEvent83
[task 2022-09-22T10:24:49.788Z] 10:24:49     INFO - Console message: [JavaScript Error: "Error: Error while calling method getRequestCookies: No such actor for ID: server0.conn0.netEvent83" {file: "resource://devtools/client/netmonitor/src/connector/firefox-data-provider.js" line: 641}]
[task 2022-09-22T10:24:49.789Z] 10:24:49     INFO - Console message: [JavaScript Error: "Error: Error while calling method getRequestCookies: No such actor for ID: server0.conn0.netEvent83" {file: "resource://devtools/client/netmonitor/src/connector/firefox-data-provider.js" line: 641}]
[task 2022-09-22T10:24:49.790Z] 10:24:49     INFO - → page loaded
[task 2022-09-22T10:24:49.791Z] 10:24:49     INFO - Wait for the toolbox to reload
[task 2022-09-22T10:24:49.792Z] 10:24:49     INFO - Waiting for toolbox commands to be reloaded…
[task 2022-09-22T10:24:49.793Z] 10:24:49     INFO - Waiting for target switch…
[task 2022-09-22T10:24:49.794Z] 10:24:49     INFO - → page loaded
[task 2022-09-22T10:24:49.795Z] 10:24:49     INFO - Wait for the toolbox to reload
[task 2022-09-22T10:24:49.796Z] 10:24:49     INFO - Waiting for toolbox commands to be reloaded…
[task 2022-09-22T10:24:49.796Z] 10:24:49     INFO - Waiting for target switch…
[task 2022-09-22T10:24:49.797Z] 10:24:49     INFO - Buffered messages logged at 10:24:49
[task 2022-09-22T10:24:49.798Z] 10:24:49     INFO - → switched-target emitted
[task 2022-09-22T10:24:49.799Z] 10:24:49     INFO - Waiting for 'dom-complete' resource…
[task 2022-09-22T10:24:49.800Z] 10:24:49     INFO - → switched-target emitted
[task 2022-09-22T10:24:49.801Z] 10:24:49     INFO - Waiting for 'dom-complete' resource…
[task 2022-09-22T10:24:49.802Z] 10:24:49     INFO - → 'dom-complete' resource emitted
[task 2022-09-22T10:24:49.803Z] 10:24:49     INFO - → 'dom-complete' resource emitted
[task 2022-09-22T10:24:49.804Z] 10:24:49     INFO - Waiting for netmonitor to be reloaded…
[task 2022-09-22T10:24:49.805Z] 10:24:49     INFO - Waiting for netmonitor updates after page reload
[task 2022-09-22T10:24:49.806Z] 10:24:49     INFO - Waiting for netmonitor to be reloaded…
[task 2022-09-22T10:24:49.807Z] 10:24:49     INFO - Waiting for netmonitor updates after page reload
[task 2022-09-22T10:24:49.808Z] 10:24:49     INFO - → panel reloaded
[task 2022-09-22T10:24:49.809Z] 10:24:49     INFO - → panel reloaded
[task 2022-09-22T10:24:49.814Z] 10:24:49     INFO - Wait for Responsive UI to reload
[task 2022-09-22T10:24:49.815Z] 10:24:49     INFO - Wait for Responsive UI to reload
[task 2022-09-22T10:24:49.816Z] 10:24:49     INFO - Waiting for network events
[task 2022-09-22T10:24:49.817Z] 10:24:49     INFO - Waiting for DOCUMENT_EVENT dom-complete resource
[task 2022-09-22T10:24:49.818Z] 10:24:49     INFO - TEST-PASS | devtools/client/netmonitor/src/har/test/browser_net_har_copy_all_as_har.js | There must be at least one request - 
[task 2022-09-22T10:24:49.819Z] 10:24:49     INFO - Assert the first navigation request which has been cancelled by the second reload
[task 2022-09-22T10:24:49.820Z] 10:24:49     INFO - Buffered messages finished
[task 2022-09-22T10:24:49.822Z] 10:24:49     INFO - TEST-UNEXPECTED-FAIL | devtools/client/netmonitor/src/har/test/browser_net_har_copy_all_as_har.js | Found the cancelled request - 
[task 2022-09-22T10:24:49.822Z] 10:24:49     INFO - Stack trace:
[task 2022-09-22T10:24:49.822Z] 10:24:49     INFO - chrome://mochikit/content/browser-test.js:test_ok:1457
[task 2022-09-22T10:24:49.822Z] 10:24:49     INFO - chrome://mochitests/content/browser/devtools/client/netmonitor/src/har/test/browser_net_har_copy_all_as_har.js:testManyReloads:94
[task 2022-09-22T10:24:49.823Z] 10:24:49     INFO - chrome://mochitests/content/browser/devtools/client/netmonitor/src/har/test/browser_net_har_copy_all_as_har.js:null:26
[task 2022-09-22T10:24:49.824Z] 10:24:49     INFO - chrome://mochikit/content/browser-test.js:handleTask:1045
[task 2022-09-22T10:24:49.824Z] 10:24:49     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1117
[task 2022-09-22T10:24:49.825Z] 10:24:49     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1252
[task 2022-09-22T10:24:49.825Z] 10:24:49     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1034
[task 2022-09-22T10:24:49.825Z] 10:24:49     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1038
[task 2022-09-22T10:24:49.827Z] 10:24:49     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-09-22T10:24:49.829Z] 10:24:49     INFO - TEST-UNEXPECTED-FAIL | devtools/client/netmonitor/src/har/test/browser_net_har_copy_all_as_har.js | Uncaught exception in test - at chrome://mochitests/content/browser/devtools/client/netmonitor/src/har/test/browser_net_har_copy_all_as_har.js:95 - TypeError: can't access property "request", entry is undefined
[task 2022-09-22T10:24:49.829Z] 10:24:49     INFO - Stack trace:
[task 2022-09-22T10:24:49.830Z] 10:24:49     INFO - testManyReloads@chrome://mochitests/content/browser/devtools/client/netmonitor/src/har/test/browser_net_har_copy_all_as_har.js:95:3
[task 2022-09-22T10:24:49.830Z] 10:24:49     INFO - async*@chrome://mochitests/content/browser/devtools/client/netmonitor/src/har/test/browser_net_har_copy_all_as_har.js:26:9
[task 2022-09-22T10:24:49.831Z] 10:24:49     INFO - Async*handleTask@chrome://mochikit/content/browser-test.js:1045:26
[task 2022-09-22T10:24:49.831Z] 10:24:49     INFO - _runTaskBasedTest@chrome://mochikit/content/browser-test.js:1117:18
[task 2022-09-22T10:24:49.831Z] 10:24:49     INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1252:14
[task 2022-09-22T10:24:49.831Z] 10:24:49     INFO - nextTest/<@chrome://mochikit/content/browser-test.js:1034:14
[task 2022-09-22T10:24:49.832Z] 10:24:49     INFO - SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1038:13
[task 2022-09-22T10:24:49.833Z] 10:24:49     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-09-22T10:24:49.838Z] 10:24:49     INFO - TEST-UNEXPECTED-FAIL | devtools/client/netmonitor/src/har/test/browser_net_har_copy_all_as_har.js | A promise chain failed to handle a rejection: Error while calling method getRequestCookies: No such actor for ID: server0.conn0.netEvent83 - stack: _requestData@resource://devtools/client/netmonitor/src/connector/firefox-data-provider.js:641:17
[task 2022-09-22T10:24:49.838Z] 10:24:49     INFO - async*requestData@resource://devtools/client/netmonitor/src/connector/firefox-data-provider.js:545:20
[task 2022-09-22T10:24:49.838Z] 10:24:49     INFO - requestData@resource://devtools/client/netmonitor/src/connector/index.js:592:30
[task 2022-09-22T10:24:49.838Z] 10:24:49     INFO - fetchNetworkUpdatePacket/<@resource://devtools/client/netmonitor/src/utils/request-utils.js:102:23
[task 2022-09-22T10:24:49.838Z] 10:24:49     INFO - fetchNetworkUpdatePacket@resource://devtools/client/netmonitor/src/utils/request-utils.js:92:17
[task 2022-09-22T10:24:49.839Z] 10:24:49     INFO - componentDidMount@resource://devtools/client/netmonitor/src/components/request-list/RequestListColumnCookies.js:24:29
[task 2022-09-22T10:24:49.839Z] 10:24:49     INFO - commitLifeCycles@resource://devtools/client/shared/vendor/react-dom.js:12949:22
[task 2022-09-22T10:24:49.839Z] 10:24:49     INFO - commitAllLifeCycles@resource://devtools/client/shared/vendor/react-dom.js:14174:23
[task 2022-09-22T10:24:49.839Z] 10:24:49     INFO - commitRoot@resource://devtools/client/shared/vendor/react-dom.js:14380:28
[task 2022-09-22T10:24:49.839Z] 10:24:49     INFO - completeRoot/<@resource://devtools/client/shared/vendor/react-dom.js:15731:15
[task 2022-09-22T10:24:49.839Z] 10:24:49     INFO - unstable_runWithPriority@resource://devtools/client/shared/vendor/react.js:617:12
[task 2022-09-22T10:24:49.839Z] 10:24:49     INFO - completeRoot@resource://devtools/client/shared/vendor/react-dom.js:15730:27
[task 2022-09-22T10:24:49.839Z] 10:24:49     INFO - performWorkOnRoot@resource://devtools/client/shared/vendor/react-dom.js:15659:21
[task 2022-09-22T10:24:49.839Z] 10:24:49     INFO - performWork@resource://devtools/client/shared/vendor/react-dom.js:15567:24
[task 2022-09-22T10:24:49.840Z] 10:24:49     INFO - performSyncWork@resource://devtools/client/shared/vendor/react-dom.js:15541:14
[task 2022-09-22T10:24:49.840Z] 10:24:49     INFO - requestWork@resource://devtools/client/shared/vendor/react-dom.js:15410:5
[task 2022-09-22T10:24:49.840Z] 10:24:49     INFO - scheduleWork@resource://devtools/client/shared/vendor/react-dom.js:15224:16
[task 2022-09-22T10:24:49.840Z] 10:24:49     INFO - enqueueSetState@resource://devtools/client/shared/vendor/react-dom.js:8192:17
[task 2022-09-22T10:24:49.840Z] 10:24:49     INFO - Component.prototype.setState@resource://devtools/client/shared/vendor/react.js:328:16
[task 2022-09-22T10:24:49.848Z] 10:24:49     INFO - onStateChange@resource://devtools/client/shared/vendor/react-redux.js:1412:16
[task 2022-09-22T10:24:49.849Z] 10:24:49     INFO - notify@resource://devtools/client/shared/vendor/react-redux.js:1159:21
[task 2022-09-22T10:24:49.849Z] 10:24:49     INFO - notifyNestedSubs@resource://devtools/client/shared/vendor/react-redux.js:1198:20
[task 2022-09-22T10:24:49.850Z] 10:24:49     INFO - onStateChange@resource://devtools/client/shared/vendor/react-redux.js:1409:16
[task 2022-09-22T10:24:49.850Z] 10:24:49     INFO - dispatch@resource://devtools/client/shared/vendor/redux.js:265:7
[task 2022-09-22T10:24:49.850Z] 10:24:49     INFO - waitUntilService/</<@resource://devtools/client/shared/redux/middleware/wait-service.js:59:24
[task 2022-09-22T10:24:49.851Z] 10:24:49     INFO - eventTelemetryMiddleware/</</<@resource://devtools/client/netmonitor/src/middleware/event-telemetry.js:29:21
[task 2022-09-22T10:24:49.851Z] 10:24:49     INFO - throttlingMiddleware/</</<@resource://devtools/client/netmonitor/src/middleware/throttling.js:18:21
[task 2022-09-22T10:24:49.852Z] 10:24:49     INFO - batchingMiddleware/</<@resource://devtools/client/netmonitor/src/middleware/batching.js:44:15
[task 2022-09-22T10:24:49.852Z] 10:24:49     INFO - prefsMiddleware/</<@resource://devtools/client/netmonitor/src/middleware/prefs.js:26:21
[task 2022-09-22T10:24:49.853Z] 10:24:49     INFO - thunk/</</<@resource://devtools/client/shared/redux/middleware/thunk.js:18:11
[task 2022-09-22T10:24:49.854Z] 10:24:49     INFO - requestBlockingMiddleware/</</<@resource://devtools/client/netmonitor/src/middleware/request-blocking.js:39:21
[task 2022-09-22T10:24:49.854Z] 10:24:49     INFO - bindActionCreator/<@resource://devtools/client/shared/vendor/redux.js:520:12
[task 2022-09-22T10:24:49.855Z] 10:24:49     INFO - addRequest@resource://devtools/client/netmonitor/src/connector/firefox-data-provider.js:131:26
[task 2022-09-22T10:24:49.855Z] 10:24:49     INFO - onNetworkResourceAvailable@resource://devtools/client/netmonitor/src/connector/firefox-data-provider.js:432:16
[task 2022-09-22T10:24:49.856Z] 10:24:49     INFO - onResourceAvailable@resource://devtools/client/netmonitor/src/connector/index.js:213:27
[task 2022-09-22T10:24:49.856Z] 10:24:49     INFO - _notifyWatchers@resource://devtools/shared/commands/resource/resource-command.js:874:24
[task 2022-09-22T10:24:49.856Z] 10:24:49     INFO - later@resource://devtools/shared/throttle.js:33:19
[task 2022-09-22T10:24:49.856Z] 10:24:49     INFO - notify@resource://gre/modules/Timer.jsm:62:17
[task 2022-09-22T10:24:49.857Z] 10:24:49     INFO - Rejection date: Thu Sep 22 2022 10:24:48 GMT+0000 (Coordinated Universal Time) - false == true - JS frame :: resource://testing-common/PromiseTestUtils.jsm :: assertNoUncaughtRejections :: line 270

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

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