Open Bug 1998569 Opened 1 month ago Updated 11 days ago

Intermittent org.mozilla.geckoview.test.GeckoViewTest#setActiveProcessPriorityTest | single tracking bug

Categories

(GeckoView :: General, defect, P5)

All
Android
defect

Tracking

(Not tracked)

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase)

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


INFO -  11-05 23:18:16.068 E/GeckoSessionTestRule( 5080): 	at android.os.Handler.handleCallback(Handler.java:958)
[task 2025-11-05T23:18:19.321+00:00] 23:18:19     INFO -  11-05 23:18:16.068 E/GeckoSessionTestRule( 5080): 	at android.os.Handler.dispatchMessage(Handler.java:99)
[task 2025-11-05T23:18:19.321+00:00] 23:18:19     INFO -  11-05 23:18:16.068 E/GeckoSessionTestRule( 5080): 	at android.os.Looper.loopOnce(Looper.java:205)
[task 2025-11-05T23:18:19.322+00:00] 23:18:19     INFO -  11-05 23:18:16.068 E/GeckoSessionTestRule( 5080): 	at android.os.Looper.loop(Looper.java:294)
[task 2025-11-05T23:18:19.322+00:00] 23:18:19     INFO -  11-05 23:18:16.068 E/GeckoSessionTestRule( 5080): 	at android.app.ActivityThread.main(ActivityThread.java:8177)
[task 2025-11-05T23:18:19.322+00:00] 23:18:19     INFO -  11-05 23:18:16.068 E/GeckoSessionTestRule( 5080): 	at java.lang.reflect.Method.invoke(Native Method)
[task 2025-11-05T23:18:19.322+00:00] 23:18:19     INFO -  11-05 23:18:16.068 E/GeckoSessionTestRule( 5080): 	at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:552)
[task 2025-11-05T23:18:19.322+00:00] 23:18:19     INFO -  11-05 23:18:16.068 E/GeckoSessionTestRule( 5080): 	at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:971)
[task 2025-11-05T23:18:19.322+00:00] 23:18:19     INFO -  11-05 23:18:16.075 D/BoundBrokerSvc( 1239): onBind: Intent { act=com.google.android.gms.instantapps.START pkg=com.google.android.gms }
[task 2025-11-05T23:18:19.322+00:00] 23:18:19     INFO -  11-05 23:18:16.075 D/BoundBrokerSvc( 1239): Loading bound service for intent: Intent { act=com.google.android.gms.instantapps.START pkg=com.google.android.gms }
[task 2025-11-05T23:18:19.322+00:00] 23:18:19     INFO -  11-05 23:18:16.079 D/GeckoViewModule( 5080): dispatch GeckoView:SetActive, data={"active":false}
[task 2025-11-05T23:18:19.323+00:00] 23:18:19     INFO -  11-05 23:18:16.079 D/GeckoViewContent( 5080): onEvent: event=GeckoView:SetActive, data={"active":false}
[task 2025-11-05T23:18:19.323+00:00] 23:18:19     INFO -  11-05 23:18:16.080 D/GeckoViewModule( 5080): dispatch GeckoView:FlushSessionState, data=null
[task 2025-11-05T23:18:19.323+00:00] 23:18:19     INFO -  11-05 23:18:16.080 D/GeckoViewProgress( 5080): onEvent: event=GeckoView:FlushSessionState, data=null
[task 2025-11-05T23:18:19.323+00:00] 23:18:19     INFO -  11-05 23:18:16.080 D/GeckoViewContentDelegateChild[C](25231): handleEvent: MozPaintStatusReset
[task 2025-11-05T23:18:19.323+00:00] 23:18:19     INFO -  11-05 23:18:16.080 D/GeckoViewModule( 5080): dispatch GeckoView:FlushSessionState, data=null
[task 2025-11-05T23:18:19.323+00:00] 23:18:19     INFO -  11-05 23:18:16.080 D/GeckoViewTab( 5080): onEvent: event=GeckoView:FlushSessionState, data=null
[task 2025-11-05T23:18:19.323+00:00] 23:18:19     INFO -  11-05 23:18:16.081 D/GeckoViewConsole( 5080): onEvent GeckoView:WebExtension:PortMessageFromApp {"message":{"id":"09566883-7195-4b1f-ac2c-cbfc326547a5","args":{"oldPrefs":{"dom.ipc.processPriorityManager.backgroundGracePeriodMS":3000,"fission.webContentIsolationStrategy":1,"dom.ipc.processPriorityManager.backgroundPerceivableGracePeriodMS":3000}},"type":"RestorePrefs"}}
[task 2025-11-05T23:18:19.323+00:00] 23:18:19     INFO -  11-05 23:18:16.081 D/GeckoViewContentDelegateParent( 5080): receiveMessage: DispatcherMessage
[task 2025-11-05T23:18:19.324+00:00] 23:18:19     INFO -  11-05 23:18:16.081 D/GeckoViewSessionStateAggregator[C](25231): receiveMessage: GeckoView:FlushSessionState
[task 2025-11-05T23:18:19.324+00:00] 23:18:19     INFO -  11-05 23:18:16.082 I/Nearby  (25333): is blocked device type false, isAuto=false, isIot=false, isLatchsky=false, isChinaWearable=false, isTv=false, isWearable=false (supportWearOs=false), isChromeOsDevice=false (supportChromeOs=false) [CONTEXT service_id=49 ]
[task 2025-11-05T23:18:19.324+00:00] 23:18:19     INFO -  11-05 23:18:16.083 W/SettingsIntentOperation(25333): No accounts
[task 2025-11-05T23:18:19.324+00:00] 23:18:19     INFO -  11-05 23:18:16.083 D/CompatibilityChangeReporter(25333): Compat change id reported: 263076149; UID 10128; state: DISABLED
[task 2025-11-05T23:18:19.324+00:00] 23:18:19     INFO -  11-05 23:18:16.085 D/GeckoSession( 5080): handleMessage GeckoView:StateUpdated uri=null
[task 2025-11-05T23:18:19.324+00:00] 23:18:19     INFO -  11-05 23:18:16.104 D/GeckoViewContent( 5080): handleEvent: DOMWindowClose
[task 2025-11-05T23:18:19.324+00:00] 23:18:19     INFO -  11-05 23:18:16.104 D/GeckoViewConsole( 5080): onEvent GeckoView:WebExtension:List null
[task 2025-11-05T23:18:19.324+00:00] 23:18:19     INFO -  11-05 23:18:16.109 I/Gecko   ( 5080): nsWindow[0x76960edfa900]::Show 0
[task 2025-11-05T23:18:19.325+00:00] 23:18:19     INFO -  11-05 23:18:16.109 E/GeckoSessionTestRule( 5080): test_end c5ee677f-bc83-49bd-9e28-2d35f3d0f059 setActiveProcessPriorityTest(org.mozilla.geckoview.test.GeckoViewTest)
[task 2025-11-05T23:18:19.325+00:00] 23:18:19  WARNING -  TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.GeckoViewTest#setActiveProcessPriorityTest | java.lang.AssertionError: The loaded oom score adj indicates lower priority because it is backgrounded.
[task 2025-11-05T23:18:19.325+00:00] 23:18:19     INFO -  TEST-INFO took 5660ms
[task 2025-11-05T23:18:19.325+00:00] 23:18:19     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.GeckoViewTest
[task 2025-11-05T23:18:19.325+00:00] 23:18:19     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=406
[task 2025-11-05T23:18:19.325+00:00] 23:18:19     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2025-11-05T23:18:19.325+00:00] 23:18:19     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=1322
[task 2025-11-05T23:18:19.325+00:00] 23:18:19     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2025-11-05T23:18:19.326+00:00] 23:18:19     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=processPriorityTest
[task 2025-11-05T23:18:19.326+00:00] 23:18:19     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 1
[task 2025-11-05T23:18:19.326+00:00] 23:18:19     INFO -  TEST-START | org.mozilla.geckoview.test.GeckoViewTest#processPriorityTest
[task 2025-11-05T23:18:23.396+00:00] 23:18:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.GeckoViewTest
[task 2025-11-05T23:18:23.396+00:00] 23:18:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=406
[task 2025-11-05T23:18:23.396+00:00] 23:18:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2025-11-05T23:18:23.396+00:00] 23:18:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=1322
[task 2025-11-05T23:18:23.396+00:00] 23:18:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=.
[task 2025-11-05T23:18:23.396+00:00] 23:18:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=processPriorityTest
[task 2025-11-05T23:18:23.396+00:00] 23:18:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 0
[task 2025-11-05T23:18:23.396+00:00] 23:18:23     INFO -  TEST-PASS | org.mozilla.geckoview.test.GeckoViewTest#processPriorityTest | took 4135ms
You need to log in before you can comment on or make changes to this bug.