1693975 - Intermittent TEST-UNEXPECTED-FAIL | damp | netmonitor/complicated.js: Test timed out

Status: REOPENED

(DevTools :: Netmonitor, defect, P2)

Description

[Treeherder Bug Filer]

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

---

[task 2021-02-20T11:37:34.221Z] 11:37:34     INFO -  PID 22923 | Received pageshow event for 275
[task 2021-02-20T11:37:34.222Z] 11:37:34     INFO -  PID 22923 | Wait for pending paints on 'complicated.netmonitor.reload'
[task 2021-02-20T11:37:34.222Z] 11:37:34     INFO -  PID 22923 | 'complicated.netmonitor.reload.settle.DAMP' took 0.1716710000182502ms.
[task 2021-02-20T11:42:28.612Z] 11:42:28     INFO -  PID 22923 | TEST-UNEXPECTED-FAIL | damp | netmonitor/complicated.js: Test timed out
[task 2021-02-20T11:42:28.628Z] 11:42:28     INFO -  PID 22923 | [DampLoad helper] Unregister DampLoad actors
[task 2021-02-20T11:42:28.656Z] 11:42:28     INFO -  Terminating psutil.Process(pid=22923, name='firefox-bin', started='11:34:42')
[task 2021-02-20T11:42:28.683Z] 11:42:28     INFO -  PID 22923 | Exiting due to channel error.
[task 2021-02-20T11:42:28.683Z] 11:42:28     INFO -  PID 22923 | Exiting due to channel error.
[task 2021-02-20T11:42:28.683Z] 11:42:28     INFO -  PID 22923 | Exiting due to channel error.
[task 2021-02-20T11:42:28.685Z] 11:42:28     INFO -  PID 22923 | Exiting due to channel error.
[task 2021-02-20T11:42:28.742Z] 11:42:28     INFO -  mozcrash checking /tmp/tmpMOe2b7/profile/minidumps for minidumps...
[task 2021-02-20T11:42:28.742Z] 11:42:28     INFO -  TEST-UNEXPECTED-ERROR | damp | unexpected error
[task 2021-02-20T11:42:28.742Z] 11:42:28    ERROR -  Traceback (most recent call last):
[task 2021-02-20T11:42:28.742Z] 11:42:28     INFO -    File "/home/cltbld/tasks/task_1613820130/build/tests/talos/talos/run_tests.py", line 337, in run_tests
[task 2021-02-20T11:42:28.742Z] 11:42:28     INFO -      talos_results.add(mytest.runTest(browser_config, test))
[task 2021-02-20T11:42:28.742Z] 11:42:28     INFO -    File "/home/cltbld/tasks/task_1613820130/build/tests/talos/talos/ttest.py", line 65, in runTest
[task 2021-02-20T11:42:28.742Z] 11:42:28     INFO -      return self._runTest(browser_config, test_config, setup)
[task 2021-02-20T11:42:28.742Z] 11:42:28     INFO -    File "/home/cltbld/tasks/task_1613820130/build/tests/talos/talos/ttest.py", line 216, in _runTest
[task 2021-02-20T11:42:28.742Z] 11:42:28     INFO -      debugger_args=browser_config["debugger_args"],
[task 2021-02-20T11:42:28.742Z] 11:42:28     INFO -    File "/home/cltbld/tasks/task_1613820130/build/tests/talos/talos/talos_process.py", line 191, in run_browser
[task 2021-02-20T11:42:28.742Z] 11:42:28     INFO -      raise TalosError("unexpected error")
[task 2021-02-20T11:42:28.742Z] 11:42:28     INFO -  TalosError: unexpected error
[task 2021-02-20T11:42:28.742Z] 11:42:28     INFO -  TEST-INFO took 1160327ms
[task 2021-02-20T11:42:28.742Z] 11:42:28     INFO -  SUITE-END | took 1160s
[task 2021-02-20T11:42:29.036Z] 11:42:29    ERROR - Return code: 2
[task 2021-02-20T11:42:29.037Z] 11:42:29  WARNING - setting return code to 2
[task 2021-02-20T11:42:29.037Z] 11:42:29    ERROR - # TBPL FAILURE #
[task 2021-02-20T11:42:29.037Z] 11:42:29     INFO - Running post-action listener: _package_coverage_data
[task 2021-02-20T11:42:29.037Z] 11:42:29     INFO - Running post-action listener: _resource_record_post_action
[task 2021-02-20T11:42:29.038Z] 11:42:29     INFO - Running post-action listener: process_java_coverage_data
[task 2021-02-20T11:42:29.038Z] 11:42:29     INFO - [mozharness: 2021-02-20 11:42:29.038300Z] Finished run-tests step (success)
[task 2021-02-20T11:42:29.038Z] 11:42:29     INFO - Running post-run listener: _resource_record_post_run
[task 2021-02-20T11:42:29.129Z] 11:42:29     INFO - Total resource usage - Wall time: 1168s; CPU: 14.0%; Read bytes: 102285312; Write bytes: 593654272; Read time: 676; Write time: 24104
[task 2021-02-20T11:42:29.129Z] 11:42:29     INFO - TinderboxPrint: CPU usage<br/>13.6%
[task 2021-02-20T11:42:29.129Z] 11:42:29     INFO - TinderboxPrint: I/O read bytes / time<br/>102,285,312 / 676
[task 2021-02-20T11:42:29.129Z] 11:42:29     INFO - TinderboxPrint: I/O write bytes / time<br/>593,654,272 / 24,104
[task 2021-02-20T11:42:29.130Z] 11:42:29     INFO - TinderboxPrint: CPU idle<br/>7,993.1 (86.3%)
[task 2021-02-20T11:42:29.130Z] 11:42:29     INFO - TinderboxPrint: CPU system<br/>156.1 (1.7%)
[task 2021-02-20T11:42:29.130Z] 11:42:29     INFO - TinderboxPrint: CPU user<br/>1,100.0 (11.9%)
[task 2021-02-20T11:42:29.130Z] 11:42:29     INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2021-02-20T11:42:29.130Z] 11:42:29     INFO - install - Wall time: 8s; CPU: 13.0%; Read bytes: 8192; Write bytes: 4182528; Read time: 0; Write time: 4
[task 2021-02-20T11:42:29.144Z] 11:42:29     INFO - run-tests - Wall time: 1161s; CPU: 14.0%; Read bytes: 100679680; Write bytes: 587763712; Read time: 592; Write time: 23984
[task 2021-02-20T11:42:29.419Z] 11:42:29  WARNING - returning nonzero exit status 2
[taskcluster 2021-02-20T11:42:29.442Z]    Exit Code: 2
[taskcluster 2021-02-20T11:42:29.442Z]    User Time: 18m50.296s
[taskcluster 2021-02-20T11:42:29.442Z]  Kernel Time: 2m20.996s
[taskcluster 2021-02-20T11:42:29.442Z]    Wall Time: 20m17.749509179s
[taskcluster 2021-02-20T11:42:29.442Z]       Result: FAILED
[taskcluster 2021-02-20T11:42:29.442Z] === Task Finished ===
[taskcluster 2021-02-20T11:42:29.442Z] Task Duration: 20m17.750146757s
[taskcluster 2021-02-20T11:42:29.554Z] Uploading artifact public/logs/localconfig.json from file logs/localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2022-02-20T09:38:18.830Z
[taskcluster 2021-02-20T11:42:30.009Z] Uploading artifact public/test_info/damp_errorsummary.log from file build/blobber_upload_dir/damp_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2022-02-20T09:38:18.830Z
[taskcluster 2021-02-20T11:42:30.242Z] Uploading artifact public/test_info/damp_raw.log from file build/blobber_upload_dir/damp_raw.log with content encoding "gzip", mime type "text/plain" and expiry 2022-02-20T09:38:18.830Z
[taskcluster 2021-02-20T11:42:30.643Z] Uploading artifact public/test_info/resource-usage.json from file build/blobber_upload_dir/resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2022-02-20T09:38:18.830Z
[taskcluster:error] exit status 2```

Comment 1

[Intermittent Failures Robot]

1 failures in 3737 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• linux64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1693975&startday=2021-02-15&endday=2021-02-21&tree=all

Comment 2

[BugBot [:suhaib / :marco/ :calixte]]

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

Comment 3

[Sandor Molnar[:smolnar]]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=349743874&repo=mozilla-central&lineNumber=3342

Comment 4

[Intermittent Failures Robot]

1 failures in 2580 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1693975&startday=2021-08-23&endday=2021-08-29&tree=all

Comment 5

[Intermittent Failures Robot]

1 failures in 3266 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1693975&startday=2021-09-06&endday=2021-09-12&tree=all

Comment 6

[Intermittent Failures Robot]

1 failures in 3375 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1693975&startday=2021-09-13&endday=2021-09-19&tree=all

Comment 7

[Intermittent Failures Robot]

1 failures in 2873 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1693975&startday=2021-09-20&endday=2021-09-26&tree=all

Comment 8

[Intermittent Failures Robot]

1 failures in 3376 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1693975&startday=2021-09-27&endday=2021-10-03&tree=all

Comment 9

[Intermittent Failures Robot]

5 failures in 3315 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 1
• mozilla-central: 2
• autoland: 2

Platform and build breakdown:

• windows10-64-shippable-qr: 4
  • opt: 4
• linux1804-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1693975&startday=2021-10-11&endday=2021-10-17&tree=all

Comment 11

[Andreea Pavel [:apavel]]

There are 28 total failures in the last 7 days on

• linux1804-64-shippable-qr opt
• windows10-64-shippable-qr opt
  Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=355887637&repo=mozilla-central&lineNumber=8319

[task 2021-10-24T23:19:58.962Z] 23:19:58     INFO -  PID 2068 | styleeditor/complicated.js took 4353ms.
[task 2021-10-24T23:19:58.962Z] 23:19:58     INFO -  PID 2068 | Loading test 'netmonitor/complicated.js'
[task 2021-10-24T23:19:58.962Z] 23:19:58     INFO -  PID 2068 | Executing test 'netmonitor/complicated.js'
[task 2021-10-24T23:19:58.971Z] 23:19:58     INFO -  PID 2068 | Wait for a pageshow event for browsing context 427
[task 2021-10-24T23:19:59.081Z] 23:19:59     INFO -  PID 2068 | console.warn: LoginHelper(Content): "Couldn't parse origin for" "httpdisabled://www.bild.de/suche.bild.html?type=article&query=&resultsStart=0&resultsPerPage=0" ({})
[task 2021-10-24T23:19:59.194Z] 23:19:59     INFO -  PID 2068 | console.warn: LoginHelper(Content): "Couldn't parse origin for" "httpdisabled://tarifvergleich.bild.de/strom/strom.php?phpurl=stromrechner.php" ({})
[task 2021-10-24T23:19:59.591Z] 23:19:59     INFO -  PID 2068 | Received pageshow event for 427
[task 2021-10-24T23:19:59.692Z] 23:19:59     INFO -  PID 2068 | Open toolbox on 'netmonitor'
[task 2021-10-24T23:19:59.693Z] 23:19:59     INFO -  PID 2068 | Open toolbox - Call showToolboxForTab
[task 2021-10-24T23:19:59.694Z] 23:19:59     INFO -  PID 2068 | Open toolbox - Wait for "toolbox-created"
[task 2021-10-24T23:19:59.702Z] 23:19:59     INFO -  PID 2068 | Open toolbox - Wait for showToolbox to resolve
[task 2021-10-24T23:19:59.954Z] 23:19:59     INFO -  PID 2068 | Wait for pending paints on 'complicated.netmonitor.open'
[task 2021-10-24T23:19:59.954Z] 23:19:59     INFO -  PID 2068 | 'complicated.netmonitor.open.settle.DAMP' took 0.04745400004321709ms.
[task 2021-10-24T23:19:59.954Z] 23:19:59     INFO -  PID 2068 | Garbage collect
[task 2021-10-24T23:20:00.853Z] 23:20:00     INFO -  PID 2068 | Reload page on 'complicated.netmonitor'
[task 2021-10-24T23:20:00.854Z] 23:20:00     INFO -  PID 2068 | Wait for a pageshow event for browsing context 427
[task 2021-10-24T23:20:01.093Z] 23:20:01     INFO -  PID 2068 | Waiting for 279 requests
[task 2021-10-24T23:20:01.093Z] 23:20:01     INFO -  PID 2068 | Waiting for 278 requests
[task 2021-10-24T23:20:01.093Z] 23:20:01     INFO -  PID 2068 | Waiting for 277 requests
[task 2021-10-24T23:20:01.094Z] 23:20:01     INFO -  PID 2068 | Waiting for 276 requests
[task 2021-10-24T23:20:01.094Z] 23:20:01     INFO -  PID 2068 | Waiting for 275 requests
[task 2021-10-24T23:20:01.094Z] 23:20:01     INFO -  PID 2068 | Waiting for 274 requests
[task 2021-10-24T23:20:01.094Z] 23:20:01     INFO -  PID 2068 | Waiting for 273 requests
[task 2021-10-24T23:20:01.094Z] 23:20:01     INFO -  PID 2068 | Waiting for 272 requests
[task 2021-10-24T23:20:01.094Z] 23:20:01     INFO -  PID 2068 | Waiting for 271 requests
[task 2021-10-24T23:20:01.094Z] 23:20:01     INFO -  PID 2068 | Waiting for 270 requests
[task 2021-10-24T23:20:01.095Z] 23:20:01     INFO -  PID 2068 | Waiting for 269 requests
[task 2021-10-24T23:20:01.095Z] 23:20:01     INFO -  PID 2068 | Waiting for 268 requests
[task 2021-10-24T23:20:01.095Z] 23:20:01     INFO -  PID 2068 | Waiting for 267 requests
[task 2021-10-24T23:20:01.095Z] 23:20:01     INFO -  PID 2068 | Waiting for 266 requests
[task 2021-10-24T23:20:01.095Z] 23:20:01     INFO -  PID 2068 | Waiting for 265 requests
[task 2021-10-24T23:20:01.095Z] 23:20:01     INFO -  PID 2068 | Waiting for 264 requests
[task 2021-10-24T23:20:01.095Z] 23:20:01     INFO -  PID 2068 | Waiting for 263 requests
[task 2021-10-24T23:20:01.118Z] 23:20:01     INFO -  PID 2068 | console.warn: LoginHelper(Content): "Couldn't parse origin for" "httpdisabled://www.bild.de/suche.bild.html?type=article&query=&resultsStart=0&resultsPerPage=0" ({})

[task 2021-10-24T23:20:02.656Z] 23:20:02     INFO -  PID 2068 | Waiting for 4 requests
[task 2021-10-24T23:20:02.656Z] 23:20:02     INFO -  PID 2068 | Waiting for 3 requests
[task 2021-10-24T23:20:02.656Z] 23:20:02     INFO -  PID 2068 | Waiting for 2 requests
[task 2021-10-24T23:20:02.656Z] 23:20:02     INFO -  PID 2068 | Waiting for 1 requests
[task 2021-10-24T23:20:02.656Z] 23:20:02     INFO -  PID 2068 | Waiting for 0 requests
[task 2021-10-24T23:20:02.669Z] 23:20:02     INFO -  PID 2068 | Received pageshow event for 427
[task 2021-10-24T23:20:02.669Z] 23:20:02     INFO -  PID 2068 | Wait for pending paints on 'complicated.netmonitor.reload'
[task 2021-10-24T23:20:02.669Z] 23:20:02     INFO -  PID 2068 | 'complicated.netmonitor.reload.settle.DAMP' took 0.03970600001048297ms.
[task 2021-10-24T23:24:58.964Z] 23:24:58     INFO -  PID 2068 | TEST-UNEXPECTED-FAIL | damp | netmonitor/complicated.js: Test timed out
[task 2021-10-24T23:24:58.970Z] 23:24:58     INFO -  PID 2068 | [DampLoad helper] Unregister DampLoad actors
[task 2021-10-24T23:24:58.970Z] 23:24:58     INFO -  Terminating psutil.Process(pid=2068, name='GeckoMain', started='23:13:11')
[task 2021-10-24T23:24:58.995Z] 23:24:58     INFO -  PID 2068 | Exiting due to channel error.
[task 2021-10-24T23:24:58.995Z] 23:24:58     INFO -  PID 2068 | Exiting due to channel error.
[task 2021-10-24T23:24:58.996Z] 23:24:58     INFO -  PID 2068 | Exiting due to channel error.
[task 2021-10-24T23:24:58.996Z] 23:24:58     INFO -  PID 2068 | Exiting due to channel error.
[task 2021-10-24T23:24:58.996Z] 23:24:58     INFO -  PID 2068 | Exiting due to channel error.
[task 2021-10-24T23:24:58.996Z] 23:24:58     INFO -  PID 2068 | Exiting due to channel error.
[task 2021-10-24T23:24:58.996Z] 23:24:58     INFO -  PID 2068 | Exiting due to channel error.
[task 2021-10-24T23:24:59.000Z] 23:24:58     INFO -  mozcrash checking /tmp/tmpqsu7k2eq/profile/minidumps for minidumps...
[task 2021-10-24T23:24:59.000Z] 23:24:58     INFO -  PID 2068 | Exiting due to channel error.
[task 2021-10-24T23:24:59.053Z] 23:24:59     INFO -  TEST-UNEXPECTED-ERROR | damp | unexpected error
[task 2021-10-24T23:24:59.053Z] 23:24:59    ERROR -  Traceback (most recent call last):
[task 2021-10-24T23:24:59.053Z] 23:24:59     INFO -    File "/home/cltbld/tasks/task_163511586008004/build/tests/talos/talos/run_tests.py", line 336, in run_tests
[task 2021-10-24T23:24:59.053Z] 23:24:59     INFO -      talos_results.add(mytest.runTest(browser_config, test))
[task 2021-10-24T23:24:59.054Z] 23:24:59     INFO -    File "/home/cltbld/tasks/task_163511586008004/build/tests/talos/talos/ttest.py", line 65, in runTest
[task 2021-10-24T23:24:59.054Z] 23:24:59     INFO -      return self._runTest(browser_config, test_config, setup)
[task 2021-10-24T23:24:59.054Z] 23:24:59     INFO -    File "/home/cltbld/tasks/task_163511586008004/build/tests/talos/talos/ttest.py", line 215, in _runTest
[task 2021-10-24T23:24:59.054Z] 23:24:59     INFO -      debugger_args=browser_config["debugger_args"],
[task 2021-10-24T23:24:59.054Z] 23:24:59     INFO -    File "/home/cltbld/tasks/task_163511586008004/build/tests/talos/talos/talos_process.py", line 191, in run_browser
[task 2021-10-24T23:24:59.055Z] 23:24:59     INFO -      raise TalosError("unexpected error")
[task 2021-10-24T23:24:59.055Z] 23:24:59     INFO -  talos.utils.TalosError: unexpected error
[task 2021-10-24T23:24:59.055Z] 23:24:59     INFO -  TEST-INFO took 1655656ms
[task 2021-10-24T23:24:59.055Z] 23:24:59     INFO -  SUITE-END | took 1655s
[task 2021-10-24T23:24:59.559Z] 23:24:59    ERROR - Return code: 2
[task 2021-10-24T23:24:59.559Z] 23:24:59  WARNING - setting return code to 2
[task 2021-10-24T23:24:59.559Z] 23:24:59    ERROR - # TBPL FAILURE #

Greg, can you please take a look?

Comment 12

[Intermittent Failures Robot]

28 failures in 3186 pushes (0.009 failures/push) were associated with this bug in the last 7 days.

This is the #32 most frequent failure this week.

Repository breakdown:

• autoland: 15
• mozilla-central: 13

Platform and build breakdown:

• linux1804-64-shippable-qr: 20
  • opt: 20
• windows10-64-shippable-qr: 7
  • opt: 7
• macosx1015-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1693975&startday=2021-10-18&endday=2021-10-24&tree=all

Comment 13

[Greg Mierzwinski [:sparky]]

:ochameau, as you're listed as the owner of the DAMP talos tests, can you look into this failure or find someone to look into it?

Comment 14

[Intermittent Failures Robot]

38 failures in 2845 pushes (0.013 failures/push) were associated with this bug in the last 7 days.

This is the #17 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 25
• mozilla-central: 13

Platform and build breakdown:

• linux1804-64-shippable-qr: 31
  • opt: 31
• windows10-64-shippable-qr: 7
  • opt: 7

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1693975&startday=2021-10-25&endday=2021-10-31&tree=all

Comment 15

[Andreea Pavel [:apavel]]

There are 38 total failures in the last 7 days on

• windows10-64-shippable-qr opt
• linux1804-64-shippable-qr opt
  Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=356562398&repo=mozilla-central&lineNumber=23286

[task 2021-11-01T00:20:13.420Z] 00:20:13     INFO -  PID 352 | Waiting for 12 requests
[task 2021-11-01T00:20:13.420Z] 00:20:13     INFO -  PID 352 | Waiting for 11 requests
[task 2021-11-01T00:20:13.420Z] 00:20:13     INFO -  PID 352 | Waiting for 10 requests
[task 2021-11-01T00:20:13.420Z] 00:20:13     INFO -  PID 352 | Waiting for 9 requests
[task 2021-11-01T00:20:13.420Z] 00:20:13     INFO -  PID 352 | Waiting for 8 requests
[task 2021-11-01T00:20:13.421Z] 00:20:13     INFO -  PID 352 | Waiting for 7 requests
[task 2021-11-01T00:20:13.421Z] 00:20:13     INFO -  PID 352 | Waiting for 6 requests
[task 2021-11-01T00:20:13.421Z] 00:20:13     INFO -  PID 352 | Waiting for 5 requests
[task 2021-11-01T00:20:13.421Z] 00:20:13     INFO -  PID 352 | Waiting for 4 requests
[task 2021-11-01T00:20:13.421Z] 00:20:13     INFO -  PID 352 | Waiting for 3 requests
[task 2021-11-01T00:20:13.421Z] 00:20:13     INFO -  PID 352 | Waiting for 2 requests
[task 2021-11-01T00:20:13.421Z] 00:20:13     INFO -  PID 352 | Waiting for 1 requests
[task 2021-11-01T00:20:13.421Z] 00:20:13     INFO -  PID 352 | Waiting for 0 requests
[task 2021-11-01T00:20:13.431Z] 00:20:13     INFO -  PID 352 | 'complicated.netmonitor.reload.settle.DAMP' took 60.694675000035204ms.
[task 2021-11-01T00:25:09.656Z] 00:25:09     INFO -  PID 352 | TEST-UNEXPECTED-FAIL | damp | netmonitor/complicated.js: Test timed out
[task 2021-11-01T00:25:09.663Z] 00:25:09     INFO -  PID 352 | [DampLoad helper] Unregister DampLoad actors
[task 2021-11-01T00:25:09.665Z] 00:25:09     INFO -  Terminating psutil.Process(pid=352, name='GeckoMain', started='00:10:02')
[task 2021-11-01T00:25:09.688Z] 00:25:09     INFO -  PID 352 | Exiting due to channel error.
[task 2021-11-01T00:25:09.689Z] 00:25:09     INFO -  PID 352 | Exiting due to channel error.
[task 2021-11-01T00:25:09.690Z] 00:25:09     INFO -  PID 352 | Exiting due to channel error.
[task 2021-11-01T00:25:09.690Z] 00:25:09     INFO -  PID 352 | Exiting due to channel error.
[task 2021-11-01T00:25:09.691Z] 00:25:09     INFO -  PID 352 | [GFX1-]: Receive IPC close with reason=AbnormalShutdown
[task 2021-11-01T00:25:09.691Z] 00:25:09     INFO -  PID 352 | Exiting due to channel error.
[task 2021-11-01T00:25:09.691Z] 00:25:09     INFO -  PID 352 | Exiting due to channel error.
[task 2021-11-01T00:25:09.691Z] 00:25:09     INFO -  PID 352 | Exiting due to channel error.
[task 2021-11-01T00:25:09.691Z] 00:25:09     INFO -  PID 352 | Exiting due to channel error.
[task 2021-11-01T00:25:09.749Z] 00:25:09     INFO -  mozcrash checking /tmp/tmpayrxhsj3/profile/minidumps for minidumps...
[task 2021-11-01T00:25:09.749Z] 00:25:09     INFO -  TEST-UNEXPECTED-ERROR | damp | unexpected error
[task 2021-11-01T00:25:09.749Z] 00:25:09    ERROR -  Traceback (most recent call last):
[task 2021-11-01T00:25:09.750Z] 00:25:09     INFO -    File "/home/cltbld/tasks/task_163572244160742/build/tests/talos/talos/run_tests.py", line 336, in run_tests
[task 2021-11-01T00:25:09.750Z] 00:25:09     INFO -      talos_results.add(mytest.runTest(browser_config, test))
[task 2021-11-01T00:25:09.750Z] 00:25:09     INFO -    File "/home/cltbld/tasks/task_163572244160742/build/tests/talos/talos/ttest.py", line 65, in runTest
[task 2021-11-01T00:25:09.750Z] 00:25:09     INFO -      return self._runTest(browser_config, test_config, setup)
[task 2021-11-01T00:25:09.750Z] 00:25:09     INFO -    File "/home/cltbld/tasks/task_163572244160742/build/tests/talos/talos/ttest.py", line 215, in _runTest
[task 2021-11-01T00:25:09.751Z] 00:25:09     INFO -      debugger_args=browser_config["debugger_args"],
[task 2021-11-01T00:25:09.751Z] 00:25:09     INFO -    File "/home/cltbld/tasks/task_163572244160742/build/tests/talos/talos/talos_process.py", line 191, in run_browser
[task 2021-11-01T00:25:09.751Z] 00:25:09     INFO -      raise TalosError("unexpected error")
[task 2021-11-01T00:25:09.751Z] 00:25:09     INFO -  talos.utils.TalosError: unexpected error
[task 2021-11-01T00:25:09.751Z] 00:25:09     INFO -  TEST-INFO took 3819201ms
[task 2021-11-01T00:25:09.752Z] 00:25:09     INFO -  SUITE-END | took 3819s
[task 2021-11-01T00:25:09.872Z] 00:25:09    ERROR - Return code: 2
[task 2021-11-01T00:25:09.873Z] 00:25:09  WARNING - setting return code to 2
[task 2021-11-01T00:25:09.873Z] 00:25:09    ERROR - # TBPL FAILURE #

:ochameau did you get a chance to take a look?

Comment 16

[Intermittent Failures Robot]

49 failures in 3030 pushes (0.016 failures/push) were associated with this bug in the last 7 days.

This is the #20 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 31
• mozilla-central: 18

Platform and build breakdown:

• linux1804-64-shippable-qr: 37
  • opt: 37
• windows10-64-shippable-qr: 12
  • opt: 12

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1693975&startday=2021-11-01&endday=2021-11-07&tree=all

Comment 17

[Jan Honza Odvarko [:Honza] (always need-info? me)]

Hubert, this test causes top intermittent failures from the past week.
Could that be related to some of the work you were doing recently?

Comment 18

[Intermittent Failures Robot]

43 failures in 2723 pushes (0.016 failures/push) were associated with this bug in the last 7 days.

This is the #11 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• mozilla-central: 15
• autoland: 28

Platform and build breakdown:

• windows10-64-shippable-qr: 10
  • opt: 10
• linux1804-64-shippable-qr: 33
  • opt: 33

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1693975&startday=2021-11-08&endday=2021-11-14&tree=all

Comment 19

[Cristian Tuns]

There were 35 failures in the last 7 days:

• 26 failures on linux1804-64-shippable-qr opt
• 9 failures on windows10-64-shippable-qr opt

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=358676232&repo=mozilla-central&lineNumber=15016

Comment 20

[Intermittent Failures Robot]

36 failures in 3259 pushes (0.011 failures/push) were associated with this bug in the last 7 days.

This is the #21 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 27
• mozilla-central: 9

Platform and build breakdown:

• linux1804-64-shippable-qr: 28
  • opt: 28
• windows10-64-shippable-qr: 8
  • opt: 8

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1693975&startday=2021-11-15&endday=2021-11-21&tree=all

Comment 21

[Andreea Pavel [:apavel]]

Attachment: Bug 1693975 - disable netmonitor/complicated.js due to frequent failures r?#intermittent-reviewers

Comment 22

[Intermittent Failures Robot]

49 failures in 2819 pushes (0.017 failures/push) were associated with this bug in the last 7 days.

This is the #20 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 29
• mozilla-central: 19
• mozilla-beta: 1

Platform and build breakdown:

• linux1804-64-shippable-qr: 39
  • opt: 39
• windows10-64-shippable-qr: 10
  • opt: 10

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1693975&startday=2021-11-22&endday=2021-11-28&tree=all

Comment 23

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/864a7b37a153
disable netmonitor/complicated.js due to frequent failures r=intermittent-reviewers,perftest-reviewers,sparky,jmaher DONTBUILD

Comment 24

[Sandor Molnar[:smolnar]]

https://hg.mozilla.org/mozilla-central/rev/864a7b37a153

Comment 25

[Intermittent Failures Robot]

31 failures in 3170 pushes (0.01 failures/push) were associated with this bug in the last 7 days.

This is the #28 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 24
• mozilla-central: 7

Platform and build breakdown:

• linux1804-64-shippable-qr: 30
  • opt: 30
• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1693975&startday=2021-11-29&endday=2021-12-05&tree=all

Comment 26

[Jan Honza Odvarko [:Honza] (always need-info? me)]

I don't think this is S2, changing to S3.
But we should enable the test again.

Comment 27

[Andreea Pavel [:apavel]]

Attachment: Bug 1693975 - re-enable netmonitor/complicated.js r=Honza