1880677 - High Freq [tier 2] browser/components/asrouter/tests/browser/browser_asrouter_cfr.js | Test timed out

Status: RESOLVED DUPLICATE of bug 1775847

(Firefox :: Messaging System, defect)

Description

[Treeherder Bug Filer]

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

---

[task 2024-02-16T17:55:52.801Z] 17:55:52     INFO - TEST-START | browser/components/asrouter/tests/browser/browser_asrouter_cfr.js
[task 2024-02-16T17:55:53.094Z] 17:55:53     INFO - GECKO(20752) | [Parent 20752, Main Thread] WARNING: g_type_add_interface_static: assertion 'g_type_parent (interface_type) == G_TYPE_INTERFACE' failed: 'glib warning', file /builds/worker/checkouts/gecko/toolkit/xre/nsSigHandlers.cpp:187
[task 2024-02-16T17:55:53.095Z] 17:55:53     INFO - GECKO(20752) | (firefox-nightly-autoland:20752): GLib-GObject-CRITICAL **: 17:55:53.092: g_type_add_interface_static: assertion 'g_type_parent (interface_type) == G_TYPE_INTERFACE' failed
[task 2024-02-16T17:55:53.097Z] 17:55:53     INFO - GECKO(20752) | [Parent 20752, Main Thread] WARNING: g_type_add_interface_static: assertion 'g_type_parent (interface_type) == G_TYPE_INTERFACE' failed: 'glib warning', file /builds/worker/checkouts/gecko/toolkit/xre/nsSigHandlers.cpp:187
[task 2024-02-16T17:55:53.098Z] 17:55:53     INFO - GECKO(20752) | (firefox-nightly-autoland:20752): GLib-GObject-CRITICAL **: 17:55:53.092: g_type_add_interface_static: assertion 'g_type_parent (interface_type) == G_TYPE_INTERFACE' failed
[task 2024-02-16T17:55:53.125Z] 17:55:53     INFO - GECKO(20752) | [Parent 20752, Main Thread] WARNING: g_type_add_interface_static: assertion 'g_type_parent (interface_type) == G_TYPE_INTERFACE' failed: 'glib warning', file /builds/worker/checkouts/gecko/toolkit/xre/nsSigHandlers.cpp:187
[task 2024-02-16T17:55:53.125Z] 17:55:53     INFO - GECKO(20752) | (firefox-nightly-autoland:20752): GLib-GObject-CRITICAL **: 17:55:53.123: g_type_add_interface_static: assertion 'g_type_parent (interface_type) == G_TYPE_INTERFACE' failed
[task 2024-02-16T17:56:38.368Z] 17:56:38     INFO - TEST-INFO | started process screentopng
[task 2024-02-16T17:56:38.540Z] 17:56:38     INFO - TEST-INFO | screentopng: exit 0
[task 2024-02-16T17:56:38.540Z] 17:56:38     INFO - Buffered messages logged at 17:55:52
[task 2024-02-16T17:56:38.540Z] 17:56:38     INFO - Entering setup bound 
[task 2024-02-16T17:56:38.540Z] 17:56:38     INFO - Leaving setup bound 
[task 2024-02-16T17:56:38.540Z] 17:56:38     INFO - Entering test bound test_cfr_notification_show
[task 2024-02-16T17:56:38.541Z] 17:56:38     INFO - TEST-PASS | browser/components/asrouter/tests/browser/browser_asrouter_cfr.js | Should have removed the notification - 0 == 0 - 
[task 2024-02-16T17:56:38.542Z] 17:56:38     INFO - Buffered messages logged at 17:55:53
[task 2024-02-16T17:56:38.542Z] 17:56:38     INFO - TEST-PASS | browser/components/asrouter/tests/browser/browser_asrouter_cfr.js | Should return true if addRecommendation checks were successful - true == true - 
<...>
[task 2024-02-16T17:56:38.613Z] 17:56:38     INFO - TEST-PASS | browser/components/asrouter/tests/browser/browser_asrouter_cfr.js | Should have removed the notification - 0 == 0 - 
[task 2024-02-16T17:56:38.615Z] 17:56:38     INFO - TEST-PASS | browser/components/asrouter/tests/browser/browser_asrouter_cfr.js | Should return true if addRecommendation checks were successful - true == true - 
[task 2024-02-16T17:56:38.615Z] 17:56:38     INFO - Console message: [JavaScript Warning: "Key event not available on some keyboard layouts: key=“r” modifiers=“accel,alt” id=“key_toggleReaderMode”" {file: "chrome://mochikit/content/tests/SimpleTest/EventUtils.js" line: 1541}]
[task 2024-02-16T17:56:38.616Z] 17:56:38     INFO - Console message: [JavaScript Warning: "Key event not available on some keyboard layouts: key=“i” modifiers=“accel,alt,shift” id=“key_browserToolbox”" {file: "chrome://mochikit/content/tests/SimpleTest/EventUtils.js" line: 1541}]
[task 2024-02-16T17:56:38.616Z] 17:56:38     INFO - Buffered messages finished
[task 2024-02-16T17:56:38.617Z] 17:56:38     INFO - TEST-UNEXPECTED-FAIL | browser/components/asrouter/tests/browser/browser_asrouter_cfr.js | Test timed out - 
[task 2024-02-16T17:56:38.617Z] 17:56:38     INFO - GECKO(20752) | Completed ShutdownLeaks collections in process 20752
[task 2024-02-16T17:56:38.618Z] 17:56:38     INFO - TEST-START | Shutdown
[task 2024-02-16T17:56:38.618Z] 17:56:38     INFO - Browser Chrome Test Summary
[task 2024-02-16T17:56:38.619Z] 17:56:38     INFO - Passed:  72
[task 2024-02-16T17:56:38.619Z] 17:56:38     INFO - Failed:  1
[task 2024-02-16T17:56:38.619Z] 17:56:38     INFO - Todo:    0
[task 2024-02-16T17:56:38.620Z] 17:56:38     INFO - Mode:    e10s
[task 2024-02-16T17:56:38.620Z] 17:56:38     INFO - *** End BrowserChrome Test Results ***

Comment 1

[Norisz Fay [:noriszfay]]

Hey Mike, could you take a look at this? Retriggers & Backfills show that the failure started appearing when Bug 1877196 landed but it was classified with Bug 1775847. The failure rate is slightly above average however it's only tier 2.

Comment 2

[Shane Hughes [:aminomancer]]

Isn't this the same failure as bug 1775847? The file was just moved in bug 1877196, but it looks like the same timeout failure as before the move. I think the reason it's hanging for so long is the problem I described in bug 1872874 and in this thread, and it might be due to bug 1833453. The issue seems to be that if you don't call Services.fog.testResetFOG after every test, something seems to accumulate, and then when you finally do call it, it hangs for a really long time. But if you "distribute" it between all the subtasks, then each one executes very quickly, so the test does not time out. I think I fixed this particular test failure in D197559 through the judicious use of Services.fog.testResetFOG, but I didn't land that patch for unrelated reasons.

I submitted a new patch, just to fix this test, at D202078. I'll close this bug after it lands.

Comment 3

[Intermittent Failures Robot]

9 failures in 3125 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 9

Platform and build breakdown:

• linux1804-64-shippable-qr: 9
  • opt: 9

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1880677&startday=2024-02-12&endday=2024-02-18&tree=all

Comment 4

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

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

Comment 5

[Punam Dahiya [:pdahiya]]

Resolving duplicate of 1775847, please feel free to reopen if issue still occurs after D202078 merge in Nightly.