Closed Bug 1755883 Opened 4 years ago Closed 4 years ago

Intermittent TV devtools/client/netmonitor/test/browser_net_open_request_in_tab.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. -

Categories

(DevTools :: Netmonitor, defect, P5)

Product:
DevTools
Component:
Netmonitor
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=368210117&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/HN2laOIHRKK6XDsL4QRIKQ/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/HN2laOIHRKK6XDsL4QRIKQ/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

[task 2022-02-17T10:22:08.941Z] 10:22:08     INFO - TEST-PASS | devtools/client/netmonitor/test/browser_net_open_request_in_tab.js | The main process DevToolsServer has no pending connection when the test ends - 
[task 2022-02-17T10:22:08.941Z] 10:22:08     INFO - finish() was called, cleaning up...
[task 2022-02-17T10:22:08.942Z] 10:22:08     INFO - Buffered messages finished
[task 2022-02-17T10:22:08.942Z] 10:22:08     INFO - TEST-UNEXPECTED-FAIL | devtools/client/netmonitor/test/browser_net_open_request_in_tab.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. - 
[task 2022-02-17T10:22:08.943Z] 10:22:08     INFO - GECKO(4384) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2022-02-17T10:22:08.943Z] 10:22:08     INFO - GECKO(4384) | MEMORY STAT | vsize 7889MB | residentFast 325MB | heapAllocated 135MB
[task 2022-02-17T10:22:08.943Z] 10:22:08     INFO - TEST-OK | devtools/client/netmonitor/test/browser_net_open_request_in_tab.js | took 61191ms
[task 2022-02-17T10:22:08.944Z] 10:22:08     INFO - checking window state
[task 2022-02-17T10:22:08.944Z] 10:22:08     INFO - GECKO(4384) | Completed ShutdownLeaks collections in process 4384
[task 2022-02-17T10:22:08.944Z] 10:22:08     INFO - TEST-START | Shutdown
[task 2022-02-17T10:22:08.944Z] 10:22:08     INFO - Browser Chrome Test Summary
[task 2022-02-17T10:22:08.945Z] 10:22:08     INFO - Passed:  10
[task 2022-02-17T10:22:08.945Z] 10:22:08     INFO - Failed:  1
[task 2022-02-17T10:22:08.945Z] 10:22:08     INFO - Todo:    0
[task 2022-02-17T10:22:08.945Z] 10:22:08     INFO - Mode:    e10s
[task 2022-02-17T10:22:08.946Z] 10:22:08     INFO - *** End BrowserChrome Test Results ***
[task 2022-02-17T10:22:08.946Z] 10:22:08     INFO - GECKO(4384) | Exiting due to channel error.
[task 2022-02-17T10:22:08.946Z] 10:22:08     INFO - GECKO(4384) | Exiting due to channel error.
[task 2022-02-17T10:22:08.946Z] 10:22:08     INFO - GECKO(4384) | Exiting due to channel error.
[task 2022-02-17T10:22:08.947Z] 10:22:08     INFO - GECKO(4384) | Exiting due to channel error.
[task 2022-02-17T10:22:09.107Z] 10:22:09     INFO - TEST-INFO | Main app process: exit 0
[task 2022-02-17T10:22:09.107Z] 10:22:09     INFO - runtests.py | Application ran for: 0:01:32.266717
[task 2022-02-17T10:22:09.108Z] 10:22:09     INFO - zombiecheck | Reading PID log: /var/folders/wq/chw748g50ds4104qggrq41pc000014/T/tmp00r357h7pidlog
[task 2022-02-17T10:22:09.108Z] 10:22:09     INFO - ==> process 4384 launched child process 4391
[task 2022-02-17T10:22:09.109Z] 10:22:09     INFO - ==> process 4384 launched child process 4392
[task 2022-02-17T10:22:09.109Z] 10:22:09     INFO - ==> process 4384 launched child process 4401
[task 2022-02-17T10:22:09.110Z] 10:22:09     INFO - ==> process 4384 launched child process 4408
[task 2022-02-17T10:22:09.110Z] 10:22:09     INFO - ==> process 4384 launched child process 4409
[task 2022-02-17T10:22:09.111Z] 10:22:09     INFO - ==> process 4384 launched child process 4414
[task 2022-02-17T10:22:09.111Z] 10:22:09     INFO - ==> process 4384 launched child process 4419
[task 2022-02-17T10:22:09.111Z] 10:22:09     INFO - ==> process 4384 launched child process 4420
[task 2022-02-17T10:22:09.112Z] 10:22:09     INFO - ==> process 4384 launched child process 4425
[task 2022-02-17T10:22:09.112Z] 10:22:09     INFO - ==> process 4384 launched child process 4426
[task 2022-02-17T10:22:09.112Z] 10:22:09     INFO - ==> process 4384 launched child process 4432
[task 2022-02-17T10:22:09.113Z] 10:22:09     INFO - ==> process 4384 launched child process 4433
[task 2022-02-17T10:22:09.113Z] 10:22:09     INFO - ==> process 4384 launched child process 4438
[task 2022-02-17T10:22:09.113Z] 10:22:09     INFO - ==> process 4384 launched child process 4439
[task 2022-02-17T10:22:09.114Z] 10:22:09     INFO - ==> process 4384 launched child process 4444
[task 2022-02-17T10:22:09.114Z] 10:22:09     INFO - ==> process 4384 launched child process 4451
[task 2022-02-17T10:22:09.115Z] 10:22:09     INFO - ==> process 4384 launched child process 4452
[task 2022-02-17T10:22:09.115Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4419
[task 2022-02-17T10:22:09.115Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4420
[task 2022-02-17T10:22:09.116Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4451
[task 2022-02-17T10:22:09.116Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4452
[task 2022-02-17T10:22:09.116Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4391
[task 2022-02-17T10:22:09.117Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4392
[task 2022-02-17T10:22:09.117Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4425
[task 2022-02-17T10:22:09.117Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4426
[task 2022-02-17T10:22:09.118Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4432
[task 2022-02-17T10:22:09.118Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4401
[task 2022-02-17T10:22:09.118Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4433
[task 2022-02-17T10:22:09.118Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4438
[task 2022-02-17T10:22:09.119Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4439
[task 2022-02-17T10:22:09.119Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4408
[task 2022-02-17T10:22:09.119Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4409
[task 2022-02-17T10:22:09.120Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4444
[task 2022-02-17T10:22:09.120Z] 10:22:09     INFO - zombiecheck | Checking for orphan process with PID: 4414
[task 2022-02-17T10:22:09.120Z] 10:22:09     INFO - Stopping web server
[task 2022-02-17T10:22:09.121Z] 10:22:09     INFO - Server shut down.
[task 2022-02-17T10:22:09.284Z] 10:22:09     INFO - Web server killed.
[task 2022-02-17T10:22:09.285Z] 10:22:09     INFO - Stopping web socket server
[task 2022-02-17T10:22:09.310Z] 10:22:09     INFO - Stopping ssltunnel
[task 2022-02-17T10:22:09.460Z] 10:22:09  WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2022-02-17T10:22:09.461Z] 10:22:09     INFO - runtests.py | Running tests: end.
[task 2022-02-17T10:22:09.483Z] 10:22:09     INFO - Buffered messages finished
[task 2022-02-17T10:22:09.484Z] 10:22:09     INFO -  TEST-INFO | checking window state
[task 2022-02-17T10:22:09.484Z] 10:22:09     INFO -  Browser Chrome Test Summary
[task 2022-02-17T10:22:09.484Z] 10:22:09     INFO -  	Passed: 160
[task 2022-02-17T10:22:09.484Z] 10:22:09     INFO -  	Failed: 1
[task 2022-02-17T10:22:09.484Z] 10:22:09     INFO -  	Todo: 0
[task 2022-02-17T10:22:09.485Z] 10:22:09     INFO -  	Mode: e10s
[task 2022-02-17T10:22:09.485Z] 10:22:09     INFO -  *** End BrowserChrome Test Results ***
[task 2022-02-17T10:22:09.485Z] 10:22:09     INFO - Buffered messages finished
[task 2022-02-17T10:22:09.485Z] 10:22:09     INFO - SUITE-END | took 93s
[task 2022-02-17T10:22:09.486Z] 10:22:09     INFO - SUITE-START | Running 1 tests
[task 2022-02-17T10:22:09.486Z] 10:22:09     INFO - :::
[task 2022-02-17T10:22:09.486Z] 10:22:09     INFO - ::: Test verification summary for:
[task 2022-02-17T10:22:09.487Z] 10:22:09     INFO - :::
[task 2022-02-17T10:22:09.487Z] 10:22:09     INFO - ::: devtools/client/netmonitor/test/browser_net_open_request_in_tab.js
[task 2022-02-17T10:22:09.487Z] 10:22:09     INFO - :::
[task 2022-02-17T10:22:09.488Z] 10:22:09     INFO - ::: 1. Run each test 10 times in one browser. : Pass
[task 2022-02-17T10:22:09.488Z] 10:22:09     INFO - ::: 2. Run each test 5 times in a new browser each time. : Pass
[task 2022-02-17T10:22:09.489Z] 10:22:09     INFO - ::: 3. Run each test 10 times in one browser, in chaos mode. : FAIL
[task 2022-02-17T10:22:09.489Z] 10:22:09     INFO - ::: 4. Run each test 5 times in a new browser each time, in chaos mode. : not run / incomplete
[task 2022-02-17T10:22:09.489Z] 10:22:09     INFO - :::
[task 2022-02-17T10:22:09.490Z] 10:22:09     INFO - ::: Test verification FAILED!
[task 2022-02-17T10:22:09.490Z] 10:22:09     INFO - :::
[task 2022-02-17T10:22:09.490Z] 10:22:09     INFO - Buffered messages finished
[task 2022-02-17T10:22:09.490Z] 10:22:09     INFO - SUITE-END | took 0s
[task 2022-02-17T10:22:09.661Z] 10:22:09     INFO - Return code: 0
[task 2022-02-17T10:22:09.661Z] 10:22:09    ERROR - Got 1 unexpected statuses

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

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