High-freq browser/components/urlbar/tests/quicksuggest/browser/browser_telemetry_suggestMetrics.js | single tracking bug
Categories
(Firefox :: Address Bar, defect, P5)
Tracking
()
| Tracking | Status | |
|---|---|---|
| firefox-esr128 | --- | unaffected |
| firefox-esr140 | --- | unaffected |
| firefox142 | --- | unaffected |
| firefox143 | --- | wontfix |
| firefox144 | --- | wontfix |
People
(Reporter: intermittent-bug-filer, Assigned: adw)
References
(Blocks 1 open bug, Regression)
Details
(Keywords: intermittent-failure, intermittent-testcase, regression, Whiteboard: [stockwell disabled][sng])
Attachments
(1 file)
Filed by: abutkovits [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=512176103&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/JbpASM2HQ7GyZ7m6GLpYpQ/runs/0/artifacts/public/logs/live_backing.log
[task 2025-06-09T11:25:25.947+00:00] 11:25:25 INFO - TEST-START | browser/components/urlbar/tests/quicksuggest/browser/browser_telemetry_suggestMetrics.js
[task 2025-06-09T11:25:25.957+00:00] 11:25:25 INFO - GECKO(2552) | console.info: RemoteSettingsServer: "Starting"
[task 2025-06-09T11:25:25.957+00:00] 11:25:25 INFO - GECKO(2552) | console.info: RemoteSettingsServer: "Server is now started at http://localhost:51893/v1"
[task 2025-06-09T11:30:38.176+00:00] 11:30:38 INFO - console.trace: Places - FrecencyRecalculator: "Initializing Frecency Recalculator"
[task 2025-06-09T11:30:38.177+00:00] 11:30:38 INFO - resource://gre/modules/PlacesFrecencyRecalculator.sys.mjs 123 PlacesFrecencyRecalculator
[task 2025-06-09T11:30:38.177+00:00] 11:30:38 INFO - D:\task_174946738732101\build\tests\mochitest\server.js 178 runServer
[task 2025-06-09T11:30:38.178+00:00] 11:30:38 INFO - D:\task_174946738732101\build\tests\mochitest\server.js 71
[task 2025-06-09T11:30:38.182+00:00] 11:30:38 INFO - console.trace: Places - FrecencyRecalculator: "Arm frecency recalculation"
[task 2025-06-09T11:30:38.182+00:00] 11:30:38 INFO - resource://gre/modules/PlacesFrecencyRecalculator.sys.mjs 387 maybeStartFrecencyRecalculation
[task 2025-06-09T11:30:38.182+00:00] 11:30:38 INFO - resource://gre/modules/PlacesFrecencyRecalculator.sys.mjs 164 PlacesFrecencyRecalculator
[task 2025-06-09T11:30:38.183+00:00] 11:30:38 INFO - D:\task_174946738732101\build\tests\mochitest\server.js 178 runServer
[task 2025-06-09T11:30:38.183+00:00] 11:30:38 INFO - D:\task_174946738732101\build\tests\mochitest\server.js 71
[task 2025-06-09T11:30:38.183+00:00] 11:30:38 INFO - console.trace: Places - FrecencyRecalculator: "Got places-init-complete topic"
[task 2025-06-09T11:30:38.184+00:00] 11:30:38 INFO - resource://gre/modules/PlacesFrecencyRecalculator.sys.mjs 497 observe
[task 2025-06-09T11:30:38.184+00:00] 11:30:38 INFO - D:\task_174946738732101\build\tests\mochitest\server.js 178 runServer
[task 2025-06-09T11:30:38.185+00:00] 11:30:38 INFO - D:\task_174946738732101\build\tests\mochitest\server.js 71
[task 2025-06-09T11:30:38.185+00:00] 11:30:38 INFO - console.error: (new TypeError("connection not specified or invalid.", "resource://gre/modules/Sqlite.sys.mjs", 1590))
[task 2025-06-09T11:30:38.185+00:00] 11:30:38 INFO - console.error: (new TypeError("can't access property \"executeBeforeShutdown\", db is undefined", "resource://gre/modules/PlacesUtils.sys.mjs", 1632))
[task 2025-06-09T11:31:35.942+00:00] 11:31:35 INFO - Buffered messages logged at 11:25:25
[task 2025-06-09T11:31:35.942+00:00] 11:31:35 INFO - Entering setup bound
[task 2025-06-09T11:31:35.943+00:00] 11:31:35 INFO - QuickSuggestTestUtils.ensureQuickSuggestInit Started
[task 2025-06-09T11:31:35.944+00:00] 11:31:35 INFO - QuickSuggestTestUtils.ensureQuickSuggestInit Awaiting ExperimentAPI.init
[task 2025-06-09T11:31:35.944+00:00] 11:31:35 INFO - QuickSuggestTestUtils.ensureQuickSuggestInit Awaiting ExperimentAPI.ready
[task 2025-06-09T11:31:35.945+00:00] 11:31:35 INFO - QuickSuggestTestUtils.ensureQuickSuggestInit Preparing remote settings server
[task 2025-06-09T11:31:35.945+00:00] 11:31:35 INFO - QuickSuggestTestUtils.ensureQuickSuggestInit Starting remote settings server
[task 2025-06-09T11:31:35.946+00:00] 11:31:35 INFO - QuickSuggestTestUtils.ensureQuickSuggestInit Remote settings server started
[task 2025-06-09T11:31:35.947+00:00] 11:31:35 INFO - QuickSuggestTestUtils.ensureQuickSuggestInit Calling QuickSuggest.init() and setting prefs
[task 2025-06-09T11:31:35.947+00:00] 11:31:35 INFO - Buffered messages finished
[task 2025-06-09T11:31:35.947+00:00] 11:31:35 INFO - TEST-UNEXPECTED-TIMEOUT | browser/components/urlbar/tests/quicksuggest/browser/browser_telemetry_suggestMetrics.js | application timed out after 370 seconds with no output
[task 2025-06-09T11:31:35.947+00:00] 11:31:35 INFO - TEST-INFO took 369054ms
[task 2025-06-09T11:31:35.948+00:00] 11:31:35 INFO - Buffered messages finished
[task 2025-06-09T11:31:35.948+00:00] 11:31:35 WARNING - Force-terminating active process(es).
[task 2025-06-09T11:31:35.949+00:00] 11:31:35 INFO - profiler Not sending a signal to start the profiler - not on MacOS or Linux. See Bug 1823370.
[task 2025-06-09T11:31:35.949+00:00] 11:31:35 INFO - Determining child pids from psutil...
[task 2025-06-09T11:31:35.949+00:00] 11:31:35 INFO - [9228]
[task 2025-06-09T11:31:35.950+00:00] 11:31:35 INFO - ==> process 9228 launched child process 6632 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250609101912 -prefsHandle 2380:28574 -prefMapHandle 2384:290867 -ipcHandle 2412 -initialChannelId {d983e62b-337c-4c2d-87bc-9b496f78ec50} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -appDir "D:\task_174946738732101\build\application\firefox\browser" - 1 gpu)
[task 2025-06-09T11:31:35.952+00:00] 11:31:35 INFO - ==> process 9228 launched child process 9132 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250609101912 -prefsHandle 2636:28574 -prefMapHandle 2640:290867 -ipcHandle 2648 -initialChannelId {24f830a7-234a-4e93-99fa-c010e3a5414d} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 2 socket)
[task 2025-06-09T11:31:35.953+00:00] 11:31:35 INFO - ==> process 9228 launched child process 3160 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 2928:28222 -prefMapHandle 2932:290867 -jsInitHandle 2936:248576 -parentBuildID 20250609101912 -ipcHandle 2944 -initialChannelId {f20c8de1-38ca-4216-881e-09253e2102cf} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 3 tab)
[task 2025-06-09T11:31:35.953+00:00] 11:31:35 INFO - ==> process 9228 launched child process 9812 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250609101912 -prefsHandle 3192:29678 -prefMapHandle 3196:290867 -ipcHandle 3204 -initialChannelId {94197bd8-323c-432a-9c91-4acfdfb8989a} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -appDir "D:\task_174946738732101\build\application\firefox\browser" - 4 rdd)
[task 2025-06-09T11:31:35.954+00:00] 11:31:35 INFO - ==> process 9228 launched child process 7092 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 3516:29814 -prefMapHandle 3520:290867 -jsInitHandle 3524:248576 -parentBuildID 20250609101912 -ipcHandle 3532 -initialChannelId {0fa69664-792e-4c4e-bd4b-3bc4331a39ec} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 5 tab)
[task 2025-06-09T11:31:35.955+00:00] 11:31:35 INFO - ==> process 9228 launched child process 9004 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 3648:28516 -prefMapHandle 3548:290867 -jsInitHandle 3560:248576 -parentBuildID 20250609101912 -ipcHandle 3680 -initialChannelId {79d21fb8-8cea-4874-bbb4-da66933e2c8a} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 6 tab)
[task 2025-06-09T11:31:35.956+00:00] 11:31:35 INFO - ==> process 9228 launched child process 1748 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250609101912 -sandboxingKind 0 -prefsHandle 4460:41321 -prefMapHandle 4456:290867 -ipcHandle 4468 -initialChannelId {894ad78d-785d-4a0c-a427-d88552b1717a} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 7 utility)
[task 2025-06-09T11:31:35.957+00:00] 11:31:35 INFO - ==> process 9228 launched child process 8988 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 4592:38968 -prefMapHandle 4600:290867 -jsInitHandle 4604:248576 -parentBuildID 20250609101912 -ipcHandle 4616 -initialChannelId {7132319d-9fe9-4ba9-9db1-a658a62be7c2} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 8 tab)
[task 2025-06-09T11:31:35.958+00:00] 11:31:35 INFO - ==> process 9228 launched child process 4264 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 4660:38968 -prefMapHandle 4664:290867 -jsInitHandle 4668:248576 -parentBuildID 20250609101912 -ipcHandle 4680 -initialChannelId {0ae16fe8-9561-4ab7-8ec7-2f9c04e8d364} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 9 tab)
[task 2025-06-09T11:31:35.959+00:00] 11:31:35 INFO - ==> process 9228 launched child process 8616 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 5024:38968 -prefMapHandle 5000:290867 -jsInitHandle 4996:248576 -parentBuildID 20250609101912 -ipcHandle 4988 -initialChannelId {fb08a7b5-e26c-4692-a22f-1ca969b0c3a3} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 10 tab)
[task 2025-06-09T11:31:35.960+00:00] 11:31:35 INFO - ==> process 9228 launched child process 8580 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 4484:41724 -prefMapHandle 4460:290867 -jsInitHandle 4456:248576 -parentBuildID 20250609101912 -ipcHandle 4984 -initialChannelId {6e7a29ce-92e4-4182-99b8-b3b630f95368} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 11 tab)
[task 2025-06-09T11:31:35.961+00:00] 11:31:35 INFO - ==> process 9228 launched child process 6204 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 5784:39433 -prefMapHandle 5380:290867 -jsInitHandle 5968:248576 -parentBuildID 20250609101912 -ipcHandle 5960 -initialChannelId {0ca540b5-29e3-4642-a76f-6f187573acd4} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 12 tab)
[task 2025-06-09T11:31:35.962+00:00] 11:31:35 INFO - ==> process 9228 launched child process 8956 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 6260:39609 -prefMapHandle 6232:290867 -jsInitHandle 6364:248576 -parentBuildID 20250609101912 -ipcHandle 6400 -initialChannelId {aa6a75df-69e4-442c-8fdb-5fb1f84a3723} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 13 tab)
[task 2025-06-09T11:31:35.963+00:00] 11:31:35 INFO - ==> process 9228 launched child process 3292 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 6340:39593 -prefMapHandle 4424:290867 -jsInitHandle 6032:248576 -parentBuildID 20250609101912 -ipcHandle 4564 -initialChannelId {7c4ccf66-281a-4d56-9064-3568798b4ce4} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 14 tab)
[task 2025-06-09T11:31:35.964+00:00] 11:31:35 INFO - ==> process 9228 launched child process 8012 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 5048:39593 -prefMapHandle 4980:290867 -jsInitHandle 4964:248576 -parentBuildID 20250609101912 -ipcHandle 6600 -initialChannelId {6b57c615-4118-4886-9755-8265e8219c45} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 15 tab)
[task 2025-06-09T11:31:35.965+00:00] 11:31:35 INFO - ==> process 9228 launched child process 9324 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 5052:39651 -prefMapHandle 6560:290867 -jsInitHandle 4948:248576 -parentBuildID 20250609101912 -ipcHandle 6540 -initialChannelId {2e897ba7-0a16-4a53-a9e9-ad67f7b9dfa1} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 16 tab)
[task 2025-06-09T11:31:35.967+00:00] 11:31:35 INFO - ==> process 9228 launched child process 1584 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 6832:39619 -prefMapHandle 6028:290867 -jsInitHandle 6016:248576 -parentBuildID 20250609101912 -ipcHandle 5692 -initialChannelId {6a8ad06c-6238-4a82-a9cf-ccfbcd060fa5} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 17 tab)
[task 2025-06-09T11:31:35.968+00:00] 11:31:35 INFO - ==> process 9228 launched child process 5408 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 6740:40076 -prefMapHandle 5092:290867 -jsInitHandle 5796:248576 -parentBuildID 20250609101912 -ipcHandle 4800 -initialChannelId {46899110-b4b5-4f97-9d69-a477dcc507fe} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 18 tab)
[task 2025-06-09T11:31:35.969+00:00] 11:31:35 INFO - ==> process 9228 launched child process 4860 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 1664:40072 -prefMapHandle 4484:290867 -jsInitHandle 4460:248576 -parentBuildID 20250609101912 -ipcHandle 4800 -initialChannelId {c9f043c4-3008-4aa7-bf6f-b7d4b95ade49} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 19 tab)
[task 2025-06-09T11:31:35.970+00:00] 11:31:35 INFO - ==> process 9228 launched child process 4852 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 6760:40072 -prefMapHandle 3708:290867 -jsInitHandle 6720:248576 -parentBuildID 20250609101912 -ipcHandle 6032 -initialChannelId {9f123b7f-3bee-4a26-a1b4-52b114498285} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 20 tab)
[task 2025-06-09T11:31:35.970+00:00] 11:31:35 INFO - ==> process 9228 launched child process 6368 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 6580:40072 -prefMapHandle 5116:290867 -jsInitHandle 4396:248576 -parentBuildID 20250609101912 -ipcHandle 6564 -initialChannelId {d5ed0448-d753-432c-ba91-81a2a2581e29} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 21 tab)
[task 2025-06-09T11:31:35.972+00:00] 11:31:35 INFO - ==> process 9228 launched child process 8452 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 4460:40028 -prefMapHandle 6048:290867 -jsInitHandle 5116:248576 -parentBuildID 20250609101912 -ipcHandle 2780 -initialChannelId {086f0e32-1645-4feb-a3d5-403c43fb8836} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 22 tab)
[task 2025-06-09T11:31:35.973+00:00] 11:31:35 INFO - ==> process 9228 launched child process 1828 ("D:\task_174946738732101\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 6536:40072 -prefMapHandle 6448:290867 -jsInitHandle 4484:248576 -parentBuildID 20250609101912 -ipcHandle 6276 -initialChannelId {0178ac90-e3c1-4caf-889e-d6af2a70acda} -parentPid 9228 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9228" -win32kLockedDown -appDir "D:\task_174946738732101\build\application\firefox\browser" - 23 tab)
[task 2025-06-09T11:31:35.974+00:00] 11:31:35 INFO - Found child pids: {8580, 4860, 8452, 9228, 8988, 5408, 1828, 4264, 8616, 9132, 9004, 1584, 7092, 6204, 8012, 9812, 1748, 3160, 3292, 6368, 6632, 9324, 4852, 8956}
[task 2025-06-09T11:31:35.974+00:00] 11:31:35 INFO - Failed to get child procs
Comment 1•10 months ago
|
||
This passed when run in confirm failure mode (rerun the test 4x in the same session).
This indicates that the test is probably a lower frequency intermittent and harder to reproduce/debug.
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Comment 10•7 months ago
|
||
Based on these retriggers and backfills it seems that your patch from https://bugzilla.mozilla.org/show_bug.cgi?id=1983376 caused this frequent failure. Can you please take a look?
Comment 11•7 months ago
|
||
Set release status flags based on info from the regressing bug 1983376
| Comment hidden (Intermittent Failures Robot) |
| Assignee | ||
Comment 13•7 months ago
|
||
Thanks and sorry, I probably won't be able to get to this until a week or two from now.
Updated•7 months ago
|
| Comment hidden (Intermittent Failures Robot) |
Comment 15•7 months ago
|
||
| Comment hidden (Intermittent Failures Robot) |
Comment 17•7 months ago
|
||
Comment 18•7 months ago
|
||
| bugherder | ||
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Updated•6 months ago
|
Updated•6 months ago
|
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Comment 29•5 months ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Comment 30•1 month ago
|
||
Still valid as the test must be re-enabled
Description
•