Open
Bug 1880406
Opened 9 months ago
Updated 7 months ago
Intermittent TV browser/components/urlbar/tests/quicksuggest/unit/test_quicksuggest_yelp.js | single tracking bug
Categories
(Firefox :: Address Bar, defect, P5)
Firefox
Address Bar
Tracking
()
NEW
| Tracking | Status | |
|---|---|---|
| firefox-esr115 | --- | unaffected |
| firefox122 | --- | unaffected |
| firefox123 | --- | unaffected |
| firefox124 | --- | affected |
| firefox125 | --- | affected |
People
(Reporter: intermittent-bug-filer, Unassigned)
References
(Regression)
Details
(Keywords: intermittent-failure, regression, test-verify-fail)
Attachments
(1 obsolete file)
Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=447331080&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/HQbgnDI9QX6JGI5D0MsG6A/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/HQbgnDI9QX6JGI5D0MsG6A/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1
[task 2024-02-15T03:12:46.249Z] 03:12:46 INFO - TEST-PASS | browser/components/urlbar/tests/quicksuggest/unit/test_quicksuggest_yelp.js | took 3909ms
[task 2024-02-15T03:12:46.280Z] 03:12:46 INFO - TEST-START | browser/components/urlbar/tests/quicksuggest/unit/test_quicksuggest_yelp.js
[task 2024-02-15T03:12:47.593Z] 03:12:47 WARNING - TEST-UNEXPECTED-FAIL | browser/components/urlbar/tests/quicksuggest/unit/test_quicksuggest_yelp.js | xpcshell return code: 0
[task 2024-02-15T03:12:47.605Z] 03:12:47 INFO - TEST-INFO took 1313ms
[task 2024-02-15T03:12:47.605Z] 03:12:47 INFO - >>>>>>>
[task 2024-02-15T03:12:47.605Z] 03:12:47 INFO - PID 6516 | DLL blocklist was unable to intercept AppInit DLLs.
[task 2024-02-15T03:12:47.605Z] 03:12:47 INFO - PID 6516 | *** You are running in chaos test mode. See ChaosMode.h. ***
[task 2024-02-15T03:12:47.606Z] 03:12:47 INFO - PID 6516 | [Parent 6516, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp:133
[task 2024-02-15T03:12:47.606Z] 03:12:47 INFO - PID 6516 | [Parent 6516, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp:133
[task 2024-02-15T03:12:47.606Z] 03:12:47 INFO - PID 6516 | [Parent 6516, Main Thread] WARNING: Couldn't get the user appdata directory. Crash events may not be produced.: file /builds/worker/checkouts/gecko/toolkit/crashreporter/nsExceptionHandler.cpp:2886
[task 2024-02-15T03:12:47.607Z] 03:12:47 INFO - (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2024-02-15T03:12:47.607Z] 03:12:47 INFO - (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2024-02-15T03:12:47.607Z] 03:12:47 INFO - (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2024-02-15T03:12:47.607Z] 03:12:47 INFO - running event loop
[task 2024-02-15T03:12:47.607Z] 03:12:47 INFO - browser/components/urlbar/tests/quicksuggest/unit/test_quicksuggest_yelp.js | Starting setup setUpQuickSuggestXpcshellTest
[task 2024-02-15T03:12:47.608Z] 03:12:47 INFO - (xpcshell/head.js) | test setUpQuickSuggestXpcshellTest pending (2)
[task 2024-02-15T03:12:47.608Z] 03:12:47 INFO - (xpcshell/head.js) | test run_next_test 0 finished (2)
[task 2024-02-15T03:12:47.608Z] 03:12:47 INFO - (xpcshell/head.js) | test run_next_test 1 pending (2)
[task 2024-02-15T03:12:47.608Z] 03:12:47 INFO - (xpcshell/head.js) | test setUpQuickSuggestXpcshellTest finished (2)
[task 2024-02-15T03:12:47.608Z] 03:12:47 INFO - browser/components/urlbar/tests/quicksuggest/unit/test_quicksuggest_yelp.js | Starting setup
[task 2024-02-15T03:12:47.609Z] 03:12:47 INFO - (xpcshell/head.js) | test pending (2)
[task 2024-02-15T03:12:47.609Z] 03:12:47 INFO - "QuickSuggestTestUtils.ensureQuickSuggestInit Started, preparing remote settings server"
[task 2024-02-15T03:12:47.609Z] 03:12:47 INFO - (xpcshell/head.js) | test run_next_test 1 finished (2)
[task 2024-02-15T03:12:47.609Z] 03:12:47 INFO - "QuickSuggestTestUtils.ensureQuickSuggestInit Starting remote settings server"
[task 2024-02-15T03:12:47.610Z] 03:12:47 INFO - PID 6516 | 1707966766912 RemoteSettingsServer INFO Starting
[task 2024-02-15T03:12:47.610Z] 03:12:47 INFO - PID 6516 | 1707966766929 RemoteSettingsServer INFO Server is now started at http://localhost:51181/v1
[task 2024-02-15T03:12:47.610Z] 03:12:47 INFO - "QuickSuggestTestUtils.ensureQuickSuggestInit Remote settings server started"
[task 2024-02-15T03:12:47.611Z] 03:12:47 INFO - "QuickSuggestTestUtils.ensureQuickSuggestInit Calling QuickSuggest.init() and setting prefs"
[task 2024-02-15T03:12:47.611Z] 03:12:47 INFO - PID 6516 | [WARN sql_support::open_database] suggest db: database operation failed: Error executing SQL: database is locked
[task 2024-02-15T03:12:47.611Z] 03:12:47 INFO - PID 6516 | [ERROR error_support::handling] suggest-unexpected: Error opening database: Error executing SQL: database is locked
[task 2024-02-15T03:12:47.612Z] 03:12:47 INFO - "CONSOLE_MESSAGE: (error) [JavaScript Error: "1707966767005 urlbar ERROR QuickSuggest.SuggestBackendRust :: Ingest error: Error opening database: Error executing SQL: database is locked" {file: "resource://gre/modules/Log.sys.mjs" line: 722}]
[task 2024-02-15T03:12:47.612Z] 03:12:47 INFO - append@resource://gre/modules/Log.sys.mjs:722:12
[task 2024-02-15T03:12:47.612Z] 03:12:47 INFO - log@resource://gre/modules/Log.sys.mjs:376:16
[task 2024-02-15T03:12:47.612Z] 03:12:47 INFO - getLoggerWithMessagePrefix/proxy.log@resource://gre/modules/Log.sys.mjs:505:18
[task 2024-02-15T03:12:47.612Z] 03:12:47 INFO - error@resource://gre/modules/Log.sys.mjs:384:10
[task 2024-02-15T03:12:47.613Z] 03:12:47 INFO - #ingest@resource:///modules/urlbar/private/SuggestBackendRust.sys.mjs:292:19
[task 2024-02-15T03:12:47.613Z] 03:12:47 INFO - _do_main@Z:\\task_170796154604680\\build\\tests\\xpcshell\\head.js:245:6
[task 2024-02-15T03:12:47.613Z] 03:12:47 INFO - _execute_test@Z:\\task_170796154604680\\build\\tests\\xpcshell\\head.js:596:5
[task 2024-02-15T03:12:47.613Z] 03:12:47 INFO - @-e:1:1
[task 2024-02-15T03:12:47.613Z] 03:12:47 INFO - "
[task 2024-02-15T03:12:47.614Z] 03:12:47 INFO - PID 6516 | [WARN sql_support::open_database] suggest db: database operation failed: Error executing SQL: table meta already exists
[task 2024-02-15T03:12:47.614Z] 03:12:47 INFO - PID 6516 | [ERROR error_support::handling] suggest-unexpected: Error opening database: Error executing SQL: table meta already exists
[task 2024-02-15T03:12:47.614Z] 03:12:47 INFO - Unexpected exception Error: at resource://gre/modules/RustSuggest.sys.mjs:992
[task 2024-02-15T03:12:47.614Z] 03:12:47 INFO - SuggestApiError@resource://gre/modules/RustSuggest.sys.mjs:992:8
[task 2024-02-15T03:12:47.614Z] 03:12:47 INFO - Other@resource://gre/modules/RustSuggest.sys.mjs:1041:9
[task 2024-02-15T03:12:47.615Z] 03:12:47 INFO - read@resource://gre/modules/RustSuggest.sys.mjs:1065:24
[task 2024-02-15T03:12:47.615Z] 03:12:47 INFO - lift@resource://gre/modules/RustSuggest.sys.mjs:247:21
[task 2024-02-15T03:12:47.615Z] 03:12:47 INFO - liftError@resource://gre/modules/RustSuggest.sys.mjs:512:69
[task 2024-02-15T03:12:47.615Z] 03:12:47 INFO - handleRustResult@resource://gre/modules/RustSuggest.sys.mjs:204:19
[task 2024-02-15T03:12:47.615Z] 03:12:47 INFO - fetchGlobalConfig/<@resource://gre/modules/RustSuggest.sys.mjs:520:68
[task 2024-02-15T03:12:47.616Z] 03:12:47 INFO - _do_main@Z:\task_170796154604680\build\tests\xpcshell\head.js:245:6
[task 2024-02-15T03:12:47.616Z] 03:12:47 INFO - _execute_test@Z:\task_170796154604680\build\tests\xpcshell\head.js:596:5
[task 2024-02-15T03:12:47.616Z] 03:12:47 INFO - @-e:1:1
[task 2024-02-15T03:12:47.616Z] 03:12:47 INFO - exiting test
[task 2024-02-15T03:12:47.616Z] 03:12:47 INFO - "Force a GC"
[task 2024-02-15T03:12:47.616Z] 03:12:47 INFO - PID 6516 | 1707966767231 RemoteSettingsServer INFO < HTTP 1.1 GET /v1/buckets/main/collections/quicksuggest/records?_sort=last_modified
[task 2024-02-15T03:12:47.617Z] 03:12:47 INFO - PID 6516 | 1707966767233 RemoteSettingsServer INFO > 200 /v1/buckets/main/collections/quicksuggest/records
[task 2024-02-15T03:12:47.617Z] 03:12:47 INFO - PID 6516 | 1707966767356 RemoteSettingsServer INFO < HTTP 1.1 GET /v1
[task 2024-02-15T03:12:47.617Z] 03:12:47 INFO - PID 6516 | 1707966767358 RemoteSettingsServer INFO > 200 /v1
[task 2024-02-15T03:12:47.617Z] 03:12:47 INFO - PID 6516 | 1707966767373 RemoteSettingsServer INFO < HTTP 1.1 GET /attachments/main/quicksuggest/1
[task 2024-02-15T03:12:47.618Z] 03:12:47 INFO - PID 6516 | 1707966767374 RemoteSettingsServer INFO > 200 /attachments/main/quicksuggest/1
[task 2024-02-15T03:12:47.618Z] 03:12:47 INFO - PID 6516 | [Parent 6516, Socket Thread] WARNING: cannot post event if not initialized: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpConnectionMgr.cpp:233
[task 2024-02-15T03:12:47.618Z] 03:12:47 INFO - PID 6516 | !!! error running onStopped callback: TypeError: callback is not a function
[task 2024-02-15T03:12:47.619Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: quota manager shutdown step: '0.000000s: startCrashBrowserTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.619Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: quota manager shutdown step: '0.000000s: initiateShutdownWorkThreads', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.620Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: idb: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.620Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: cache: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.620Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: sdb: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.621Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: fs: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.621Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: ls: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.621Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: quota manager shutdown step: '0.000000s: startKillActorsTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.622Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: idb: '0.016000s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.622Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: idb: '0.016000s: gLiveDatabaseHashtable entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.622Z] 03:12:47 INFO - PID 6516 | [Parent 6516, QuotaManager IO] WARNING: quota manager shutdown step: '0.016000s: ShutdownStorageOp::DoDirectoryWork -> ShutdownStorageInternal.', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.623Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: quota manager shutdown step: '0.031000s: stopKillActorsTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.623Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: quota manager shutdown step: '0.031000s: shutdownAndJoinWorkThreads', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.623Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: idb: '0.031000s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.624Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: cache: '0.031000s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.624Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: sdb: '0.031000s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.624Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: fs: '0.031000s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.625Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: ls: '0.031000s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.625Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: quota manager shutdown step: '0.031000s: shutdownAndJoinIOThread', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.625Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: quota manager shutdown step: '0.031000s: invalidatePendingDirectoryLocks', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.626Z] 03:12:47 INFO - PID 6516 | [Parent 6516, IPDL Background] WARNING: quota manager shutdown step: '0.031000s: stopCrashBrowserTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2218
[task 2024-02-15T03:12:47.626Z] 03:12:47 INFO - PID 6516 | [Parent 6516, Main Thread] WARNING: NS_ENSURE_TRUE(inst) failed: file StaticComponents.cpp:12637
[task 2024-02-15T03:12:47.626Z] 03:12:47 INFO - PID 6516 | [Parent 6516, Main Thread] WARNING: OOPDeinit() without successful OOPInit(): file /builds/worker/checkouts/gecko/toolkit/crashreporter/nsExceptionHandler.cpp:3376
[task 2024-02-15T03:12:47.626Z] 03:12:47 INFO - PID 6516 | [Parent 6516, Main Thread] WARNING: XPCOM object PerThreadData destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:216
[task 2024-02-15T03:12:47.627Z] 03:12:47 INFO - PID 6516 | [Parent 6516, Main Thread] WARNING: XPCOM object SourceList destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:216
[task 2024-02-15T03:12:47.627Z] 03:12:47 INFO - <<<<<<<
[task 2024-02-15T03:12:47.633Z] 03:12:47 INFO - TEST-START | browser/components/urlbar/tests/quicksuggest/unit/test_quicksuggest_yelp.js
|
||
Comment 1•9 months ago
|
||
:daisuke, since you are the author of the regressor, bug 1879614, could you take a look?
For more information, please visit BugBot documentation.
Flags: needinfo?(daisuke)
|
|
||
Comment 2•9 months ago
|
||
Set release status flags based on info from the regressing bug 1879614
status-firefox122:
--- → unaffected
status-firefox123:
--- → unaffected
status-firefox124:
--- → affected
status-firefox-esr115:
--- → unaffected
|
||
Comment 3•9 months ago
|
||
Hopefully bug 1880416 fixed this.
Depends on: 1880416
Flags: needinfo?(daisuke)
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 5•9 months ago
|
||
Set release status flags based on info from the regressing bug 1879614
status-firefox125:
--- → affected
|
||
Updated•9 months ago
|
Attachment #9384591 -
Attachment is obsolete: true
| Comment hidden (Intermittent Failures Robot) |
You need to log in
before you can comment on or make changes to this bug.
Description
•