Closed
Bug 1770009
Opened 4 years ago
Closed 4 years ago
Intermittent org.mozilla.geckoview.test.SelectionActionDelegateTest#cut[#contenteditable] | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
Categories
(GeckoView :: General, defect, P5)
Tracking
(Not tracked)
RESOLVED
DUPLICATE
of bug 1761875
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=378515442&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/eZim7tqJTa6Inyi2AL42xg/runs/0/artifacts/public/logs/live_backing.log
[task 2022-05-18T15:48:21.999Z] 15:48:21 INFO - TEST-START | org.mozilla.geckoview.test.SelectionActionDelegateTest#cut[#contenteditable]
[task 2022-05-18T15:48:56.826Z] 15:48:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=916
[task 2022-05-18T15:48:56.827Z] 15:48:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2022-05-18T15:48:56.827Z] 15:48:56 INFO - org.mozilla.geckoview.test | Error in cut[#contenteditable](org.mozilla.geckoview.test.SelectionActionDelegateTest):
[task 2022-05-18T15:48:56.827Z] 15:48:56 INFO - org.mozilla.geckoview.test | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2022-05-18T15:48:56.828Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:49)
[task 2022-05-18T15:48:56.828Z] 15:48:56 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2022-05-18T15:48:56.828Z] 15:48:56 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2022-05-18T15:48:56.829Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:158)
[task 2022-05-18T15:48:56.829Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1775)
[task 2022-05-18T15:48:56.829Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForPageStops(GeckoSessionTestRule.java:1531)
[task 2022-05-18T15:48:56.830Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForPageStop(GeckoSessionTestRule.java:1506)
[task 2022-05-18T15:48:56.830Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.BaseSessionTest.waitForPageStop(BaseSessionTest.kt:183)
[task 2022-05-18T15:48:56.830Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest.testThat(SelectionActionDelegateTest.kt:271)
[task 2022-05-18T15:48:56.831Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest.access$testThat(SelectionActionDelegateTest.kt:37)
[task 2022-05-18T15:48:56.831Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest$cut$1$1.invoke(SelectionActionDelegateTest.kt:155)
[task 2022-05-18T15:48:56.831Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest$cut$1$1.invoke(SelectionActionDelegateTest.kt:154)
[task 2022-05-18T15:48:56.832Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest.withClipboard(SelectionActionDelegateTest.kt:368)
[task 2022-05-18T15:48:56.832Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest.access$withClipboard(SelectionActionDelegateTest.kt:37)
[task 2022-05-18T15:48:56.832Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest$cut$1.invoke(SelectionActionDelegateTest.kt:154)
[task 2022-05-18T15:48:56.833Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest$cut$1.invoke(SelectionActionDelegateTest.kt:153)
[task 2022-05-18T15:48:56.833Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest.assumingEditable(SelectionActionDelegateTest.kt:393)
[task 2022-05-18T15:48:56.834Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest.cut(SelectionActionDelegateTest.kt:153)
[task 2022-05-18T15:48:56.834Z] 15:48:56 INFO - org.mozilla.geckoview.test |
[task 2022-05-18T15:48:56.834Z] 15:48:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2022-05-18T15:48:56.834Z] 15:48:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=cut[#contenteditable]
[task 2022-05-18T15:48:56.834Z] 15:48:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.SelectionActionDelegateTest
[task 2022-05-18T15:48:56.835Z] 15:48:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stack=org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2022-05-18T15:48:56.835Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:49)
[task 2022-05-18T15:48:56.835Z] 15:48:56 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2022-05-18T15:48:56.836Z] 15:48:56 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2022-05-18T15:48:56.836Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:158)
[task 2022-05-18T15:48:56.836Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1775)
[task 2022-05-18T15:48:56.837Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForPageStops(GeckoSessionTestRule.java:1531)
[task 2022-05-18T15:48:56.837Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForPageStop(GeckoSessionTestRule.java:1506)
[task 2022-05-18T15:48:56.837Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.BaseSessionTest.waitForPageStop(BaseSessionTest.kt:183)
[task 2022-05-18T15:48:56.838Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest.testThat(SelectionActionDelegateTest.kt:271)
[task 2022-05-18T15:48:56.838Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest.access$testThat(SelectionActionDelegateTest.kt:37)
[task 2022-05-18T15:48:56.838Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest$cut$1$1.invoke(SelectionActionDelegateTest.kt:155)
[task 2022-05-18T15:48:56.839Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest$cut$1$1.invoke(SelectionActionDelegateTest.kt:154)
[task 2022-05-18T15:48:56.839Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest.withClipboard(SelectionActionDelegateTest.kt:368)
[task 2022-05-18T15:48:56.839Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest.access$withClipboard(SelectionActionDelegateTest.kt:37)
[task 2022-05-18T15:48:56.840Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest$cut$1.invoke(SelectionActionDelegateTest.kt:154)
[task 2022-05-18T15:48:56.840Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest$cut$1.invoke(SelectionActionDelegateTest.kt:153)
[task 2022-05-18T15:48:56.840Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest.assumingEditable(SelectionActionDelegateTest.kt:393)
[task 2022-05-18T15:48:56.841Z] 15:48:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.SelectionActionDelegateTest.cut(SelectionActionDelegateTest.kt:153)
[task 2022-05-18T15:48:56.841Z] 15:48:56 INFO - org.mozilla.geckoview.test |
[task 2022-05-18T15:48:56.841Z] 15:48:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=605
[task 2022-05-18T15:48:56.841Z] 15:48:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: -2
[task 2022-05-18T15:48:56.841Z] 15:48:56 INFO - Printing logcat for test:
[task 2022-05-18T15:48:56.890Z] 15:48:56 INFO - 05-18 15:48:21.901 E/GeckoSessionTestRule( 3414): test_start 1f0befec-3ff2-40ff-89cf-b127eb38b1ec cut[#contenteditable](org.mozilla.geckoview.test.SelectionActionDelegateTest)
[task 2022-05-18T15:48:56.890Z] 15:48:56 INFO - 05-18 15:48:21.901 E/GeckoSessionTestRule( 3414): before prepareStatement cut[#contenteditable](org.mozilla.geckoview.test.SelectionActionDelegateTest)
[task 2022-05-18T15:48:56.891Z] 15:48:56 INFO - 05-18 15:48:21.903 D/LifecycleMonitor( 3414): Lifecycle status change: androidx.test.core.app.InstrumentationActivityInvoker$BootstrapActivity@315f972 in: STOPPED
[task 2022-05-18T15:48:56.892Z] 15:48:56 INFO - 05-18 15:48:21.903 V/ActivityScenario( 3414): Activity lifecycle changed event received but ignored because the intent does not match. startActivityIntent=Intent { act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] cmp=org.mozilla.geckoview.test/.GeckoViewTestActivity }, activity.getIntent()=Intent { act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10008000 cmp=org.mozilla.geckoview.test/androidx.test.core.app.InstrumentationActivityInvoker$BootstrapActivity (has extras) }, activity=androidx.test.core.app.InstrumentationActivityInvoker$BootstrapActivity@315f972
[task 2022-05-18T15:48:56.893Z] 15:48:56 INFO - 05-18 15:48:21.950 D/GeckoViewStartup( 3414): onEvent GeckoView:StorageDelegate:Attached
[task 2022-05-18T15:48:56.893Z] 15:48:56 INFO - 05-18 15:48:21.950 I/Gecko ( 3414): nsWindow[0x78d0d4727700]::Create 0x0 [0 0 1 1]
[task 2022-05-18T15:48:56.893Z] 15:48:56 INFO - 05-18 15:48:21.957 I/Gecko ( 3414): nsWindow[0x78d0d4727700]::Resize [0.000000 0.000000 400.000000 400.000000] (repaint 0)
[task 2022-05-18T15:48:56.894Z] 15:48:56 INFO - 05-18 15:48:21.957 I/Gecko ( 3414): nsWindow: 0x78d0d4727700 OnSizeChanged [400 400]
[task 2022-05-18T15:48:56.894Z] 15:48:56 INFO - 05-18 15:48:21.971 D/GeckoViewNavigation( 3414): sessionContextId=null
[task 2022-05-18T15:48:56.894Z] 15:48:56 INFO - 05-18 15:48:21.980 E/eglCodecCommon(23815): glUtilsParamSize: unknow param 0x00008caa
[task 2022-05-18T15:48:56.894Z] 15:48:56 INFO - 05-18 15:48:22.006 W/webrender::device::gl(23815): Missing optimized shader source for gpu_cache_update
[task 2022-05-18T15:48:56.895Z] 15:48:56 INFO - 05-18 15:48:22.012 E/eglCodecCommon(23815): glUtilsParamSize: unknow param 0x00008741
[task 2022-05-18T15:48:56.896Z] 15:48:56 INFO - 05-18 15:48:22.020 D/GeckoViewModule( 3414): registerListener ["GeckoViewContent:ExitFullScreen","GeckoView:ClearMatches","GeckoView:DisplayMatches","GeckoView:FindInPage","GeckoView:RestoreState","GeckoView:ScrollBy","GeckoView:ScrollTo","GeckoView:SetActive","GeckoView:SetFocused","GeckoView:SetPriorityHint","GeckoView:UpdateInitData","GeckoView:ZoomToInput"]
[task 2022-05-18T15:48:56.896Z] 15:48:56 INFO - 05-18 15:48:22.022 D/GeckoViewNavigation( 3414): onInit
[task 2022-05-18T15:48:56.897Z] 15:48:56 INFO - 05-18 15:48:22.023 D/GeckoViewModule( 3414): registerListener ["GeckoView:GoBack","GeckoView:GoForward","GeckoView:GotoHistoryIndex","GeckoView:LoadUri","GeckoView:Reload","GeckoView:Stop","GeckoView:PurgeHistory"]
[task 2022-05-18T15:48:56.897Z] 15:48:56 INFO - 05-18 15:48:22.023 D/GeckoViewNavigation( 3414): onEnable
[task 2022-05-18T15:48:56.897Z] 15:48:56 INFO - 05-18 15:48:22.024 D/GeckoViewProcessHangMonitor( 3414): onInit
[task 2022-05-18T15:48:56.898Z] 15:48:56 INFO - 05-18 15:48:22.024 D/GeckoViewProcessHangMonitor( 3414): onEnable
[task 2022-05-18T15:48:56.898Z] 15:48:56 INFO - 05-18 15:48:22.025 D/GeckoViewModule( 3414): registerListener ["GeckoView:HangReportStop","GeckoView:HangReportWait"]
[task 2022-05-18T15:48:56.898Z] 15:48:56 INFO - 05-18 15:48:22.026 D/GeckoViewProgress( 3414): onEnable
[task 2022-05-18T15:48:56.899Z] 15:48:56 INFO - 05-18 15:48:22.027 D/GeckoViewModule( 3414): registerListener GeckoView:FlushSessionState
[task 2022-05-18T15:48:56.899Z] 15:48:56 INFO - 05-18 15:48:22.028 D/EGL_emulation(23815): eglMakeCurrent: 0x78d14067ba40: ver 3 0 (tinfo 0x78d1406b4c00)
[task 2022-05-18T15:48:56.900Z] 15:48:56 INFO - 05-18 15:48:22.028 D/GeckoViewSelectionAction( 3414): onEnable
[task 2022-05-18T15:48:56.900Z] 15:48:56 INFO - 05-18 15:48:22.028 D/GeckoViewModule( 3414): registerListener ["GeckoView:ExecuteSelectionAction"]
[task 2022-05-18T15:48:56.900Z] 15:48:56 INFO - 05-18 15:48:22.029 D/GeckoSession( 3414): handleMessage GeckoView:PageStart uri=about:blank
[task 2022-05-18T15:48:56.901Z] 15:48:56 INFO - 05-18 15:48:22.029 E/GeckoSessionTestRule( 3414): method: public abstract void org.mozilla.geckoview.GeckoSession$ProgressDelegate.onPageStart(org.mozilla.geckoview.GeckoSession,java.lang.String)
[task 2022-05-18T15:48:56.901Z] 15:48:56 INFO - 05-18 15:48:22.029 D/GeckoSession( 3414): handleMessage GeckoView:LocationChange uri=about:blank
[task 2022-05-18T15:48:56.902Z] 15:48:56 INFO - 05-18 15:48:22.029 E/GeckoSessionTestRule( 3414): method: public abstract void org.mozilla.geckoview.GeckoSession$NavigationDelegate.onLocationChange(org.mozilla.geckoview.GeckoSession,java.lang.String,java.util.List)
[task 2022-05-18T15:48:56.902Z] 15:48:56 INFO - 05-18 15:48:22.029 E/GeckoSessionTestRule( 3414): method: public abstract void org.mozilla.geckoview.GeckoSession$NavigationDelegate.onCanGoBack(org.mozilla.geckoview.GeckoSession,boolean)
[task 2022-05-18T15:48:56.903Z] 15:48:56 INFO - 05-18 15:48:22.029 D/GeckoViewSettings( 3414): onInit
[task 2022-05-18T15:48:56.903Z] 15:48:56 INFO - 05-18 15:48:22.029 E/GeckoSessionTestRule( 3414): method: public abstract void org.mozilla.geckoview.GeckoSession$NavigationDelegate.onCanGoForward(org.mozilla.geckoview.GeckoSession,boolean)
[task 2022-05-18T15:48:56.904Z] 15:48:56 INFO - 05-18 15:48:22.029 D/GeckoSession( 3414): handleMessage GeckoView:PageStop uri=null
[task 2022-05-18T15:48:56.904Z] 15:48:56 INFO - 05-18 15:48:22.029 E/GeckoSessionTestRule( 3414): method: public abstract void org.mozilla.geckoview.GeckoSession$ProgressDelegate.onPageStop(org.mozilla.geckoview.GeckoSession,boolean)
[task 2022-05-18T15:48:56.905Z] 15:48:56 INFO - 05-18 15:48:22.029 E/GeckoSessionTestRule( 3414): after prepareStatement
[task 2022-05-18T15:48:56.905Z] 15:48:56 INFO - 05-18 15:48:22.030 D/GeckoViewModule( 3414): registerListener ["GeckoView:GetUserAgent"]
[task 2022-05-18T15:48:56.905Z] 15:48:56 INFO - 05-18 15:48:22.030 D/GeckoViewSettings( 3414): onSettingsUpdate: {"chromeUri":null,"screenId":0,"userAgentOverride":null,"allowJavascript":true,"userAgentMode":0,"viewportMode":0,"useTrackingProtection":false,"suspendMediaWhenInactive":false,"usePrivateMode":false,"unsafeSessionContextId":null,"displayMode":0,"sessionContextId":null,"fullAccessibilityTree":false,"isPopup":false}
[task 2022-05-18T15:48:56.906Z] 15:48:56 INFO - 05-18 15:48:22.032 D/GeckoViewModule( 3414): registerListener ["GeckoView:WebExtension:SetTabActive"]
[task 2022-05-18T15:48:56.906Z] 15:48:56 INFO - 05-18 15:48:22.032 D/GeckoViewSelectionActionDelegate[C](15137): handleEvent: visibilitychange
[task 2022-05-18T15:48:56.906Z] 15:48:56 INFO - 05-18 15:48:22.032 D/GeckoViewModule( 3414): registerListener ["ContentBlocking:RequestLog"]
[task 2022-05-18T15:48:56.906Z] 15:48:56 INFO - 05-18 15:48:22.033 D/GeckoViewMediaControl( 3414): onEnable
[task 2022-05-18T15:48:56.906Z] 15:48:56 INFO - 05-18 15:48:22.034 D/GeckoViewSettings[C](15137): receiveMessage: SettingsUpdate
[task 2022-05-18T15:48:56.907Z] 15:48:56 INFO - 05-18 15:48:22.034 D/GeckoViewModule( 3414): registerListener ["GeckoView:MediaSession:Play","GeckoView:MediaSession:Pause","GeckoView:MediaSession:Stop","GeckoView:MediaSession:NextTrack","GeckoView:MediaSession:PrevTrack","GeckoView:MediaSession:SeekForward","GeckoView:MediaSession:SeekBackward","GeckoView:MediaSession:SkipAd","GeckoView:MediaSession:SeekTo","GeckoView:MediaSession:MuteAudio"]
[task 2022-05-18T15:48:56.907Z] 15:48:56 INFO - 05-18 15:48:22.037 I/GeckoSession( 3414): zerdatime 683702 - chrome startup finished
[task 2022-05-18T15:48:56.907Z] 15:48:56 INFO - 05-18 15:48:22.038 I/Gecko ( 3414): nsWindow[0x78d0d4727700]::Show 1
[task 2022-05-18T15:48:56.907Z] 15:48:56 INFO - 05-18 15:48:22.041 I/Gecko ( 3414): nsWindow[0x78d0d4727700]::Resize [0.000000 0.000000 400.000000 400.000000] (repaint 0)
[task 2022-05-18T15:48:56.908Z] 15:48:56 INFO - 05-18 15:48:22.041 W/GeckoEditableChild(15137): No editable parent
[task 2022-05-18T15:48:56.908Z] 15:48:56 INFO - 05-18 15:48:22.043 D/GeckoViewXUL( 3414): receiveMessage GeckoView:ContentModuleLoaded {}
[task 2022-05-18T15:48:56.908Z] 15:48:56 INFO - 05-18 15:48:22.043 D/GeckoViewModule( 3414): dispatch GeckoView:LoadUri, data={"uri":"http://localhost:4245/assets/www/inputs.html","flags":0,"headerFilter":1}
[task 2022-05-18T15:48:56.908Z] 15:48:56 INFO - 05-18 15:48:22.044 D/GeckoViewNavigation( 3414): onEvent: event=GeckoView:LoadUri, data={"uri":"http://localhost:4245/assets/www/inputs.html","flags":0,"headerFilter":1}
[task 2022-05-18T15:48:56.909Z] 15:48:56 INFO - 05-18 15:48:22.052 E/eglCodecCommon(23815): glUtilsParamSize: unknow param 0x00008caa
[task 2022-05-18T15:48:56.909Z] 15:48:56 INFO - 05-18 15:48:22.055 D/GeckoViewProgress( 3414): ProgressTracker onStateChange: isTopLevel=true, flags=0xf0001, status=NS_OK
[task 2022-05-18T15:48:56.909Z] 15:48:56 INFO - 05-18 15:48:22.056 D/GeckoViewProgress( 3414): ProgressTracker onStateChange: uri=http://localhost:4245/assets/www/inputs.html
[task 2022-05-18T15:48:56.909Z] 15:48:56 INFO - 05-18 15:48:22.056 D/GeckoViewProgress( 3414): ProgressTracker start http://localhost:4245/assets/www/inputs.html
[task 2022-05-18T15:48:56.909Z] 15:48:56 INFO - 05-18 15:48:22.057 D/GeckoViewProgress( 3414): ProgressTracker updateProgress
[task 2022-05-18T15:48:56.910Z] 15:48:56 INFO - 05-18 15:48:22.057 D/GeckoViewProgress( 3414): ProgressTracker updateProgress data={"prev":0,"uri":"http://localhost:4245/assets/www/inputs.html","locationChange":false,"pageStart":true,"pageStop":false,"firstPaint":false,"pageShow":false,"parsed":false} progress=15
[task 2022-05-18T15:48:56.910Z] 15:48:56 INFO - 05-18 15:48:22.058 D/GeckoSession( 3414): handleMessage GeckoView:ProgressChanged uri=null
[task 2022-05-18T15:48:56.911Z] 15:48:56 INFO - 05-18 15:48:22.060 D/GeckoViewProgress( 3414): StateTracker onStateChange: isTopLevel=true, flags=0xf0001, status=NS_OK loadType=1
[task 2022-05-18T15:48:56.911Z] 15:48:56 INFO - 05-18 15:48:22.060 D/GeckoSession( 3414): handleMessage GeckoView:PageStart uri=http://localhost:4245/assets/www/inputs.html
[task 2022-05-18T15:48:56.911Z] 15:48:56 INFO - 05-18 15:48:22.071 I/art (25923): Late-enabling -Xcheck:jni
[task 2022-05-18T15:48:56.911Z] 15:48:56 INFO - 05-18 15:48:22.072 W/art (25923): Unexpected CPU variant for X86 using defaults: x86_64
[task 2022-05-18T15:48:56.911Z] 15:48:56 INFO - 05-18 15:48:22.076 I/ActivityManager( 1650): Start proc 25923:org.mozilla.geckoview.test:tab27/u0a62 for service org.mozilla.geckoview.test/org.mozilla.gecko.process.GeckoChildProcessServices$tab27
[task 2022-05-18T15:48:56.912Z] 15:48:56 INFO - 05-18 15:48:22.077 D/ServiceAllocator( 3414): org.mozilla.gecko.process.GeckoChildProcessServices$tab27 updateBindings: FOREGROUND priority, 0 importance, 3 successful binds, 0 failed binds, 0 successful unbinds
[task 2022-05-18T15:48:56.913Z] 15:48:56 INFO - 05-18 15:48:22.085 I/WindowManager( 1650): Destroying surface Surface(name=Starting org.mozilla.geckoview.test) called by com.android.server.wm.WindowStateAnimator.destroySurface:2014 com.android.server.wm.WindowStateAnimator.destroySurfaceLocked:881 com.android.server.wm.WindowState.destroyOrSaveSurface:2073 com.android.server.wm.AppWindowToken.destroySurfaces:363 com.android.server.wm.WindowStateAnimator.finishExit:565 com.android.server.wm.WindowStateAnimator.stepAnimationLocked:491 com.android.server.wm.WindowAnimator.updateWindowsLocked:303 com.android.server.wm.WindowAnimator.animateLocked:704
[task 2022-05-18T15:48:56.913Z] 15:48:56 INFO - 05-18 15:48:22.089 I/MultiDex(25923): VM with version 2.1.0 has multidex support
[task 2022-05-18T15:48:56.913Z] 15:48:56 INFO - 05-18 15:48:22.089 I/MultiDex(25923): Installing application
[task 2022-05-18T15:48:56.913Z] 15:48:56 INFO - 05-18 15:48:22.089 I/MultiDex(25923): VM has multidex support, MultiDex support library is disabled.
[task 2022-05-18T15:48:56.914Z] 15:48:56 INFO - 05-18 15:48:22.092 I/ServiceChildProcess(25923): onCreate
[task 2022-05-18T15:48:56.914Z] 15:48:56 INFO - 05-18 15:48:22.094 D/GeckoThread(25923): State changed to LAUNCHED
[task 2022-05-18T15:48:56.914Z] 15:48:56 INFO - 05-18 15:48:22.094 I/GeckoThread(25923): preparing to run Gecko
[task 2022-05-18T15:48:56.914Z] 15:48:56 INFO - 05-18 15:48:22.098 D/GeckoThread(25923): env var: MOZ_CRASHREPORTER=1
[task 2022-05-18T15:48:56.914Z] 15:48:56 INFO - 05-18 15:48:22.098 D/GeckoThread(25923): env var: MOZ_CRASHREPORTER_SHUTDOWN=1
[task 2022-05-18T15:48:56.914Z] 15:48:56 INFO - 05-18 15:48:22.098 D/GeckoThread(25923): env var: XPCOM_DEBUG_BREAK=stack
[task 2022-05-18T15:48:56.914Z] 15:48:56 INFO - 05-18 15:48:22.098 D/GeckoThread(25923): env var: MOZ_DISABLE_NONLOCAL_CONNECTIONS=1
[task 2022-05-18T15:48:56.915Z] 15:48:56 INFO - 05-18 15:48:22.098 D/GeckoThread(25923): env var: MOZ_IN_AUTOMATION=1
[task 2022-05-18T15:48:56.915Z] 15:48:56 INFO - 05-18 15:48:22.098 D/GeckoThread(25923): env var: R_LOG_VERBOSE=1
[task 2022-05-18T15:48:56.915Z] 15:48:56 INFO - 05-18 15:48:22.098 D/GeckoThread(25923): env var: R_LOG_LEVEL=6
[task 2022-05-18T15:48:56.915Z] 15:48:56 INFO - 05-18 15:48:22.098 D/GeckoThread(25923): env var: R_LOG_DESTINATION=stderr
[task 2022-05-18T15:48:56.915Z] 15:48:56 INFO - 05-18 15:48:22.098 D/GeckoThread(25923): env var: MOZ_WEBRENDER=1
[task 2022-05-18T15:48:56.915Z] 15:48:56 INFO - 05-18 15:48:22.098 D/GeckoThread(25923): env var: MOZ_FORCE_ENABLE_FISSION=1
[task 2022-05-18T15:48:56.916Z] 15:48:56 INFO - 05-18 15:48:22.099 D/ServiceAllocator( 3414): org.mozilla.gecko.process.GeckoChildProcessServices$tab27 updateBindings: FOREGROUND priority, 2 importance, 0 successful binds, 0 failed binds, 0 successful unbinds
[task 2022-05-18T15:48:56.916Z] 15:48:56 INFO - 05-18 15:48:22.099 D/GeckoThread(25923): State changed to MOZGLUE_READY
[task 2022-05-18T15:48:56.916Z] 15:48:56 INFO - 05-18 15:48:22.100 I/GeckoLoader(25923): Library base=/data/app/org.mozilla.geckoview.test-1/lib/x86_64
[task 2022-05-18T15:48:56.916Z] 15:48:56 INFO - 05-18 15:48:22.100 I/GeckoLoader(25923): Library base=/data/app/org.mozilla.geckoview.test-1/lib/x86_64
[task 2022-05-18T15:48:56.916Z] 15:48:56 INFO - 05-18 15:48:22.100 E/GeckoLibLoad(25923): Load sqlite start
[task 2022-05-18T15:48:56.916Z] 15:48:56 INFO - 05-18 15:48:22.101 E/GeckoLibLoad(25923): Load sqlite done
[task 2022-05-18T15:48:56.916Z] 15:48:56 INFO - 05-18 15:48:22.101 I/GeckoLoader(25923): Library base=/data/app/org.mozilla.geckoview.test-1/lib/x86_64
[task 2022-05-18T15:48:56.916Z] 15:48:56 INFO - 05-18 15:48:22.101 E/GeckoLibLoad(25923): Load nss start
[task 2022-05-18T15:48:56.917Z] 15:48:56 INFO - 05-18 15:48:22.101 E/GeckoLibLoad(25923): Load nss done
[task 2022-05-18T15:48:56.917Z] 15:48:56 INFO - 05-18 15:48:22.101 I/GeckoLoader(25923): Library base=/data/app/org.mozilla.geckoview.test-1/lib/x86_64
[task 2022-05-18T15:48:56.917Z] 15:48:56 INFO - 05-18 15:48:22.109 W/webrender::device::gl(23815): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-05-18T15:48:56.917Z] 15:48:56 INFO - 05-18 15:48:22.109 W/webrender::device::gl(23815): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-05-18T15:48:56.917Z] 15:48:56 INFO - 05-18 15:48:22.113 W/webrender::device::gl(23815): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-05-18T15:48:56.917Z] 15:48:56 INFO - 05-18 15:48:22.114 E/GeckoLibLoad(25923): Loaded libs in 13.130193ms total, 10ms(10ms) user, 0ms(0ms) system, 0(0) faults
[task 2022-05-18T15:48:56.917Z] 15:48:56 INFO - 05-18 15:48:22.114 D/GeckoThread(25923): State changed to LIBS_READY
[task 2022-05-18T15:48:56.917Z] 15:48:56 INFO - 05-18 15:48:22.114 W/GeckoThread(25923): zerdatime 683779 - runGecko
[task 2022-05-18T15:48:56.918Z] 15:48:56 INFO - 05-18 15:48:22.116 D/GeckoViewXUL( 3414): WillChangeBrowserRemoteness
[task 2022-05-18T15:48:56.918Z] 15:48:56 INFO - 05-18 15:48:22.121 D/GeckoViewSelectionActionDelegate[C](15137): handleEvent: visibilitychange
[task 2022-05-18T15:48:56.918Z] 15:48:56 INFO - 05-18 15:48:22.122 D/GeckoViewXUL( 3414): DidChangeBrowserRemoteness
[task 2022-05-18T15:48:56.918Z] 15:48:56 INFO - 05-18 15:48:22.123 D/GeckoViewNavigation( 3414): sessionContextId=null
[task 2022-05-18T15:48:56.918Z] 15:48:56 INFO - 05-18 15:48:22.123 D/GeckoViewAutoFill[C](15137): handleEvent: pagehide
[task 2022-05-18T15:48:56.918Z] 15:48:56 INFO - 05-18 15:48:22.128 D/GeckoViewAutoFill( 3414): receiveMessage Clear
[task 2022-05-18T15:48:56.918Z] 15:48:56 INFO - 05-18 15:48:22.136 E/eglCodecCommon(23815): glUtilsParamSize: unknow param 0x00008caa
[task 2022-05-18T15:48:56.918Z] 15:48:56 INFO - 05-18 15:48:22.142 W/webrender::device::gl(23815): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-05-18T15:48:56.918Z] 15:48:56 INFO - 05-18 15:48:22.142 W/webrender::device::gl(23815): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-05-18T15:48:56.918Z] 15:48:56 INFO - 05-18 15:48:22.145 W/webrender::device::gl(23815): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-05-18T15:48:56.919Z] 15:48:56 INFO - 05-18 15:48:22.193 D/GeckoThread(25923): State changed to RUNNING
[task 2022-05-18T15:48:56.919Z] 15:48:56 INFO - 05-18 15:48:22.230 D/GeckoViewStartup(25923): observe: content-process-ready-for-script
[task 2022-05-18T15:48:56.919Z] 15:48:56 INFO - 05-18 15:48:22.234 D/GeckoViewConsole(25923): enabled = true
[task 2022-05-18T15:48:56.919Z] 15:48:56 INFO - 05-18 15:48:22.266 E/eglCodecCommon(23815): glUtilsParamSize: unknow param 0x00008caa
[task 2022-05-18T15:48:56.919Z] 15:48:56 INFO - 05-18 15:48:22.270 W/webrender::device::gl(23815): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-05-18T15:48:56.919Z] 15:48:56 INFO - 05-18 15:48:22.271 W/webrender::device::gl(23815): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-05-18T15:48:56.919Z] 15:48:56 INFO - 05-18 15:48:22.273 W/webrender::device::gl(23815): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-05-18T15:48:56.919Z] 15:48:56 INFO - 05-18 15:48:22.285 E/eglCodecCommon(23815): glUtilsParamSize: unknow param 0x00008caa
[task 2022-05-18T15:48:56.919Z] 15:48:56 INFO - 05-18 15:48:26.262 D/GeckoViewXUL( 3414): receiveMessage GeckoView:ContentModuleLoaded {}
[task 2022-05-18T15:48:56.920Z] 15:48:56 INFO - 05-18 15:48:26.280 D/GeckoViewSelectionActionDelegate[C](25923): handleEvent: visibilitychange
[task 2022-05-18T15:48:56.920Z] 15:48:56 INFO - 05-18 15:48:26.286 D/GeckoViewAutoFill[C](25923): handleEvent: pagehide
[task 2022-05-18T15:48:56.920Z] 15:48:56 INFO - 05-18 15:48:26.288 D/GeckoViewAutoFill( 3414): receiveMessage Clear
[task 2022-05-18T15:48:56.920Z] 15:48:56 INFO - 05-18 15:48:26.297 W/Isolated Web Content(25923): [JavaScript Warning: "This page is in Quirks Mode. Page layout may be impacted. For Standards Mode use “<!DOCTYPE html>”." {file: "http://localhost:4245/assets/www/inputs.html" line: 0}]
[task 2022-05-18T15:48:56.920Z] 15:48:56 INFO - 05-18 15:48:26.298 D/GeckoViewNavigation( 3414): onLocationChange
[task 2022-05-18T15:48:56.921Z] 15:48:56 INFO - 05-18 15:48:26.301 D/GeckoSession( 3414): handleMessage GeckoView:LocationChange uri=http://localhost:4245/assets/www/inputs.html
[task 2022-05-18T15:48:56.921Z] 15:48:56 INFO - 05-18 15:48:26.301 D/GeckoViewProgress( 3414): SecurityTracker onLocationChange: location=http://localhost:4245/assets/www/inputs.html, flags=0
[task 2022-05-18T15:48:56.921Z] 15:48:56 INFO - 05-18 15:48:26.301 D/GeckoViewProgress( 3414): ProgressTracker onLocationChange: location=http://localhost:4245/assets/www/inputs.html, flags=0
[task 2022-05-18T15:48:56.921Z] 15:48:56 INFO - 05-18 15:48:26.301 D/GeckoViewProgress( 3414): ProgressTracker changeLocation http://localhost:4245/assets/www/inputs.html
[task 2022-05-18T15:48:56.921Z] 15:48:56 INFO - 05-18 15:48:26.301 D/GeckoViewProgress( 3414): onSecurityChange
[task 2022-05-18T15:48:56.921Z] 15:48:56 INFO - 05-18 15:48:26.304 D/GeckoSession( 3414): handleMessage GeckoView:SecurityChanged uri=null
[task 2022-05-18T15:48:56.921Z] 15:48:56 INFO - 05-18 15:48:29.416 I/Gecko ( 3414): nsWindow 0x78d0d2f2f100 destructor
[task 2022-05-18T15:48:56.922Z] 15:48:56 INFO - 05-18 15:48:29.417 I/Gecko ( 3414): nsWindow 0x78d0d2f2fa00 destructor
[task 2022-05-18T15:48:56.922Z] 15:48:56 INFO - 05-18 15:48:29.417 I/Gecko ( 3414): nsWindow 0x78d0d4727400 destructor
[task 2022-05-18T15:48:56.922Z] 15:48:56 INFO - 05-18 15:48:29.417 I/Gecko ( 3414): nsWindow 0x78d0d2f31800 destructor
[task 2022-05-18T15:48:56.922Z] 15:48:56 INFO - 05-18 15:48:29.417 I/Gecko ( 3414): nsWindow 0x78d0d2f30600 destructor
[task 2022-05-18T15:48:56.922Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): Error
[task 2022-05-18T15:48:56.922Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2022-05-18T15:48:56.922Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:49)
[task 2022-05-18T15:48:56.923Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at android.os.Handler.handleCallback(Handler.java:751)
[task 2022-05-18T15:48:56.923Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2022-05-18T15:48:56.923Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:158)
[task 2022-05-18T15:48:56.923Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1775)
[task 2022-05-18T15:48:56.923Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForPageStops(GeckoSessionTestRule.java:1531)
[task 2022-05-18T15:48:56.924Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForPageStop(GeckoSessionTestRule.java:1506)
[task 2022-05-18T15:48:56.924Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.BaseSessionTest.waitForPageStop(BaseSessionTest.kt:183)
[task 2022-05-18T15:48:56.924Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.SelectionActionDelegateTest.testThat(SelectionActionDelegateTest.kt:271)
[task 2022-05-18T15:48:56.925Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.SelectionActionDelegateTest.access$testThat(SelectionActionDelegateTest.kt:37)
[task 2022-05-18T15:48:56.925Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.SelectionActionDelegateTest$cut$1$1.invoke(SelectionActionDelegateTest.kt:155)
[task 2022-05-18T15:48:56.925Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.SelectionActionDelegateTest$cut$1$1.invoke(SelectionActionDelegateTest.kt:154)
[task 2022-05-18T15:48:56.925Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.SelectionActionDelegateTest.withClipboard(SelectionActionDelegateTest.kt:368)
[task 2022-05-18T15:48:56.926Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.SelectionActionDelegateTest.access$withClipboard(SelectionActionDelegateTest.kt:37)
[task 2022-05-18T15:48:56.926Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.SelectionActionDelegateTest$cut$1.invoke(SelectionActionDelegateTest.kt:154)
[task 2022-05-18T15:48:56.926Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.SelectionActionDelegateTest$cut$1.invoke(SelectionActionDelegateTest.kt:153)
[task 2022-05-18T15:48:56.926Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.SelectionActionDelegateTest.assumingEditable(SelectionActionDelegateTest.kt:393)
[task 2022-05-18T15:48:56.927Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.SelectionActionDelegateTest.cut(SelectionActionDelegateTest.kt:153)
[task 2022-05-18T15:48:56.927Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at java.lang.reflect.Method.invoke(Native Method)
[task 2022-05-18T15:48:56.927Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
[task 2022-05-18T15:48:56.927Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
[task 2022-05-18T15:48:56.927Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
[task 2022-05-18T15:48:56.928Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
[task 2022-05-18T15:48:56.928Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
[task 2022-05-18T15:48:56.928Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.lambda$evaluate$0$org-mozilla-geckoview-test-rule-GeckoSessionTestRule$2(GeckoSessionTestRule.java:1460)
[task 2022-05-18T15:48:56.928Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2$$ExternalSyntheticLambda0.run(Unknown Source)
[task 2022-05-18T15:48:56.928Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:428)
[task 2022-05-18T15:48:56.929Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at java.util.concurrent.FutureTask.run(FutureTask.java:237)
[task 2022-05-18T15:48:56.929Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1950)
[task 2022-05-18T15:48:56.929Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at android.os.Handler.handleCallback(Handler.java:751)
[task 2022-05-18T15:48:56.929Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2022-05-18T15:48:56.929Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at android.os.Looper.loop(Looper.java:154)
[task 2022-05-18T15:48:56.929Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at android.app.ActivityThread.main(ActivityThread.java:6077)
[task 2022-05-18T15:48:56.929Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at java.lang.reflect.Method.invoke(Native Method)
[task 2022-05-18T15:48:56.929Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:866)
[task 2022-05-18T15:48:56.930Z] 15:48:56 INFO - 05-18 15:48:56.306 E/GeckoSessionTestRule( 3414): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:756)
[task 2022-05-18T15:48:56.930Z] 15:48:56 INFO - 05-18 15:48:56.308 D/EGL_emulation(23815): eglMakeCurrent: 0x78d14067ba40: ver 3 0 (tinfo 0x78d1406b4c00)
[task 2022-05-18T15:48:56.930Z] 15:48:56 INFO - 05-18 15:48:56.312 D/GeckoViewContent( 3414): handleEvent: DOMWindowClose
[task 2022-05-18T15:48:56.930Z] 15:48:56 INFO - 05-18 15:48:56.316 D/GeckoViewConsole( 3414): onEvent GeckoView:WebExtension:List null
[task 2022-05-18T15:48:56.930Z] 15:48:56 INFO - 05-18 15:48:56.322 E/GeckoSessionTestRule( 3414): test_end c5ee677f-bc83-49bd-9e28-2d35f3d0f059 cut[#contenteditable](org.mozilla.geckoview.test.SelectionActionDelegateTest)
[task 2022-05-18T15:48:56.930Z] 15:48:56 WARNING - TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.SelectionActionDelegateTest#cut[#contenteditable] | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2022-05-18T15:48:56.931Z] 15:48:56 INFO - TEST-INFO took 34896ms
[task 2022-05-18T15:48:56.931Z] 15:48:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=916
[task 2022-05-18T15:48:56.931Z] 15:48:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2022-05-18T15:48:56.931Z] 15:48:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2022-05-18T15:48:56.931Z] 15:48:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=copy[#contenteditable]
[task 2022-05-18T15:48:56.931Z] 15:48:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.SelectionActionDelegateTest
[task 2022-05-18T15:48:56.931Z] 15:48:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=606
[task 2022-05-18T15:48:56.931Z] 15:48:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 1
[task 2022-05-18T15:48:56.931Z] 15:48:56 INFO - TEST-START | org.mozilla.geckoview.test.SelectionActionDelegateTest#copy[#contenteditable]
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•4 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE
|
||
Updated•4 years ago
|
Resolution: INCOMPLETE → DUPLICATE
You need to log in
before you can comment on or make changes to this bug.
Description
•