Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=465631396&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/BLgUrkpRTY-OsqhGHhFLDg/runs/0/artifacts/public/logs/live_backing.log
[task 2024-07-09T16:16:28.745Z] 16:16:28 INFO - TEST-START | org.mozilla.geckoview.test.AccessibilityTest#autoFill
[task 2024-07-09T16:16:30.110Z] 16:16:30 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=1146
[task 2024-07-09T16:16:30.111Z] 16:16:30 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2024-07-09T16:16:30.111Z] 16:16:30 INFO - org.mozilla.geckoview.test | Error in autoFill(org.mozilla.geckoview.test.AccessibilityTest):
[task 2024-07-09T16:16:30.111Z] 16:16:30 INFO - org.mozilla.geckoview.test | org.mozilla.geckoview.test.rule.GeckoSessionTestRule$RejectedPromiseException: org.mozilla.geckoview.test.rule.GeckoSessionTestRule$MessageDelegate$PortDisconnectException: The port disconnected before a message could be received.Usually this happens when the page navigates away while waiting for a message.
[task 2024-07-09T16:16:30.111Z] 16:16:30 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForMessage(GeckoSessionTestRule.java:2543)
[task 2024-07-09T16:16:30.111Z] 16:16:30 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.evaluateJS(GeckoSessionTestRule.java:2471)
[task 2024-07-09T16:16:30.111Z] 16:16:30 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$ExtensionPromise.getValue(GeckoSessionTestRule.java:2438)
[task 2024-07-09T16:16:30.112Z] 16:16:30 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.AccessibilityTest.autoFill(AccessibilityTest.kt:1400)
[task 2024-07-09T16:16:30.112Z] 16:16:30 INFO - org.mozilla.geckoview.test |
[task 2024-07-09T16:16:30.112Z] 16:16:30 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2024-07-09T16:16:30.112Z] 16:16:30 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=autoFill
[task 2024-07-09T16:16:30.112Z] 16:16:30 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.AccessibilityTest
[task 2024-07-09T16:16:30.112Z] 16:16:30 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stack=org.mozilla.geckoview.test.rule.GeckoSessionTestRule$RejectedPromiseException: org.mozilla.geckoview.test.rule.GeckoSessionTestRule$MessageDelegate$PortDisconnectException: The port disconnected before a message could be received.Usually this happens when the page navigates away while waiting for a message.
[task 2024-07-09T16:16:30.112Z] 16:16:30 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForMessage(GeckoSessionTestRule.java:2543)
[task 2024-07-09T16:16:30.113Z] 16:16:30 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.evaluateJS(GeckoSessionTestRule.java:2471)
[task 2024-07-09T16:16:30.113Z] 16:16:30 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$ExtensionPromise.getValue(GeckoSessionTestRule.java:2438)
[task 2024-07-09T16:16:30.113Z] 16:16:30 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.AccessibilityTest.autoFill(AccessibilityTest.kt:1400)
[task 2024-07-09T16:16:30.113Z] 16:16:30 INFO - org.mozilla.geckoview.test |
[task 2024-07-09T16:16:30.113Z] 16:16:30 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=36
[task 2024-07-09T16:16:30.113Z] 16:16:30 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: -2
[task 2024-07-09T16:16:30.113Z] 16:16:30 INFO - Printing logcat for test:
[task 2024-07-09T16:16:30.622Z] 16:16:30 INFO - 07-09 16:16:28.287 E/GeckoSessionTestRule( 3452): test_start 1f0befec-3ff2-40ff-89cf-b127eb38b1ec autoFill(org.mozilla.geckoview.test.AccessibilityTest)
[task 2024-07-09T16:16:30.622Z] 16:16:30 INFO - 07-09 16:16:28.287 E/GeckoSessionTestRule( 3452): before prepareStatement autoFill(org.mozilla.geckoview.test.AccessibilityTest)
[task 2024-07-09T16:16:30.622Z] 16:16:30 INFO - 07-09 16:16:28.289 D/GeckoViewStartup( 3452): onEvent GeckoView:StorageDelegate:Attached
[task 2024-07-09T16:16:30.622Z] 16:16:30 INFO - 07-09 16:16:28.289 I/Gecko ( 3452): nsWindow[0x79094f743700]::Create 0x0 [0 0 1 1]
[task 2024-07-09T16:16:30.623Z] 16:16:30 INFO - 07-09 16:16:28.301 I/Gecko ( 3452): nsWindow[0x79094f743700]::Resize [0.000000 0.000000 480.000000 640.000000] (repaint 0)
[task 2024-07-09T16:16:30.623Z] 16:16:30 INFO - 07-09 16:16:28.301 I/Gecko ( 3452): nsWindow: 0x79094f743700 OnSizeChanged [480 640]
[task 2024-07-09T16:16:30.623Z] 16:16:30 INFO - 07-09 16:16:28.324 D/GeckoViewNavigation( 3452): sessionContextId=null
[task 2024-07-09T16:16:30.623Z] 16:16:30 INFO - 07-09 16:16:28.330 D/GeckoViewSessionStore( 3452): observe browsing-context-did-set-embedder
[task 2024-07-09T16:16:30.623Z] 16:16:30 INFO - 07-09 16:16:28.331 D/GeckoViewSessionStore( 3452): observe browsing-context-did-set-embedder
[task 2024-07-09T16:16:30.623Z] 16:16:30 INFO - 07-09 16:16:28.340 E/eglCodecCommon( 3525): glUtilsParamSize: unknow param 0x00008caa
[task 2024-07-09T16:16:30.623Z] 16:16:30 INFO - 07-09 16:16:28.413 W/webrender::device::gl( 3525): Missing optimized shader source for gpu_cache_update
[task 2024-07-09T16:16:30.623Z] 16:16:30 INFO - 07-09 16:16:28.422 E/eglCodecCommon( 3525): glUtilsParamSize: unknow param 0x00008741
[task 2024-07-09T16:16:30.624Z] 16:16:30 INFO - 07-09 16:16:28.439 D/GeckoViewModule( 3452): registerListener ["GeckoViewContent:ExitFullScreen","GeckoView:ClearMatches","GeckoView:DisplayMatches","GeckoView:FindInPage","GeckoView:HasCookieBannerRuleForBrowsingContextTree","GeckoView:RestoreState","GeckoView:ContainsFormData","GeckoView:RequestCreateAnalysis","GeckoView:RequestAnalysisStatus","GeckoView:RequestAnalysisCreationStatus","GeckoView:PollForAnalysisCompleted","GeckoView:SendClickAttributionEvent","GeckoView:SendImpressionAttributionEvent","GeckoView:SendPlacementAttributionEvent","GeckoView:RequestAnalysis","GeckoView:RequestRecommendations","GeckoView:ReportBackInStock","GeckoView:ScrollBy","GeckoView:ScrollTo","GeckoView:SetActive","GeckoView:SetFocused","GeckoView:SetPriorityHint","GeckoView:UpdateInitData","GeckoView:ZoomToInput","GeckoView:IsPdfJs"]
[task 2024-07-09T16:16:30.624Z] 16:16:30 INFO - 07-09 16:16:28.440 D/GeckoViewNavigation( 3452): onInit
[task 2024-07-09T16:16:30.624Z] 16:16:30 INFO - 07-09 16:16:28.441 D/GeckoViewModule( 3452): registerListener ["GeckoView:GoBack","GeckoView:GoForward","GeckoView:GotoHistoryIndex","GeckoView:LoadUri","GeckoView:Reload","GeckoView:Stop","GeckoView:PurgeHistory","GeckoView:DotPrintFinish"]
[task 2024-07-09T16:16:30.624Z] 16:16:30 INFO - 07-09 16:16:28.441 D/GeckoViewNavigation( 3452): onEnable
[task 2024-07-09T16:16:30.624Z] 16:16:30 INFO - 07-09 16:16:28.441 D/GeckoViewProcessHangMonitor( 3452): onInit
[task 2024-07-09T16:16:30.624Z] 16:16:30 INFO - 07-09 16:16:28.441 D/GeckoViewProcessHangMonitor( 3452): onEnable
[task 2024-07-09T16:16:30.625Z] 16:16:30 INFO - 07-09 16:16:28.442 D/GeckoViewModule( 3452): registerListener ["GeckoView:HangReportStop","GeckoView:HangReportWait"]
[task 2024-07-09T16:16:30.625Z] 16:16:30 INFO - 07-09 16:16:28.442 D/GeckoViewProgress( 3452): onEnable
[task 2024-07-09T16:16:30.625Z] 16:16:30 INFO - 07-09 16:16:28.443 D/EGL_emulation( 3525): eglMakeCurrent: 0x79097f859280: ver 3 0 (tinfo 0x79097f80c460)
[task 2024-07-09T16:16:30.625Z] 16:16:30 INFO - 07-09 16:16:28.444 D/GeckoViewModule( 3452): registerListener GeckoView:FlushSessionState
[task 2024-07-09T16:16:30.625Z] 16:16:30 INFO - 07-09 16:16:28.445 D/GeckoViewSelectionAction( 3452): onEnable
[task 2024-07-09T16:16:30.625Z] 16:16:30 INFO - 07-09 16:16:28.445 D/GeckoViewModule( 3452): registerListener ["GeckoView:ExecuteSelectionAction"]
[task 2024-07-09T16:16:30.625Z] 16:16:30 INFO - 07-09 16:16:28.446 D/GeckoViewSettings( 3452): onInit
[task 2024-07-09T16:16:30.626Z] 16:16:30 INFO - 07-09 16:16:28.446 I/WindowManager( 1659): 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 2024-07-09T16:16:30.626Z] 16:16:30 INFO - 07-09 16:16:28.446 D/GeckoViewModule( 3452): registerListener ["GeckoView:GetUserAgent"]
[task 2024-07-09T16:16:30.626Z] 16:16:30 INFO - 07-09 16:16:28.446 D/GeckoViewSettings( 3452): onSettingsUpdate: {"isExtensionPopup":false,"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}
[task 2024-07-09T16:16:30.626Z] 16:16:30 INFO - 07-09 16:16:28.447 D/GeckoSession( 3452): handleMessage GeckoView:PageStart uri=about:blank
[task 2024-07-09T16:16:30.626Z] 16:16:30 INFO - 07-09 16:16:28.447 E/GeckoSessionTestRule( 3452): method: public abstract void org.mozilla.geckoview.GeckoSession$SelectionActionDelegate.onDismissClipboardPermissionRequest(org.mozilla.geckoview.GeckoSession)
[task 2024-07-09T16:16:30.626Z] 16:16:30 INFO - 07-09 16:16:28.447 E/GeckoSessionTestRule( 3452): method: public abstract void org.mozilla.geckoview.GeckoSession$ProgressDelegate.onPageStart(org.mozilla.geckoview.GeckoSession,java.lang.String)
[task 2024-07-09T16:16:30.627Z] 16:16:30 INFO - 07-09 16:16:28.447 D/GeckoViewModule( 3452): registerListener ["GeckoView:WebExtension:SetTabActive","GeckoView:FlushSessionState"]
[task 2024-07-09T16:16:30.627Z] 16:16:30 INFO - 07-09 16:16:28.447 D/GeckoSession( 3452): handleMessage GeckoView:LocationChange uri=about:blank
[task 2024-07-09T16:16:30.627Z] 16:16:30 INFO - 07-09 16:16:28.447 E/GeckoSessionTestRule( 3452): method: public abstract void org.mozilla.geckoview.GeckoSession$NavigationDelegate.onLocationChange(org.mozilla.geckoview.GeckoSession,java.lang.String,java.util.List,java.lang.Boolean)
[task 2024-07-09T16:16:30.627Z] 16:16:30 INFO - 07-09 16:16:28.447 E/GeckoSessionTestRule( 3452): method: public abstract void org.mozilla.geckoview.GeckoSession$NavigationDelegate.onCanGoBack(org.mozilla.geckoview.GeckoSession,boolean)
[task 2024-07-09T16:16:30.627Z] 16:16:30 INFO - 07-09 16:16:28.447 E/GeckoSessionTestRule( 3452): method: public abstract void org.mozilla.geckoview.GeckoSession$NavigationDelegate.onCanGoForward(org.mozilla.geckoview.GeckoSession,boolean)
[task 2024-07-09T16:16:30.627Z] 16:16:30 INFO - 07-09 16:16:28.447 D/GeckoSession( 3452): handleMessage GeckoView:PageStop uri=null
[task 2024-07-09T16:16:30.627Z] 16:16:30 INFO - 07-09 16:16:28.447 E/GeckoSessionTestRule( 3452): method: public abstract void org.mozilla.geckoview.GeckoSession$ProgressDelegate.onPageStop(org.mozilla.geckoview.GeckoSession,boolean)
[task 2024-07-09T16:16:30.628Z] 16:16:30 INFO - 07-09 16:16:28.448 E/GeckoSessionTestRule( 3452): after prepareStatement
[task 2024-07-09T16:16:30.628Z] 16:16:30 INFO - 07-09 16:16:28.448 D/GeckoViewModule( 3452): registerListener ["ContentBlocking:RequestLog"]
[task 2024-07-09T16:16:30.628Z] 16:16:30 INFO - 07-09 16:16:28.449 D/GeckoViewMediaControl( 3452): onInitBrowser
[task 2024-07-09T16:16:30.628Z] 16:16:30 INFO - 07-09 16:16:28.450 D/GeckoViewMediaControl( 3452): onEnable
[task 2024-07-09T16:16:30.628Z] 16:16:30 INFO - 07-09 16:16:28.450 D/GeckoViewModule( 3452): 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 2024-07-09T16:16:30.628Z] 16:16:30 INFO - 07-09 16:16:28.451 D/GeckoViewTranslations( 3452): onInit
[task 2024-07-09T16:16:30.628Z] 16:16:30 INFO - 07-09 16:16:28.451 D/GeckoViewModule( 3452): registerListener ["GeckoView:Translations:Translate","GeckoView:Translations:RestorePage","GeckoView:Translations:GetNeverTranslateSite","GeckoView:Translations:SetNeverTranslateSite"]
[task 2024-07-09T16:16:30.628Z] 16:16:30 INFO - 07-09 16:16:28.451 D/GeckoViewSelectionActionDelegate[C]( 3487): handleEvent: visibilitychange
[task 2024-07-09T16:16:30.629Z] 16:16:30 INFO - 07-09 16:16:28.451 D/GeckoViewTranslations( 3452): onEnable
[task 2024-07-09T16:16:30.629Z] 16:16:30 INFO - 07-09 16:16:28.456 D/GeckoViewSettings[C]( 3487): receiveMessage: SettingsUpdate
[task 2024-07-09T16:16:30.629Z] 16:16:30 INFO - 07-09 16:16:28.456 I/GeckoSession( 3452): zerdatime 84611 - chrome startup finished
[task 2024-07-09T16:16:30.629Z] 16:16:30 INFO - 07-09 16:16:28.458 I/Gecko ( 3452): nsWindow[0x79094f743700]::Show 1
[task 2024-07-09T16:16:30.629Z] 16:16:30 INFO - 07-09 16:16:28.461 I/Gecko ( 3452): nsWindow[0x79094f743700]::Resize [0.000000 0.000000 480.000000 640.000000] (repaint 0)
[task 2024-07-09T16:16:30.629Z] 16:16:30 INFO - 07-09 16:16:28.464 W/GeckoEditableChild( 3487): No editable parent
[task 2024-07-09T16:16:30.629Z] 16:16:30 INFO - 07-09 16:16:28.471 D/GeckoViewXUL( 3452): onEvent GeckoView:UpdateModuleState {"enabled":true,"module":"GeckoViewExperiment"}
[task 2024-07-09T16:16:30.629Z] 16:16:30 INFO - 07-09 16:16:28.472 D/GeckoViewModule( 3452): dispatch GeckoView:LoadUri, data={"uri":"http://localhost:4245/assets/www/forms.html","flags":0,"headerFilter":1}
[task 2024-07-09T16:16:30.630Z] 16:16:30 INFO - 07-09 16:16:28.472 D/GeckoViewNavigation( 3452): onEvent: event=GeckoView:LoadUri, data={"uri":"http://localhost:4245/assets/www/forms.html","flags":0,"headerFilter":1}
[task 2024-07-09T16:16:30.630Z] 16:16:30 INFO - 07-09 16:16:28.478 D/GeckoViewXUL( 3452): receiveMessage GeckoView:ContentModuleLoaded {}
<...>
[task 2024-07-09T16:16:30.668Z] 16:16:30 INFO - 07-09 16:16:29.169 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusin
[task 2024-07-09T16:16:30.668Z] 16:16:30 INFO - 07-09 16:16:29.171 D/GeckoViewAutocomplete( 3452): delegateDismiss
[task 2024-07-09T16:16:30.668Z] 16:16:30 INFO - 07-09 16:16:29.172 D/GeckoViewAutoFill( 3452): receiveMessage Focus
[task 2024-07-09T16:16:30.668Z] 16:16:30 INFO - 07-09 16:16:29.173 D/AutofillSupport( 3452): handleMessage GeckoView:OnAutofillFocus
[task 2024-07-09T16:16:30.668Z] 16:16:30 INFO - 07-09 16:16:29.175 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusout
[task 2024-07-09T16:16:30.668Z] 16:16:30 INFO - 07-09 16:16:29.176 D/GeckoViewAutoFill[C]( 3487): Auto-fill focus on null
[task 2024-07-09T16:16:30.669Z] 16:16:30 INFO - 07-09 16:16:29.176 D/GeckoViewAutocomplete( 3452): fetchAddresses
[task 2024-07-09T16:16:30.669Z] 16:16:30 INFO - 07-09 16:16:29.178 I/Gecko ( 3487): [Child 3487, Main Thread] WARNING: EditorBase::GetInlineSpellChecker() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/EditorBase.cpp:2262
[task 2024-07-09T16:16:30.669Z] 16:16:30 INFO - 07-09 16:16:29.179 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusin
[task 2024-07-09T16:16:30.669Z] 16:16:30 INFO - 07-09 16:16:29.182 D/GeckoViewAutocomplete( 3452): delegateDismiss
[task 2024-07-09T16:16:30.669Z] 16:16:30 INFO - 07-09 16:16:29.183 D/GeckoViewAutoFill( 3452): receiveMessage Focus
[task 2024-07-09T16:16:30.669Z] 16:16:30 INFO - 07-09 16:16:29.183 D/AutofillSupport( 3452): handleMessage GeckoView:OnAutofillFocus
[task 2024-07-09T16:16:30.669Z] 16:16:30 INFO - 07-09 16:16:29.183 I/Gecko ( 3487): [Child 3487, Main Thread] WARNING: NS_ENSURE_TRUE(!mIMEMaskEventsCount) failed: file /builds/worker/checkouts/gecko/widget/android/GeckoEditableSupport.cpp:608
[task 2024-07-09T16:16:30.669Z] 16:16:30 INFO - 07-09 16:16:29.186 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusout
[task 2024-07-09T16:16:30.670Z] 16:16:30 INFO - 07-09 16:16:29.186 D/GeckoViewAutocomplete( 3452): fetchCreditCards
[task 2024-07-09T16:16:30.670Z] 16:16:30 INFO - 07-09 16:16:29.187 D/GeckoViewAutoFill[C]( 3487): Auto-fill focus on null
[task 2024-07-09T16:16:30.670Z] 16:16:30 INFO - 07-09 16:16:29.189 D/GeckoViewAutocomplete( 3452): fetchAddresses
[task 2024-07-09T16:16:30.670Z] 16:16:30 INFO - 07-09 16:16:29.190 I/Gecko ( 3487): [Child 3487, Main Thread] WARNING: EditorBase::GetInlineSpellChecker() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/EditorBase.cpp:2262
[task 2024-07-09T16:16:30.670Z] 16:16:30 INFO - 07-09 16:16:29.191 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusin
[task 2024-07-09T16:16:30.670Z] 16:16:30 INFO - 07-09 16:16:29.194 D/GeckoViewAutocomplete( 3452): delegateDismiss
[task 2024-07-09T16:16:30.670Z] 16:16:30 INFO - 07-09 16:16:29.197 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusout
[task 2024-07-09T16:16:30.670Z] 16:16:30 INFO - 07-09 16:16:29.197 D/GeckoViewAutoFill[C]( 3487): Auto-fill focus on null
[task 2024-07-09T16:16:30.670Z] 16:16:30 INFO - 07-09 16:16:29.198 D/GeckoViewAutoFill( 3452): receiveMessage Focus
[task 2024-07-09T16:16:30.671Z] 16:16:30 INFO - 07-09 16:16:29.199 D/AutofillSupport( 3452): handleMessage GeckoView:OnAutofillFocus
[task 2024-07-09T16:16:30.671Z] 16:16:30 INFO - 07-09 16:16:29.200 I/Gecko ( 3487): [Child 3487, Main Thread] WARNING: EditorBase::GetInlineSpellChecker() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/EditorBase.cpp:2262
[task 2024-07-09T16:16:30.671Z] 16:16:30 INFO - 07-09 16:16:29.201 D/GeckoViewAutocomplete( 3452): fetchCreditCards
[task 2024-07-09T16:16:30.671Z] 16:16:30 INFO - 07-09 16:16:29.203 D/GeckoViewAutocomplete( 3452): fetchAddresses
[task 2024-07-09T16:16:30.671Z] 16:16:30 INFO - 07-09 16:16:29.204 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusin
[task 2024-07-09T16:16:30.671Z] 16:16:30 INFO - 07-09 16:16:29.208 I/Gecko ( 3487): [Child 3487, Main Thread] WARNING: NS_ENSURE_TRUE(!mIMEMaskEventsCount) failed: file /builds/worker/checkouts/gecko/widget/android/GeckoEditableSupport.cpp:608
[task 2024-07-09T16:16:30.671Z] 16:16:30 INFO - 07-09 16:16:29.209 D/GeckoViewAutocomplete( 3452): delegateDismiss
[task 2024-07-09T16:16:30.671Z] 16:16:30 INFO - 07-09 16:16:29.210 D/GeckoViewAutoFill( 3452): receiveMessage Focus
[task 2024-07-09T16:16:30.672Z] 16:16:30 INFO - 07-09 16:16:29.210 D/AutofillSupport( 3452): handleMessage GeckoView:OnAutofillFocus
[task 2024-07-09T16:16:30.672Z] 16:16:30 INFO - 07-09 16:16:29.211 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusout
[task 2024-07-09T16:16:30.672Z] 16:16:30 INFO - 07-09 16:16:29.211 D/GeckoViewAutoFill[C]( 3487): Auto-fill focus on null
[task 2024-07-09T16:16:30.672Z] 16:16:30 INFO - 07-09 16:16:29.215 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusin
[task 2024-07-09T16:16:30.672Z] 16:16:30 INFO - 07-09 16:16:29.216 D/GeckoViewAutocomplete( 3452): fetchAddresses
[task 2024-07-09T16:16:30.672Z] 16:16:30 INFO - 07-09 16:16:29.220 D/GeckoViewAutocomplete( 3452): fetchCreditCards
[task 2024-07-09T16:16:30.672Z] 16:16:30 INFO - 07-09 16:16:29.222 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusout
[task 2024-07-09T16:16:30.672Z] 16:16:30 INFO - 07-09 16:16:29.222 D/GeckoViewAutoFill[C]( 3487): Auto-fill focus on null
[task 2024-07-09T16:16:30.673Z] 16:16:30 INFO - 07-09 16:16:29.224 I/Gecko ( 3487): [Child 3487, Main Thread] WARNING: EditorBase::GetInlineSpellChecker() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/EditorBase.cpp:2262
[task 2024-07-09T16:16:30.673Z] 16:16:30 INFO - 07-09 16:16:29.225 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusin
[task 2024-07-09T16:16:30.673Z] 16:16:30 INFO - 07-09 16:16:29.226 D/GeckoViewAutocomplete( 3452): delegateDismiss
[task 2024-07-09T16:16:30.673Z] 16:16:30 INFO - 07-09 16:16:29.227 D/GeckoViewAutoFill( 3452): receiveMessage Focus
[task 2024-07-09T16:16:30.673Z] 16:16:30 INFO - 07-09 16:16:29.228 D/AutofillSupport( 3452): handleMessage GeckoView:OnAutofillFocus
[task 2024-07-09T16:16:30.673Z] 16:16:30 INFO - 07-09 16:16:29.230 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusout
[task 2024-07-09T16:16:30.673Z] 16:16:30 INFO - 07-09 16:16:29.230 D/GeckoViewModule( 3452): dispatch GeckoView:ZoomToInput, data={"force":true}
[task 2024-07-09T16:16:30.673Z] 16:16:30 INFO - 07-09 16:16:29.230 D/GeckoViewAutoFill[C]( 3487): Auto-fill focus on null
[task 2024-07-09T16:16:30.673Z] 16:16:30 INFO - 07-09 16:16:29.230 D/GeckoViewContent( 3452): onEvent: event=GeckoView:ZoomToInput, data={"force":true}
[task 2024-07-09T16:16:30.674Z] 16:16:30 INFO - 07-09 16:16:29.232 D/GeckoViewAutocomplete( 3452): fetchCreditCards
[task 2024-07-09T16:16:30.674Z] 16:16:30 INFO - 07-09 16:16:29.232 I/Gecko ( 3487): [Child 3487, Main Thread] WARNING: EditorBase::GetInlineSpellChecker() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/EditorBase.cpp:2262
[task 2024-07-09T16:16:30.674Z] 16:16:30 INFO - 07-09 16:16:29.233 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusin
[task 2024-07-09T16:16:30.674Z] 16:16:30 INFO - 07-09 16:16:29.236 I/Gecko ( 3487): [Child 3487, Main Thread] WARNING: NS_ENSURE_TRUE(!mIMEMaskEventsCount) failed: file /builds/worker/checkouts/gecko/widget/android/GeckoEditableSupport.cpp:608
[task 2024-07-09T16:16:30.674Z] 16:16:30 INFO - 07-09 16:16:29.237 E/eglCodecCommon( 3525): glUtilsParamSize: unknow param 0x00008caa
[task 2024-07-09T16:16:30.674Z] 16:16:30 INFO - 07-09 16:16:29.240 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusout
[task 2024-07-09T16:16:30.675Z] 16:16:30 INFO - 07-09 16:16:29.240 D/GeckoViewAutoFill[C]( 3487): Auto-fill focus on null
[task 2024-07-09T16:16:30.675Z] 16:16:30 INFO - 07-09 16:16:29.241 D/GeckoViewAutocomplete( 3452): delegateDismiss
[task 2024-07-09T16:16:30.675Z] 16:16:30 INFO - 07-09 16:16:29.241 D/GeckoViewAutoFill( 3452): receiveMessage Focus
[task 2024-07-09T16:16:30.675Z] 16:16:30 INFO - 07-09 16:16:29.242 D/AutofillSupport( 3452): handleMessage GeckoView:OnAutofillFocus
[task 2024-07-09T16:16:30.675Z] 16:16:30 INFO - 07-09 16:16:29.243 I/Gecko ( 3487): [Child 3487, Main Thread] WARNING: EditorBase::GetInlineSpellChecker() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/EditorBase.cpp:2262
[task 2024-07-09T16:16:30.675Z] 16:16:30 INFO - 07-09 16:16:29.249 D/GeckoViewAutocomplete( 3452): delegateDismiss
[task 2024-07-09T16:16:30.675Z] 16:16:30 INFO - 07-09 16:16:29.249 D/GeckoViewAutoFill( 3452): receiveMessage Focus
[task 2024-07-09T16:16:30.675Z] 16:16:30 INFO - 07-09 16:16:29.250 D/AutofillSupport( 3452): handleMessage GeckoView:OnAutofillFocus
[task 2024-07-09T16:16:30.676Z] 16:16:30 INFO - 07-09 16:16:29.255 D/GeckoViewModule( 3452): dispatch GeckoView:ZoomToInput, data={"force":true}
[task 2024-07-09T16:16:30.676Z] 16:16:30 INFO - 07-09 16:16:29.255 D/GeckoViewContent( 3452): onEvent: event=GeckoView:ZoomToInput, data={"force":true}
[task 2024-07-09T16:16:30.676Z] 16:16:30 INFO - 07-09 16:16:29.258 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusin
[task 2024-07-09T16:16:30.676Z] 16:16:30 INFO - 07-09 16:16:29.258 D/GeckoViewAutocomplete( 3452): delegateDismiss
[task 2024-07-09T16:16:30.676Z] 16:16:30 INFO - 07-09 16:16:29.259 D/GeckoViewAutoFill( 3452): receiveMessage Focus
[task 2024-07-09T16:16:30.676Z] 16:16:30 INFO - 07-09 16:16:29.259 D/AutofillSupport( 3452): handleMessage GeckoView:OnAutofillFocus
[task 2024-07-09T16:16:30.676Z] 16:16:30 INFO - 07-09 16:16:29.263 D/GeckoViewAutocomplete( 3452): fetchAddresses
[task 2024-07-09T16:16:30.677Z] 16:16:30 INFO - 07-09 16:16:29.264 D/GeckoViewProgressDelegate[C]( 3487): handleEvent: MozAfterPaint
[task 2024-07-09T16:16:30.677Z] 16:16:30 INFO - 07-09 16:16:29.268 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusout
[task 2024-07-09T16:16:30.677Z] 16:16:30 INFO - 07-09 16:16:29.268 D/GeckoViewAutoFill[C]( 3487): Auto-fill focus on null
[task 2024-07-09T16:16:30.677Z] 16:16:30 INFO - 07-09 16:16:29.270 D/GeckoViewAutocomplete( 3452): fetchCreditCards
[task 2024-07-09T16:16:30.677Z] 16:16:30 INFO - 07-09 16:16:29.271 D/GeckoViewProgress( 3452): receiveMessage: MozAfterPaint
[task 2024-07-09T16:16:30.677Z] 16:16:30 INFO - 07-09 16:16:29.273 D/GeckoViewAutocomplete( 3452): delegateDismiss
[task 2024-07-09T16:16:30.677Z] 16:16:30 INFO - 07-09 16:16:29.273 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusin
[task 2024-07-09T16:16:30.677Z] 16:16:30 INFO - 07-09 16:16:29.274 D/GeckoViewAutoFill( 3452): receiveMessage Focus
[task 2024-07-09T16:16:30.678Z] 16:16:30 INFO - 07-09 16:16:29.274 D/AutofillSupport( 3452): handleMessage GeckoView:OnAutofillFocus
[task 2024-07-09T16:16:30.678Z] 16:16:30 INFO - 07-09 16:16:29.281 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusout
[task 2024-07-09T16:16:30.678Z] 16:16:30 INFO - 07-09 16:16:29.281 D/GeckoViewAutoFill[C]( 3487): Auto-fill focus on null
[task 2024-07-09T16:16:30.678Z] 16:16:30 INFO - 07-09 16:16:29.283 D/GeckoViewAutocomplete( 3452): delegateDismiss
[task 2024-07-09T16:16:30.678Z] 16:16:30 INFO - 07-09 16:16:29.284 D/GeckoViewAutoFill( 3452): receiveMessage Focus
[task 2024-07-09T16:16:30.678Z] 16:16:30 INFO - 07-09 16:16:29.284 I/Gecko ( 3487): [Child 3487, Main Thread] WARNING: EditorBase::GetInlineSpellChecker() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/EditorBase.cpp:2262
[task 2024-07-09T16:16:30.678Z] 16:16:30 INFO - 07-09 16:16:29.285 D/AutofillSupport( 3452): handleMessage GeckoView:OnAutofillFocus
[task 2024-07-09T16:16:30.679Z] 16:16:30 INFO - 07-09 16:16:29.286 D/GeckoViewAutoFill[C]( 3487): handleEvent: focusin
[task 2024-07-09T16:16:30.679Z] 16:16:30 INFO - 07-09 16:16:29.287 F/MOZ_Assert( 3487): [3487] Assertion failure: !aContentToInsert.IsText(), at /builds/worker/checkouts/gecko/editor/libeditor/EditorBase.cpp:2349
[task 2024-07-09T16:16:30.679Z] 16:16:30 INFO - 07-09 16:16:29.287 F/MOZ_Assert( 3487): #01: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x87f78a9]
[task 2024-07-09T16:16:30.679Z] 16:16:30 INFO - 07-09 16:16:29.287 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.679Z] 16:16:30 INFO - 07-09 16:16:29.287 D/GeckoViewAutocomplete( 3452): fetchAddresses
[task 2024-07-09T16:16:30.679Z] 16:16:30 INFO - 07-09 16:16:29.287 F/MOZ_Assert( 3487): #02: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x87fb924]
[task 2024-07-09T16:16:30.679Z] 16:16:30 INFO - 07-09 16:16:29.287 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.679Z] 16:16:30 INFO - 07-09 16:16:29.288 F/MOZ_Assert( 3487): #03: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x894c486]
[task 2024-07-09T16:16:30.680Z] 16:16:30 INFO - 07-09 16:16:29.288 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.680Z] 16:16:30 INFO - 07-09 16:16:29.288 F/MOZ_Assert( 3487): #04: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x87f5b7c]
[task 2024-07-09T16:16:30.680Z] 16:16:30 INFO - 07-09 16:16:29.288 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.680Z] 16:16:30 INFO - 07-09 16:16:29.288 F/MOZ_Assert( 3487): #05: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x8808e08]
[task 2024-07-09T16:16:30.680Z] 16:16:30 INFO - 07-09 16:16:29.288 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.680Z] 16:16:30 INFO - 07-09 16:16:29.288 F/MOZ_Assert( 3487): #06: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x908b217]
[task 2024-07-09T16:16:30.680Z] 16:16:30 INFO - 07-09 16:16:29.288 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.681Z] 16:16:30 INFO - 07-09 16:16:29.288 F/MOZ_Assert( 3487): #07: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x90ae7c1]
[task 2024-07-09T16:16:30.681Z] 16:16:30 INFO - 07-09 16:16:29.288 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.681Z] 16:16:30 INFO - 07-09 16:16:29.288 F/MOZ_Assert( 3487): #08: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x90c5558]
[task 2024-07-09T16:16:30.681Z] 16:16:30 INFO - 07-09 16:16:29.288 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.681Z] 16:16:30 INFO - 07-09 16:16:29.288 F/MOZ_Assert( 3487): #09: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x80d3420]
[task 2024-07-09T16:16:30.681Z] 16:16:30 INFO - 07-09 16:16:29.288 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.681Z] 16:16:30 INFO - 07-09 16:16:29.289 F/MOZ_Assert( 3487): #10: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x486de1f]
[task 2024-07-09T16:16:30.681Z] 16:16:30 INFO - 07-09 16:16:29.289 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.682Z] 16:16:30 INFO - 07-09 16:16:29.289 F/MOZ_Assert( 3487): #11: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x486ba60]
[task 2024-07-09T16:16:30.682Z] 16:16:30 INFO - 07-09 16:16:29.289 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.682Z] 16:16:30 INFO - 07-09 16:16:29.289 F/MOZ_Assert( 3487): #12: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x486c2fe]
[task 2024-07-09T16:16:30.682Z] 16:16:30 INFO - 07-09 16:16:29.289 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.682Z] 16:16:30 INFO - 07-09 16:16:29.289 F/MOZ_Assert( 3487): #13: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x486ced0]
[task 2024-07-09T16:16:30.682Z] 16:16:30 INFO - 07-09 16:16:29.289 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.682Z] 16:16:30 INFO - 07-09 16:16:29.289 F/MOZ_Assert( 3487): #14: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x3e96e58]
[task 2024-07-09T16:16:30.682Z] 16:16:30 INFO - 07-09 16:16:29.289 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.683Z] 16:16:30 INFO - 07-09 16:16:29.289 F/MOZ_Assert( 3487): #15: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x3e8b708]
[task 2024-07-09T16:16:30.683Z] 16:16:30 INFO - 07-09 16:16:29.289 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.683Z] 16:16:30 INFO - 07-09 16:16:29.289 F/MOZ_Assert( 3487): #16: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x3e8a1c8]
[task 2024-07-09T16:16:30.683Z] 16:16:30 INFO - 07-09 16:16:29.289 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.683Z] 16:16:30 INFO - 07-09 16:16:29.290 F/MOZ_Assert( 3487): #17: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x3e8a666]
[task 2024-07-09T16:16:30.683Z] 16:16:30 INFO - 07-09 16:16:29.290 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.683Z] 16:16:30 INFO - 07-09 16:16:29.290 F/MOZ_Assert( 3487): #18: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x3e9b137]
[task 2024-07-09T16:16:30.683Z] 16:16:30 INFO - 07-09 16:16:29.290 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.684Z] 16:16:30 INFO - 07-09 16:16:29.290 D/GeckoViewAutocomplete( 3452): fetchCreditCards
[task 2024-07-09T16:16:30.684Z] 16:16:30 INFO - 07-09 16:16:29.290 F/MOZ_Assert( 3487): #19: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x3eaf31e]
[task 2024-07-09T16:16:30.684Z] 16:16:30 INFO - 07-09 16:16:29.290 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.684Z] 16:16:30 INFO - 07-09 16:16:29.290 F/MOZ_Assert( 3487): #20: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x3eb6060]
[task 2024-07-09T16:16:30.684Z] 16:16:30 INFO - 07-09 16:16:29.290 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.684Z] 16:16:30 INFO - 07-09 16:16:29.290 F/MOZ_Assert( 3487): #21: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x4872067]
[task 2024-07-09T16:16:30.684Z] 16:16:30 INFO - 07-09 16:16:29.290 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.684Z] 16:16:30 INFO - 07-09 16:16:29.290 F/MOZ_Assert( 3487): #22: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x47f32b2]
[task 2024-07-09T16:16:30.684Z] 16:16:30 INFO - 07-09 16:16:29.290 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.685Z] 16:16:30 INFO - 07-09 16:16:29.290 F/MOZ_Assert( 3487): #23: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x8702b89]
[task 2024-07-09T16:16:30.685Z] 16:16:30 INFO - 07-09 16:16:29.290 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.685Z] 16:16:30 INFO - 07-09 16:16:29.291 F/MOZ_Assert( 3487): #24: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x95b2cfc]
[task 2024-07-09T16:16:30.685Z] 16:16:30 INFO - 07-09 16:16:29.291 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.685Z] 16:16:30 INFO - 07-09 16:16:29.291 F/MOZ_Assert( 3487): #25: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x487294d]
[task 2024-07-09T16:16:30.685Z] 16:16:30 INFO - 07-09 16:16:29.291 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.685Z] 16:16:30 INFO - 07-09 16:16:29.291 F/MOZ_Assert( 3487): #26: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x47f32b2]
[task 2024-07-09T16:16:30.685Z] 16:16:30 INFO - 07-09 16:16:29.291 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.686Z] 16:16:30 INFO - 07-09 16:16:29.291 F/MOZ_Assert( 3487): #27: ???[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so +0x95b25a4]
[task 2024-07-09T16:16:30.686Z] 16:16:30 INFO - 07-09 16:16:29.291 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.686Z] 16:16:30 INFO - 07-09 16:16:29.291 F/MOZ_Assert( 3487): #28: Java_org_mozilla_gecko_mozglue_GeckoLoader_nativeRun[/data/app/org.mozilla.geckoview.test-1/lib/x86_64/libmozglue.so +0xc40a3]
[task 2024-07-09T16:16:30.686Z] 16:16:30 INFO - 07-09 16:16:29.291 F/MOZ_Assert( 3487):
[task 2024-07-09T16:16:30.686Z] 16:16:30 INFO - 07-09 16:16:29.293 W/minidump_writer::linux::ptrace_dumper( 3452): failed to stop process 3487: Failed to stop the process
[task 2024-07-09T16:16:30.686Z] 16:16:30 INFO - 07-09 16:16:29.308 I/Gecko ( 3452): nsWindow 0x79094fa06a00 destructor
[task 2024-07-09T16:16:30.686Z] 16:16:30 INFO - 07-09 16:16:29.282 I/Gecko ( 3452): type=1400 audit(0.0:18): avc: denied { signal } for scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:r:isolated_app:s0:c512,c768 tclass=process permissive=1
[task 2024-07-09T16:16:30.687Z] 16:16:30 INFO - 07-09 16:16:29.319 E/TaskPersister( 1659): File error accessing recents directory (directory doesn't exist?).
[task 2024-07-09T16:16:30.687Z] 16:16:30 INFO - 07-09 16:16:29.323 I/Gecko ( 3452): [Parent 3452, IPC I/O Parent] WARNING: [1.1]: Dropping message '<null>'; no connection to unknown peer D3B602EBB550DF94.4C4AA51CF972EB37: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:365
[task 2024-07-09T16:16:30.687Z] 16:16:30 INFO - 07-09 16:16:29.323 I/Gecko ( 3452): [Parent 3452, IPC I/O Parent] WARNING: [1.1]: Rejecting introduction request from '18742104CAC967F7.82606CDF8C2B4E09' for unknown peer 'D3B602EBB550DF94.4C4AA51CF972EB37': file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:700
[task 2024-07-09T16:16:30.687Z] 16:16:30 INFO - 07-09 16:16:29.323 I/Gecko ( 3525): [GPU 3525, IPC I/O Child] WARNING: [18742104CAC967F7.82606CDF8C2B4E09]: Could not be introduced to peer D3B602EBB550DF94.4C4AA51CF972EB37: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:629
[task 2024-07-09T16:16:30.687Z] 16:16:30 INFO - 07-09 16:16:29.324 I/ActivityManager( 1659): Process org.mozilla.geckoview.test:tab11 (pid 3487) has died
[task 2024-07-09T16:16:30.688Z] 16:16:30 INFO - 07-09 16:16:29.324 D/ActivityManager( 1659): cleanUpApplicationRecord -- 3487
[task 2024-07-09T16:16:30.688Z] 16:16:30 INFO - 07-09 16:16:29.325 W/ActivityManager( 1659): Scheduling restart of crashed service org.mozilla.geckoview.test/org.mozilla.gecko.process.GeckoChildProcessServices$tab11 in 1000ms
[task 2024-07-09T16:16:30.688Z] 16:16:30 INFO - 07-09 16:16:29.326 E/KernelCpuSpeedReader( 1659): Failed to read cpu-freq: /sys/devices/system/cpu/cpu0/cpufreq/stats/time_in_state (No such file or directory)
[task 2024-07-09T16:16:30.688Z] 16:16:30 INFO - 07-09 16:16:29.326 E/KernelUidCpuTimeReader( 1659): Failed to read uid_cputime: /proc/uid_cputime/show_uid_stat (No such file or directory)
[task 2024-07-09T16:16:30.688Z] 16:16:30 INFO - 07-09 16:16:29.327 E/KernelUidCpuTimeReader( 1659): failed to remove uid from uid_cputime module
[task 2024-07-09T16:16:30.688Z] 16:16:30 INFO - 07-09 16:16:29.327 E/KernelUidCpuTimeReader( 1659): java.io.FileNotFoundException: /proc/uid_cputime/remove_uid_range (No such file or directory)
[task 2024-07-09T16:16:30.689Z] 16:16:30 INFO - 07-09 16:16:29.327 E/KernelUidCpuTimeReader( 1659): at java.io.FileOutputStream.open(Native Method)
[task 2024-07-09T16:16:30.689Z] 16:16:30 INFO - 07-09 16:16:29.327 E/KernelUidCpuTimeReader( 1659): at java.io.FileOutputStream.<init>(FileOutputStream.java:221)
[task 2024-07-09T16:16:30.689Z] 16:16:30 INFO - 07-09 16:16:29.327 E/KernelUidCpuTimeReader( 1659): at java.io.FileOutputStream.<init>(FileOutputStream.java:108)
[task 2024-07-09T16:16:30.689Z] 16:16:30 INFO - 07-09 16:16:29.327 E/KernelUidCpuTimeReader( 1659): at java.io.FileWriter.<init>(FileWriter.java:63)
[task 2024-07-09T16:16:30.689Z] 16:16:30 INFO - 07-09 16:16:29.327 E/KernelUidCpuTimeReader( 1659): at com.android.internal.os.KernelUidCpuTimeReader.removeUid(KernelUidCpuTimeReader.java:158)
[task 2024-07-09T16:16:30.689Z] 16:16:30 INFO - 07-09 16:16:29.327 E/KernelUidCpuTimeReader( 1659): at com.android.internal.os.BatteryStatsImpl.removeIsolatedUidLocked(BatteryStatsImpl.java:2943)
[task 2024-07-09T16:16:30.690Z] 16:16:30 INFO - 07-09 16:16:29.327 E/KernelUidCpuTimeReader( 1659): at com.android.server.am.BatteryStatsService$BatteryStatsHandler.handleMessage(BatteryStatsService.java:141)
[task 2024-07-09T16:16:30.690Z] 16:16:30 INFO - 07-09 16:16:29.327 E/KernelUidCpuTimeReader( 1659): at android.os.Handler.dispatchMessage(Handler.java:102)
[task 2024-07-09T16:16:30.690Z] 16:16:30 INFO - 07-09 16:16:29.327 E/KernelUidCpuTimeReader( 1659): at android.os.Looper.loop(Looper.java:154)
[task 2024-07-09T16:16:30.690Z] 16:16:30 INFO - 07-09 16:16:29.327 E/KernelUidCpuTimeReader( 1659): at android.os.HandlerThread.run(HandlerThread.java:61)
[task 2024-07-09T16:16:30.690Z] 16:16:30 INFO - 07-09 16:16:29.327 E/KernelUidCpuTimeReader( 1659): at com.android.server.ServiceThread.run(ServiceThread.java:46)
[task 2024-07-09T16:16:30.690Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): Error
[task 2024-07-09T16:16:30.690Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): org.mozilla.geckoview.test.rule.GeckoSessionTestRule$RejectedPromiseException: org.mozilla.geckoview.test.rule.GeckoSessionTestRule$MessageDelegate$PortDisconnectException: The port disconnected before a message could be received.Usually this happens when the page navigates away while waiting for a message.
[task 2024-07-09T16:16:30.691Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForMessage(GeckoSessionTestRule.java:2543)
[task 2024-07-09T16:16:30.691Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.evaluateJS(GeckoSessionTestRule.java:2471)
[task 2024-07-09T16:16:30.691Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$ExtensionPromise.getValue(GeckoSessionTestRule.java:2438)
[task 2024-07-09T16:16:30.691Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at org.mozilla.geckoview.test.AccessibilityTest.autoFill(AccessibilityTest.kt:1400)
[task 2024-07-09T16:16:30.691Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at java.lang.reflect.Method.invoke(Native Method)
[task 2024-07-09T16:16:30.691Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:59)
[task 2024-07-09T16:16:30.691Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
[task 2024-07-09T16:16:30.692Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:56)
[task 2024-07-09T16:16:30.692Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
[task 2024-07-09T16:16:30.692Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at androidx.test.internal.runner.junit4.statement.RunBefores.evaluate(RunBefores.java:80)
[task 2024-07-09T16:16:30.692Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at androidx.test.internal.runner.junit4.statement.RunAfters.evaluate(RunAfters.java:61)
[task 2024-07-09T16:16:30.692Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.lambda$evaluate$0(GeckoSessionTestRule.java:1502)
[task 2024-07-09T16:16:30.692Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.$r8$lambda$eGWMAiU-In-hdc_ISYHPMUhHPKA(GeckoSessionTestRule.java)
[task 2024-07-09T16:16:30.692Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2$$ExternalSyntheticLambda1.run(D8$$SyntheticClass)
[task 2024-07-09T16:16:30.692Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:428)
[task 2024-07-09T16:16:30.693Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at java.util.concurrent.FutureTask.run(FutureTask.java:237)
[task 2024-07-09T16:16:30.693Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1950)
[task 2024-07-09T16:16:30.693Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at android.os.Handler.handleCallback(Handler.java:751)
[task 2024-07-09T16:16:30.693Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2024-07-09T16:16:30.693Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at android.os.Looper.loop(Looper.java:154)
[task 2024-07-09T16:16:30.693Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at android.app.ActivityThread.main(ActivityThread.java:6077)
[task 2024-07-09T16:16:30.693Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at java.lang.reflect.Method.invoke(Native Method)
[task 2024-07-09T16:16:30.694Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:866)
[task 2024-07-09T16:16:30.694Z] 16:16:30 INFO - 07-09 16:16:29.328 E/GeckoSessionTestRule( 3452): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:756)
[task 2024-07-09T16:16:30.694Z] 16:16:30 INFO - 07-09 16:16:29.329 I/Gecko ( 3452): [Parent 3452, Main Thread] WARNING: IPC message 'PBrowser::Msg_StopIMEStateManagement' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:551
[task 2024-07-09T16:16:30.694Z] 16:16:30 INFO - 07-09 16:16:29.329 I/Gecko ( 3452): [Parent 3452, Main Thread] WARNING: IPC message 'PBrowser::Msg_Destroy' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:551
[task 2024-07-09T16:16:30.694Z] 16:16:30 INFO - 07-09 16:16:29.330 D/GeckoViewProgress( 3452): observe: topic=oop-frameloader-crashed
[task 2024-07-09T16:16:30.694Z] 16:16:30 INFO - 07-09 16:16:29.331 D/GeckoViewProgress( 3452): ProgressTracker stop
[task 2024-07-09T16:16:30.694Z] 16:16:30 INFO - 07-09 16:16:29.331 D/GeckoViewContent( 3452): observe: oop-frameloader-crashed
[task 2024-07-09T16:16:30.694Z] 16:16:30 INFO - 07-09 16:16:29.332 I/Gecko ( 3452): [Parent 3452, Main Thread] WARNING: No build ID mismatch: file /builds/worker/checkouts/gecko/dom/base/nsFrameLoader.cpp:3743
[task 2024-07-09T16:16:30.695Z] 16:16:30 INFO - 07-09 16:16:29.332 D/EGL_emulation( 3525): eglMakeCurrent: 0x79097f859280: ver 3 0 (tinfo 0x79097f80c460)
[task 2024-07-09T16:16:30.695Z] 16:16:30 INFO - 07-09 16:16:29.337 I/Gecko ( 3452): [Parent 3452, Main Thread] WARNING: IPC message 'PContent::Msg_ShutdownA11y' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:551
[task 2024-07-09T16:16:30.695Z] 16:16:30 INFO - 07-09 16:16:29.340 D/GeckoViewContent( 3452): observe: ipc:content-shutdown
[task 2024-07-09T16:16:30.695Z] 16:16:30 INFO - 07-09 16:16:29.344 D/GeckoViewChildCrashHandler( 3452): Notifying child process crash, dump ID 0d5d2f57-0a08-8b07-7fbb-500b3459317c
[task 2024-07-09T16:16:30.695Z] 16:16:30 INFO - 07-09 16:16:29.344 I/Gecko ( 3452): [Parent 3452, Main Thread] WARNING: IPC message 'PContent::Msg_DiscardBrowsingContext' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:551
[task 2024-07-09T16:16:30.695Z] 16:16:30 INFO - 07-09 16:16:29.344 D/GeckoViewSessionStore( 3452): observe browsing-context-discarded
[task 2024-07-09T16:16:30.695Z] 16:16:30 INFO - 07-09 16:16:29.345 I/Gecko ( 3452): [Parent 3452, Main Thread] WARNING: IPC message 'PContent::Msg_DiscardBrowsingContext' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:551
[task 2024-07-09T16:16:30.696Z] 16:16:30 INFO - 07-09 16:16:29.345 D/GeckoViewSessionStore( 3452): observe browsing-context-discarded
[task 2024-07-09T16:16:30.696Z] 16:16:30 INFO - 07-09 16:16:29.347 D/GeckoViewContent( 3452): handleEvent: DOMWindowClose
[task 2024-07-09T16:16:30.696Z] 16:16:30 INFO - 07-09 16:16:29.347 D/GeckoViewConsole( 3452): onEvent GeckoView:WebExtension:List null
[task 2024-07-09T16:16:30.696Z] 16:16:30 INFO - 07-09 16:16:29.352 I/art ( 3843): Late-enabling -Xcheck:jni
[task 2024-07-09T16:16:30.696Z] 16:16:30 INFO - 07-09 16:16:29.352 W/art ( 3843): Unexpected CPU variant for X86 using defaults: x86_64
[task 2024-07-09T16:16:30.696Z] 16:16:30 INFO - 07-09 16:16:29.352 I/Gecko ( 3452): [Parent 3452, IPC I/O Parent] WARNING: waitid failed pid:3487 errno:10: file /builds/worker/checkouts/gecko/ipc/chromium/src/base/process_util_posix.cc:314
[task 2024-07-09T16:16:30.696Z] 16:16:30 INFO - 07-09 16:16:29.354 I/Gecko ( 3452): nsWindow[0x79094f743700]::Show 0
[task 2024-07-09T16:16:30.696Z] 16:16:30 INFO - 07-09 16:16:29.356 I/Zygote ( 1342): Process 3487 exited due to signal (11)
[task 2024-07-09T16:16:30.697Z] 16:16:30 INFO - 07-09 16:16:29.356 E/GeckoConsole( 3452): [JavaScript Error: "TypeError: can't access property "sendAsyncMessage", this._manager.messageManager is null" {file: "chrome://geckoview/content/geckoview.js" line: 511}]
[task 2024-07-09T16:16:30.697Z] 16:16:30 INFO - 07-09 16:16:29.356 E/GeckoConsole( 3452): _updateContentModuleState@chrome://geckoview/content/geckoview.js:511:5
[task 2024-07-09T16:16:30.697Z] 16:16:30 INFO - 07-09 16:16:29.356 E/GeckoConsole( 3452): set enabled@chrome://geckoview/content/geckoview.js:486:10
[task 2024-07-09T16:16:30.697Z] 16:16:30 INFO - 07-09 16:16:29.356 E/GeckoConsole( 3452): init/</<@chrome://geckoview/content/geckoview.js:110:9
[task 2024-07-09T16:16:30.697Z] 16:16:30 INFO - 07-09 16:16:29.356 E/GeckoConsole( 3452): forEach@chrome://geckoview/content/geckoview.js:161:19
[task 2024-07-09T16:16:30.697Z] 16:16:30 INFO - 07-09 16:16:29.356 E/GeckoConsole( 3452): init/<@chrome://geckoview/content/geckoview.js:109:12
[task 2024-07-09T16:16:30.697Z] 16:16:30 INFO - 07-09 16:16:29.357 I/ActivityManager( 1659): Start proc 3843:org.mozilla.geckoview.test:crash/u0a62 for service org.mozilla.geckoview.test/.TestCrashHandler
[task 2024-07-09T16:16:30.698Z] 16:16:30 INFO - 07-09 16:16:29.357 D/GeckoViewSessionStore( 3452): observe browsing-context-discarded
[task 2024-07-09T16:16:30.698Z] 16:16:30 INFO - 07-09 16:16:29.358 D/GeckoViewSessionStore( 3452): observe browsing-context-discarded
[task 2024-07-09T16:16:30.698Z] 16:16:30 INFO - 07-09 16:16:29.358 E/GeckoSessionTestRule( 3452): test_end c5ee677f-bc83-49bd-9e28-2d35f3d0f059 autoFill(org.mozilla.geckoview.test.AccessibilityTest)
[task 2024-07-09T16:16:30.698Z] 16:16:30 WARNING - TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.AccessibilityTest#autoFill | org.mozilla.geckoview.test.rule.GeckoSessionTestRule$RejectedPromiseException: org.mozilla.geckoview.test.rule.GeckoSessionTestRule$MessageDelegate$PortDisconnectException: The port disconnected before a message could be received.Usually this happens when the page navigates away while waiting for a message.
[task 2024-07-09T16:16:30.698Z] 16:16:30 INFO - TEST-INFO took 1878ms
[task 2024-07-09T16:16:30.698Z] 16:16:30 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=1146
[task 2024-07-09T16:16:30.699Z] 16:16:30 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2024-07-09T16:16:30.699Z] 16:16:30 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2024-07-09T16:16:30.699Z] 16:16:30 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=testMoveByLine
[task 2024-07-09T16:16:30.699Z] 16:16:30 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.AccessibilityTest
[task 2024-07-09T16:16:30.699Z] 16:16:30 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=37
[task 2024-07-09T16:16:30.699Z] 16:16:30 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 1
[task 2024-07-09T16:16:30.699Z] 16:16:30 INFO - TEST-START | org.mozilla.geckoview.test.AccessibilityTest#testMoveByLine
Description
•