Closed Bug 1684185 Opened 5 years ago Closed 5 years ago

Intermittent TEST-UNEXPECTED-FAIL | damp | netmonitor/cold-open.js: Test timed out

Categories

(Testing :: Talos, defect, P5)

Product:
Testing
Component:
Talos
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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

[task 2020-12-24T20:00:03.866Z] 20:00:03     INFO -  PID 7136 | Handler function _httpStopRequest threw an exception: [Exception... "Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsITraceableChannel.setNewListener]"  nsresult: "0x80004005 (NS_ERROR_FAILURE)"  location: "JS frame :: resource://devtools/server/actors/network-monitor/network-observer.js :: _setupResponseListener :: line 1086"  data: no]
[task 2020-12-24T20:00:03.867Z] 20:00:03     INFO -  PID 7136 | Stack: _setupResponseListener@resource://devtools/server/actors/network-monitor/network-observer.js:1086:38
[task 2020-12-24T20:00:03.867Z] 20:00:03     INFO -  PID 7136 | _createNetworkEvent@resource://devtools/server/actors/network-monitor/network-observer.js:912:12
[task 2020-12-24T20:00:03.867Z] 20:00:03     INFO -  PID 7136 | _httpStopRequest@resource://devtools/server/actors/network-monitor/network-observer.js:409:14
[task 2020-12-24T20:00:03.867Z] 20:00:03     INFO -  PID 7136 | exports.makeInfallible/<@resource://devtools/shared/ThreadSafeDevToolsUtils.js:103:22
[task 2020-12-24T20:00:03.867Z] 20:00:03     INFO -  PID 7136 | Line: 1086, column: 0
[task 2020-12-24T20:00:03.867Z] 20:00:03     INFO -  PID 7136 | console.error: ({})
[task 2020-12-24T20:00:03.907Z] 20:00:03     INFO -  PID 7136 | Reload page on 'panelsInBackground'
[task 2020-12-24T20:00:03.907Z] 20:00:03     INFO -  PID 7136 | Wait for a pageshow event for browsing context 206
[task 2020-12-24T20:00:04.448Z] 20:00:04    ERROR -  PID 7136 | Handler function threw an exception: TypeError: can't access property "first", timings.REQUEST_HEADER is undefined
[task 2020-12-24T20:00:04.448Z] 20:00:04     INFO -  PID 7136 | Stack: _getBlockedTiming@resource://devtools/server/actors/network-monitor/network-observer.js:1226:7
[task 2020-12-24T20:00:04.448Z] 20:00:04     INFO -  PID 7136 | _setupHarTimings@resource://devtools/server/actors/network-monitor/network-observer.js:1419:31
[task 2020-12-24T20:00:04.448Z] 20:00:04     INFO -  PID 7136 | _onTransactionClose@resource://devtools/server/actors/network-monitor/network-observer.js:1210:27
[task 2020-12-24T20:00:04.448Z] 20:00:04     INFO -  PID 7136 | _dispatchActivity@resource://devtools/server/actors/network-monitor/network-observer.js:632:14
[task 2020-12-24T20:00:04.448Z] 20:00:04     INFO -  PID 7136 | NetworkObserver.prototype.observeActivity<@resource://devtools/server/actors/network-monitor/network-observer.js:738:12
[task 2020-12-24T20:00:04.448Z] 20:00:04     INFO -  PID 7136 | exports.makeInfallible/<@resource://devtools/shared/ThreadSafeDevToolsUtils.js:103:22
[task 2020-12-24T20:00:04.448Z] 20:00:04     INFO -  PID 7136 | Line: 1226, column: 7
[task 2020-12-24T20:00:04.449Z] 20:00:04     INFO -  PID 7136 | console.error: (new TypeError("can't access property \"first\", timings.REQUEST_HEADER is undefined", "resource://devtools/server/actors/network-monitor/network-observer.js", 1226))
[task 2020-12-24T20:00:05.034Z] 20:00:05     INFO -  PID 7136 | Received pageshow event for 206
[task 2020-12-24T20:00:05.034Z] 20:00:05     INFO -  PID 7136 | Wait for pending paints on 'panelsInBackground.reload'
[task 2020-12-24T20:00:05.034Z] 20:00:05     INFO -  PID 7136 | 'panelsInBackground.reload.settle.DAMP' took 0.09181880769028794ms.
[task 2020-12-24T20:00:05.073Z] 20:00:05     INFO -  PID 7136 | Garbage collect
[task 2020-12-24T20:00:06.161Z] 20:00:06     INFO -  PID 7136 | toolbox/panels-in-background.js took 3509ms.
[task 2020-12-24T20:00:06.162Z] 20:00:06     INFO -  PID 7136 | Loading test 'server/protocol.js'
[task 2020-12-24T20:00:06.164Z] 20:00:06     INFO -  PID 7136 | Executing test 'server/protocol.js'
[task 2020-12-24T20:00:06.174Z] 20:00:06     INFO -  PID 7136 | Wait for a pageshow event for browsing context 213
[task 2020-12-24T20:00:06.245Z] 20:00:06     INFO -  PID 7136 | Received pageshow event for 213
[task 2020-12-24T20:00:06.343Z] 20:00:06     INFO -  PID 7136 | Open toolbox on 'options'
[task 2020-12-24T20:00:06.343Z] 20:00:06     INFO -  PID 7136 | Open toolbox - Wait for tab target
[task 2020-12-24T20:00:06.348Z] 20:00:06     INFO -  PID 7136 | Open toolbox - Call showToolbox
[task 2020-12-24T20:00:06.348Z] 20:00:06     INFO -  PID 7136 | Open toolbox - Wait for "toolbox-created"
[task 2020-12-24T20:00:06.353Z] 20:00:06     INFO -  PID 7136 | Open toolbox - Wait for showToolbox to resolve
[task 2020-12-24T20:00:08.990Z] 20:00:08     INFO -  PID 7136 | Garbage collect
[task 2020-12-24T20:00:09.391Z] 20:00:09     INFO -  PID 7136 | server/protocol.js took 3224ms.
[task 2020-12-24T20:00:09.396Z] 20:00:09     INFO -  PID 7136 | DAMP_RESULTS_JSON=[{"name":"cold.inspector.open.DAMP","value":617.7784422410205},{"name":"cold.jsdebugger.open.DAMP","value":742.3376522306348},{"name":"cold.webconsole.open.DAMP","value":316.27346712937833},{"name":"cold.netmonitor.open.DAMP","value":195.42694550912256},{"name":"cold.accessibility.open.DAMP","value":265.35942625874577},{"name":"simple.webconsole.open.DAMP","value":202.14644383027007},{"name":"simple.webconsole.reload.DAMP","value":157.75529297879802},{"name":"simple.webconsole.close.DAMP","value":9.866255154567625},{"name":"simple.inspector.open.DAMP","value":214.90618609590092},{"name":"simple.inspector.reload.DAMP","value":122.72966051275762},{"name":"simple.inspector.close.DAMP","value":6.99085873795957},{"name":"simple.jsdebugger.open.DAMP","value":560.5630370248255},{"name":"simple.jsdebugger.reload.DAMP","value":246.6570615319124},{"name":"simple.jsdebugger.close.DAMP","value":20.693706452200786},{"name":"simple.styleeditor.open.DAMP","value":192.5167330390359},{"name":"simple.styleeditor.reload.DAMP","value":19.068274622202807},{"name":"simple.styleeditor.close.DAMP","value":4.981767651994232},{"name":"simple.netmonitor.open.DAMP","value":144.47842991886864},{"name":"simple.netmonitor.reload.DAMP","value":22.58708536042832},{"name":"simple.netmonitor.requestsFinished.DAMP","value":191.889702742581},{"name":"simple.netmonitor.exportHar","value":21.130955123811873},{"name":"simple.netmonitor.close.DAMP","value":8.462007664311386},{"name":"simple.accessibility.open.DAMP","value":299.4180599061401},{"name":"simple.accessibility.reload.DAMP","value":104.95333454165302},{"name":"simple.accessibility.close.DAMP","value":6.77001573207599},{"name":"complicated.webconsole.open.DAMP","value":297.1645737781182},{"name":"complicated.webconsole.reload.DAMP","value":1826.1549116406095},{"name":"complicated.webconsole.close.DAMP","value":28.861484331242536},{"name":"complicated.inspector.open.DAMP","value":371.7159842890869},{"name":"complicated.inspector.reload.DAMP","value":719.01772307789},{"name":"complicated.inspector.close.DAMP","value":28.057643096537504},{"name":"complicated.jsdebugger.open.DAMP","value":1061.6923400927662},{"name":"complicated.jsdebugger.reload.DAMP","value":1235.2462706716033},{"name":"complicated.jsdebugger.close.DAMP","value":47.6184624752932},{"name":"complicated.styleeditor.open.DAMP","value":677.2459682498011},{"name":"complicated.styleeditor.reload.DAMP","value":1842.5556621654905},{"name":"complicated.styleeditor.close.DAMP","value":27.953536269968026},{"name":"complicated.netmonitor.open.DAMP","value":162.04449423367623},{"name":"complicated.netmonitor.reload.DAMP","value":2513.2009162766117},{"name":"complicated.netmonitor.requestsFinished.DAMP","value":3633.1545085253238},{"name":"complicated.netmonitor.exportHar","value":569.1417808684419},{"name":"complicated.netmonitor.responsePanel.html","value":344.49392647600325},{"name":"complicated.netmonitor.responsePanel.editor","value":2635.527461503516},{"name":"complicated.netmonitor.close.DAMP","value":55.99616067677562},{"name":"custom.webconsole.open.DAMP","value":2383.4114475866445},{"name":"custom.webconsole.reload.DAMP","value":16243.36933381531},{"name":"custom.webconsole.close.DAMP","value":214.74814851980773},{"name":"custom.inspector.open.DAMP","value":416.1911032695498},{"name":"custom.inspector.reload.DAMP","value":651.3810538546386},{"name":"custom.inspector.manyrules.selectnode","value":605.0378146714065},{"name":"custom.inspector.manyrules.deselectnode","value":169.66033526493993},{"name":"custom.inspector.manycssvariables.selectnode","value":280.2634278179612},{"name":"custom.inspector.expandall.manychildren","value":137.49098451947793},{"name":"custom.inspector.collapseall.manychildren","value":0.7031477467098739},{"name":"custom.inspector.expandall.balanced","value":739.809051013377},{"name":"custom.inspector.collapseall.balanced","value":10.637328338940279},{"name":"custom.inspector.close.DAMP","value":53.444007423342555},{"name":"custom.jsdebugger.open.DAMP","value":1017.4878988614219},{"name":"custom.jsdebugger.reload.DAMP","value":839.3420038959885},{"name":"custom.jsdebugger.pause.DAMP","value":183.3164202406915},{"name":"custom.jsdebugger.stepIn.DAMP","value":989.979120607939},{"name":"custom.jsdebugger.stepOver.DAMP","value":304.23257396790723},{"name":"custom.jsdebugger.stepOut.DAMP","value":448.1191309776623},{"name":"custom.jsdebugger.project-search.DAMP","value":1764.3987421164784},{"name":"custom.jsdebugger.preview.DAMP","value":547.1830911398865},{"name":"custom.jsdebugger.close.DAMP","value":48.5748799443536},{"name":"console.bulklog","value":1444.8723633239424},{"name":"console.autocomplete","value":785.9362258647016},{"name":"console.autocomplete.longInput","value":1125.8910947020631},{"name":"console.streamlog","value":16},{"name":"console.objectexpand","value":368.12071476674464},{"name":"console.objectexpanded.close.DAMP","value":18.442268327329657},{"name":"console.openwithcache.open.DAMP","value":387.213565426704},{"name":"console.typing","value":509.6206654440175},{"name":"inspector.mutations","value":873.3422694537294},{"name":"inspector.layout.open","value":222.78383019597095},{"name":"panelsInBackground.reload.DAMP","value":1131.3578977657162},{"name":"server.protocoljs.DAMP","value":2503.3175944291434}]
[task 2020-12-24T20:00:09.396Z] 20:00:09     INFO -  PID 7136 |
[task 2020-12-24T20:00:09.397Z] 20:00:09     INFO -  PID 7136 | cold.inspector.open.DAMP: 617.8
[task 2020-12-24T20:00:09.397Z] 20:00:09     INFO -  PID 7136 | cold.jsdebugger.open.DAMP: 742.3
[task 2020-12-24T20:00:09.397Z] 20:00:09     INFO -  PID 7136 | cold.webconsole.open.DAMP: 316.3```

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

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