1998616 - Intermittent org.mozilla.geckoview.test.InteractiveWidgetTest#bug1994311 | single tracking bug

Status: NEW

(GeckoView :: General, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2025-11-06T07:52:34.733+00:00] 07:52:34     INFO -  11-06 07:52:32.820 E/OpenGLRenderer( 1396): Unable to match the desired swap behavior.
[task 2025-11-06T07:52:34.733+00:00] 07:52:34     INFO -  11-06 07:52:32.821 D/BoundBrokerSvc( 1660): onBind: Intent { act=com.google.android.gms.common.BIND_SHARED_PREFS pkg=com.google.android.gms }
[task 2025-11-06T07:52:34.734+00:00] 07:52:34     INFO -  11-06 07:52:32.821 D/BoundBrokerSvc( 1660): Loading bound service for intent: Intent { act=com.google.android.gms.common.BIND_SHARED_PREFS pkg=com.google.android.gms }
[task 2025-11-06T07:52:34.734+00:00] 07:52:34     INFO -  11-06 07:52:32.823 D/BoundBrokerSvc( 1660): onUnbind: Intent { act=com.google.android.gms.common.BIND_SHARED_PREFS pkg=com.google.android.gms }
[task 2025-11-06T07:52:34.734+00:00] 07:52:34     INFO -  11-06 07:52:32.844 I/DeviceModeUtil( 1396): DeviceModeUtil.getDeviceMode():122 Get device mode phone by ui mode:1 and smallestScreenWidthDp:400
[task 2025-11-06T07:52:34.734+00:00] 07:52:34     INFO -  11-06 07:52:32.844 I/DeviceModeUtil( 1396): DeviceModeUtil.getDeviceMode():122 Get device mode phone by ui mode:1 and smallestScreenWidthDp:400
[task 2025-11-06T07:52:34.734+00:00] 07:52:34     INFO -  11-06 07:52:32.847 D/InsetsController( 5099): show(ime(), fromIme=true)
[task 2025-11-06T07:52:34.735+00:00] 07:52:34     INFO -  11-06 07:52:32.850 D/BoundBrokerSvc( 1660): onBind: Intent { act=com.google.android.gms.common.BIND_SHARED_PREFS pkg=com.google.android.gms }
[task 2025-11-06T07:52:34.735+00:00] 07:52:34     INFO -  11-06 07:52:32.850 D/BoundBrokerSvc( 1660): Loading bound service for intent: Intent { act=com.google.android.gms.common.BIND_SHARED_PREFS pkg=com.google.android.gms }
[task 2025-11-06T07:52:34.736+00:00] 07:52:34     INFO -  11-06 07:52:32.854 D/BoundBrokerSvc( 1660): onUnbind: Intent { act=com.google.android.gms.common.BIND_SHARED_PREFS pkg=com.google.android.gms }
[task 2025-11-06T07:52:34.736+00:00] 07:52:34     INFO -  11-06 07:52:32.997 D/StatusBarIconController(  790): ignoring old pipeline callback because the new wifi icon is enabled
[task 2025-11-06T07:52:34.736+00:00] 07:52:34     INFO -  11-06 07:52:33.042 I/Gecko   (10583): waiting for paint...
[task 2025-11-06T07:52:34.737+00:00] 07:52:34     INFO -  11-06 07:52:33.087 I/ImeTracker( 5099): org.mozilla.geckoview.test:ae1dd1d5: onRequestHide at ORIGIN_CLIENT_HIDE_SOFT_INPUT reason HIDE_SOFT_INPUT
[task 2025-11-06T07:52:34.738+00:00] 07:52:34     INFO -  11-06 07:52:33.090 I/GoogleInputMethodService( 1396): GoogleInputMethodService.onFinishInputView():2241
[task 2025-11-06T07:52:34.738+00:00] 07:52:34     INFO -  11-06 07:52:33.090 W/TooltipLifecycleManager( 1396): TooltipLifecycleManager.dismissTooltips():159 Tooltip with id spell_check_add_to_dictionary not found in tooltipManager.
[task 2025-11-06T07:52:34.739+00:00] 07:52:34     INFO -  11-06 07:52:33.091 I/AndroidIME( 1396): AbstractIme.onDeactivate():207 PasswordIme.onDeactivate()
[task 2025-11-06T07:52:34.739+00:00] 07:52:34     INFO -  11-06 07:52:33.095 I/ImeTracker( 5099): org.mozilla.geckoview.test:ad6bd4f1: onCancelled at PHASE_CLIENT_ANIMATION_CANCEL
[task 2025-11-06T07:52:34.739+00:00] 07:52:34     INFO -  11-06 07:52:33.135 W/WindowOnBackDispatcher( 5099): sendCancelIfRunning: isInProgress=falsecallback=ImeCallback=ImeOnBackInvokedCallback@238770190 Callback=android.window.IOnBackInvokedCallback$Stub$Proxy@c1d895e
[task 2025-11-06T07:52:34.740+00:00] 07:52:34     INFO -  11-06 07:52:33.136 D/CoreBackPreview(  571): Window{f5644ea u0 org.mozilla.geckoview.test/org.mozilla.geckoview.test.GeckoViewTestActivity}: Setting back callback OnBackInvokedCallbackInfo{mCallback=android.window.IOnBackInvokedCallback$Stub$Proxy@138733, mPriority=0, mIsAnimationCallback=false}
[task 2025-11-06T07:52:34.740+00:00] 07:52:34     INFO -  11-06 07:52:33.137 I/ImeTracker(  571): org.mozilla.geckoview.test:ad6bd4f1: setFinished on previously finished token at PHASE_NOT_SET with STATUS_SUCCESS
[task 2025-11-06T07:52:34.741+00:00] 07:52:34     INFO -  11-06 07:52:33.138 I/ImeTracker( 5099): org.mozilla.geckoview.test:ad6bd4f1: onShown
[task 2025-11-06T07:52:34.741+00:00] 07:52:34     INFO -  11-06 07:52:33.154 D/EGL_emulation( 5099): app_time_stats: avg=188.92ms min=28.22ms max=658.11ms count=6
[task 2025-11-06T07:52:34.742+00:00] 07:52:34     INFO -  11-06 07:52:33.253 I/Gecko   (10583): waiting for paint...
[task 2025-11-06T07:52:34.742+00:00] 07:52:34     INFO -  11-06 07:52:33.257 W/FrameTracker( 5099): Missed App frame:UNKNOWN: 74, 139060, 0, CUJ=J<IME_INSETS_ANIMATION::0@[e-mail]>
[task 2025-11-06T07:52:34.742+00:00] 07:52:34     INFO -  11-06 07:52:33.257 W/FrameTracker( 5099): Missed SF frame:UNKNOWN: 74, 139060, 0, CUJ=J<IME_INSETS_ANIMATION::0@[e-mail]>
[task 2025-11-06T07:52:34.742+00:00] 07:52:34     INFO -  11-06 07:52:33.257 W/FrameTracker( 5099): Missed SF frame:JANK_SURFACEFLINGER_DEADLINE_MISSED, 139083, 0, CUJ=J<IME_INSETS_ANIMATION::0@[e-mail]>
[task 2025-11-06T07:52:34.742+00:00] 07:52:34     INFO -  11-06 07:52:33.257 W/FrameTracker( 5099): Missed SF frame:JANK_SURFACEFLINGER_DEADLINE_MISSED, 139098, 0, CUJ=J<IME_INSETS_ANIMATION::0@[e-mail]>
[task 2025-11-06T07:52:34.743+00:00] 07:52:34     INFO -  11-06 07:52:33.257 W/FrameTracker( 5099): Missed SF frame:JANK_SURFACEFLINGER_DEADLINE_MISSED, 139112, 0, CUJ=J<IME_INSETS_ANIMATION::0@[e-mail]>
[task 2025-11-06T07:52:34.743+00:00] 07:52:34     INFO -  11-06 07:52:33.257 W/FrameTracker( 5099): Missed SF frame:JANK_SURFACEFLINGER_DEADLINE_MISSED, 139127, 0, CUJ=J<IME_INSETS_ANIMATION::0@[e-mail]>
[task 2025-11-06T07:52:34.744+00:00] 07:52:34     INFO -  11-06 07:52:33.257 W/FrameTracker( 5099): Missed SF frame:JANK_SURFACEFLINGER_DEADLINE_MISSED, 139142, 0, CUJ=J<IME_INSETS_ANIMATION::0@[e-mail]>
[task 2025-11-06T07:52:34.744+00:00] 07:52:34     INFO -  11-06 07:52:33.257 W/FrameTracker( 5099): Missed SF frame:JANK_SURFACEFLINGER_DEADLINE_MISSED, 139157, 0, CUJ=J<IME_INSETS_ANIMATION::0@[e-mail]>
[task 2025-11-06T07:52:34.744+00:00] 07:52:34     INFO -  11-06 07:52:33.258 W/FrameTracker( 5099): Missed SF frame:JANK_SURFACEFLINGER_DEADLINE_MISSED, 139172, 0, CUJ=J<IME_INSETS_ANIMATION::0@[e-mail]>
[task 2025-11-06T07:52:34.745+00:00] 07:52:34     INFO -  11-06 07:52:33.258 W/FrameTracker( 5099): Missed SF frame:JANK_SURFACEFLINGER_DEADLINE_MISSED, 139187, 0, CUJ=J<IME_INSETS_ANIMATION::0@[e-mail]>
[task 2025-11-06T07:52:34.745+00:00] 07:52:34     INFO -  11-06 07:52:33.258 W/FrameTracker( 5099): Missed SF frame:JANK_SURFACEFLINGER_DEADLINE_MISSED, 139201, 0, CUJ=J<IME_INSETS_ANIMATION::0@[e-mail]>
[task 2025-11-06T07:52:34.746+00:00] 07:52:34     INFO -  11-06 07:52:33.258 W/FrameTracker( 5099): Missed SF frame:JANK_SURFACEFLINGER_DEADLINE_MISSED, 139223, 0, CUJ=J<IME_INSETS_ANIMATION::0@[e-mail]>
[task 2025-11-06T07:52:34.746+00:00] 07:52:34     INFO -  11-06 07:52:33.258 W/FrameTracker( 5099): Missed SF frame:JANK_SURFACEFLINGER_DEADLINE_MISSED, 139231, 0, CUJ=J<IME_INSETS_ANIMATION::0@[e-mail]>
[task 2025-11-06T07:52:34.746+00:00] 07:52:34     INFO -  11-06 07:52:33.258 W/FrameTracker( 5099): Missed SF frame:UNKNOWN: 66, 139246, 0, CUJ=J<IME_INSETS_ANIMATION::0@[e-mail]>
[task 2025-11-06T07:52:34.746+00:00] 07:52:34     INFO -  11-06 07:52:33.259 V/PerfettoTrigger( 5099): Not triggering com.android.telemetry.interaction-jank-monitor-69 - not enough time since last trigger
[task 2025-11-06T07:52:34.747+00:00] 07:52:34     INFO -  11-06 07:52:33.321 E/GeckoSessionTestRule( 5099): after evaluate
[task 2025-11-06T07:52:34.747+00:00] 07:52:34     INFO -  11-06 07:52:33.321 E/GeckoSessionTestRule( 5099): after performTestEndCheck
[task 2025-11-06T07:52:34.747+00:00] 07:52:34     INFO -  11-06 07:52:33.324 D/GeckoSession( 5099): handleMessage: GeckoView:DismissClipboardPermissionRequest
[task 2025-11-06T07:52:34.747+00:00] 07:52:34     INFO -  11-06 07:52:33.329 E/GeckoSessionTestRule( 5099): test_end c5ee677f-bc83-49bd-9e28-2d35f3d0f059 bug1994311(org.mozilla.geckoview.test.InteractiveWidgetTest)
[task 2025-11-06T07:52:34.749+00:00] 07:52:34  WARNING -  TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.InteractiveWidgetTest#bug1994311 | java.lang.AssertionError: The visual viewport height is restored to the original one
[task 2025-11-06T07:52:34.749+00:00] 07:52:34     INFO -  TEST-INFO took 2957ms
[task 2025-11-06T07:52:34.749+00:00] 07:52:34     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.InteractiveWidgetTest
[task 2025-11-06T07:52:34.749+00:00] 07:52:34     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=449
[task 2025-11-06T07:52:34.749+00:00] 07:52:34     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2025-11-06T07:52:34.749+00:00] 07:52:34     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=1322
[task 2025-11-06T07:52:34.749+00:00] 07:52:34     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2025-11-06T07:52:34.749+00:00] 07:52:34     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=hideDynamicToolbarOnResizesVisual
[task 2025-11-06T07:52:34.749+00:00] 07:52:34     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 1
[task 2025-11-06T07:52:34.749+00:00] 07:52:34     INFO -  TEST-START | org.mozilla.geckoview.test.InteractiveWidgetTest#hideDynamicToolbarOnResizesVisual
[task 2025-11-06T07:52:37.037+00:00] 07:52:37     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.InteractiveWidgetTest
[task 2025-11-06T07:52:37.037+00:00] 07:52:37     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=449
[task 2025-11-06T07:52:37.038+00:00] 07:52:37     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2025-11-06T07:52:37.038+00:00] 07:52:37     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=1322
[task 2025-11-06T07:52:37.038+00:00] 07:52:37     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=.
[task 2025-11-06T07:52:37.038+00:00] 07:52:37     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=hideDynamicToolbarOnResizesVisual
[task 2025-11-06T07:52:37.038+00:00] 07:52:37     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 0
[task 2025-11-06T07:52:37.040+00:00] 07:52:37     INFO -  TEST-PASS | org.mozilla.geckoview.test.InteractiveWidgetTest#hideDynamicToolbarOnResizesVisual | took 2330ms

Comment 1

[Intermittent Failures Robot]

12 failures were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 8
• mozilla-central: 2
• try: 2

Table

	fis	http3	nofis	nofis-noship
android-x86/debug	2
android-x86/opt			4	5
linux2404-x86_64/debug		1

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1998616&startday=2025-11-03&endday=2025-11-09&tree=all

Comment 2

[Intermittent Failures Robot]

5 failures were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 4
• try: 1

Table

	nofis	nofis-noship
android-x86/debug	1
android-x86/opt	2	2

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1998616&startday=2025-11-10&endday=2025-11-16&tree=all

Comment 3

[Intermittent Failures Robot]

13 failures were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 4
• mozilla-central: 4
• mozilla-beta: 4
• try: 1

Table

	nofis	nofis-noship
android-x86/opt	8	5

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1998616&startday=2025-11-17&endday=2025-11-23&tree=all

Comment 4

[Intermittent Failures Robot]

10 failures were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 8
• mozilla-beta: 1
• try: 1

Table

	fis	nofis	nofis-noship
android-x86/debug		1
android-x86/opt	1	4	4

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1998616&startday=2025-11-24&endday=2025-11-30&tree=all

Comment 5

[Intermittent Failures Robot]

26 failures were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 15
• mozilla-central: 6
• try: 3
• mozilla-beta: 1
• mozilla-release: 1

Table

	fis	no_variant	nofis	nofis-noship
android-x86/debug	3	1	3	2
android-x86/opt	8		5	4

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1998616&startday=2025-12-01&endday=2025-12-07&tree=all

Comment 6

[Intermittent Failures Robot]

41 failures were associated with this bug in the last 7 days.

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: 22
• mozilla-central: 11
• mozilla-beta: 8

Table

	fis	nofis	nofis-noship
android-x86/debug	2	7	2
android-x86/opt	14	10	6

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1998616&startday=2025-12-08&endday=2025-12-14&tree=all