Closed
Bug 1895470
Opened 1 year ago
Closed 1 year ago
Intermittent org.mozilla.geckoview.test.GeolocationTest#highAccuracyTest | single tracking bug
Categories
(GeckoView :: General, defect, P5)
Tracking
(Not tracked)
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure, intermittent-testcase)
Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=457239660&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/HodQuOaBRy2r0rBmnoOCyQ/runs/0/artifacts/public/logs/live_backing.log
[task 2024-05-07T09:48:55.916Z] 09:48:55 INFO - TEST-START | org.mozilla.geckoview.test.GeolocationTest#highAccuracyTest
[task 2024-05-07T09:48:59.948Z] 09:48:59 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=1141
[task 2024-05-07T09:48:59.949Z] 09:48:59 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2024-05-07T09:48:59.949Z] 09:48:59 INFO - org.mozilla.geckoview.test | Error in highAccuracyTest(org.mozilla.geckoview.test.GeolocationTest):
[task 2024-05-07T09:48:59.949Z] 09:48:59 INFO - org.mozilla.geckoview.test | java.lang.AssertionError: High accuracy longitude is expected.
[task 2024-05-07T09:48:59.949Z] 09:48:59 INFO - org.mozilla.geckoview.test | Expected: <4.4444>
[task 2024-05-07T09:48:59.949Z] 09:48:59 INFO - org.mozilla.geckoview.test | but: was <2.2222>
[task 2024-05-07T09:48:59.949Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.hamcrest.MatcherAssert.assertThat(MatcherAssert.java:20)
[task 2024-05-07T09:48:59.949Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.junit.Assert.assertThat(Assert.java:964)
[task 2024-05-07T09:48:59.950Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.junit.rules.ErrorCollector$1.call(ErrorCollector.java:77)
[task 2024-05-07T09:48:59.950Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.junit.rules.ErrorCollector.checkSucceeds(ErrorCollector.java:90)
[task 2024-05-07T09:48:59.950Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.junit.rules.ErrorCollector.checkThat(ErrorCollector.java:75)
[task 2024-05-07T09:48:59.950Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.checkThat(GeckoSessionTestRule.java:929)
[task 2024-05-07T09:48:59.950Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.BaseSessionTest.assertThat(BaseSessionTest.kt:159)
[task 2024-05-07T09:48:59.950Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.GeolocationTest.highAccuracyTest(GeolocationTest.kt:208)
[task 2024-05-07T09:48:59.950Z] 09:48:59 INFO - org.mozilla.geckoview.test |
[task 2024-05-07T09:48:59.950Z] 09:48:59 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2024-05-07T09:48:59.950Z] 09:48:59 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=highAccuracyTest
[task 2024-05-07T09:48:59.950Z] 09:48:59 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.GeolocationTest
[task 2024-05-07T09:48:59.950Z] 09:48:59 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stack=java.lang.AssertionError: High accuracy longitude is expected.
[task 2024-05-07T09:48:59.951Z] 09:48:59 INFO - org.mozilla.geckoview.test | Expected: <4.4444>
[task 2024-05-07T09:48:59.951Z] 09:48:59 INFO - org.mozilla.geckoview.test | but: was <2.2222>
[task 2024-05-07T09:48:59.951Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.hamcrest.MatcherAssert.assertThat(MatcherAssert.java:20)
[task 2024-05-07T09:48:59.951Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.junit.Assert.assertThat(Assert.java:964)
[task 2024-05-07T09:48:59.951Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.junit.rules.ErrorCollector$1.call(ErrorCollector.java:77)
[task 2024-05-07T09:48:59.951Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.junit.rules.ErrorCollector.checkSucceeds(ErrorCollector.java:90)
[task 2024-05-07T09:48:59.951Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.junit.rules.ErrorCollector.checkThat(ErrorCollector.java:75)
[task 2024-05-07T09:48:59.951Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.checkThat(GeckoSessionTestRule.java:929)
[task 2024-05-07T09:48:59.951Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.BaseSessionTest.assertThat(BaseSessionTest.kt:159)
[task 2024-05-07T09:48:59.951Z] 09:48:59 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.GeolocationTest.highAccuracyTest(GeolocationTest.kt:208)
[task 2024-05-07T09:48:59.951Z] 09:48:59 INFO - org.mozilla.geckoview.test |
[task 2024-05-07T09:48:59.951Z] 09:48:59 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=381
[task 2024-05-07T09:48:59.951Z] 09:48:59 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: -2
[task 2024-05-07T09:48:59.951Z] 09:48:59 INFO - Printing logcat for test:
[task 2024-05-07T09:49:00.558Z] 09:49:00 INFO - 05-07 09:48:55.385 E/GeckoSessionTestRule( 3480): test_start 1f0befec-3ff2-40ff-89cf-b127eb38b1ec highAccuracyTest(org.mozilla.geckoview.test.GeolocationTest)
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:55.385 E/GeckoSessionTestRule( 3480): before prepareStatement highAccuracyTest(org.mozilla.geckoview.test.GeolocationTest)
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:55.475 I/WindowManager( 1657): 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-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:56.007 W/OpenGLRenderer( 2101): Incorrectly called buildLayer on View: ShortcutAndWidgetContainer, destroying layer...
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:56.021 I/WindowManager( 1657): Destroying surface Surface(name=com.android.launcher3/com.android.launcher3.Launcher) 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.AppWindowToken.notifyAppStopped:389 com.android.server.wm.WindowManagerService.notifyAppStopped:4456 com.android.server.am.ActivityStack.activityStoppedLocked:1252 com.android.server.am.ActivityManagerService.activityStopped:6903
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.811 D/GeckoViewStartup( 3480): onEvent GeckoView:StorageDelegate:Attached
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.812 I/Gecko ( 3480): nsWindow[0x7d73437fcf00]::Create 0x0 [0 0 1 1]
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.826 D/ServiceAllocator( 3480): org.mozilla.gecko.process.GeckoChildProcessServices$tab1 updateBindings: IDLE priority, 6 importance, 0 successful binds, 0 failed binds, 2 successful unbinds
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.849 D/GeckoViewNavigation( 3480): sessionContextId=null
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.856 D/GeckoViewSessionStore( 3480): observe browsing-context-did-set-embedder
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.857 D/GeckoViewSessionStore( 3480): observe browsing-context-did-set-embedder
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.865 E/eglCodecCommon( 3553): glUtilsParamSize: unknow param 0x00008caa
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.936 W/webrender::device::gl( 3553): Missing optimized shader source for gpu_cache_update
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.944 E/eglCodecCommon( 3553): glUtilsParamSize: unknow param 0x00008741
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.959 D/GeckoViewModule( 3480): 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-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.961 D/GeckoViewNavigation( 3480): onInit
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.961 D/ServiceAllocator( 3480): org.mozilla.gecko.process.GeckoChildProcessServices$tab1 updateBindings: FOREGROUND priority, 2 importance, 2 successful binds, 0 failed binds, 0 successful unbinds
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.961 D/GeckoViewModule( 3480): registerListener ["GeckoView:GoBack","GeckoView:GoForward","GeckoView:GotoHistoryIndex","GeckoView:LoadUri","GeckoView:Reload","GeckoView:Stop","GeckoView:PurgeHistory","GeckoView:DotPrintFinish"]
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.962 D/GeckoViewNavigation( 3480): onEnable
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.962 D/GeckoViewProcessHangMonitor( 3480): onInit
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.962 D/GeckoViewProcessHangMonitor( 3480): onEnable
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.963 D/GeckoViewModule( 3480): registerListener ["GeckoView:HangReportStop","GeckoView:HangReportWait"]
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.964 D/GeckoViewProgress( 3480): onEnable
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.965 D/GeckoSession( 3480): handleMessage GeckoView:PageStart uri=about:blank
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.965 E/GeckoSessionTestRule( 3480): method: public abstract void org.mozilla.geckoview.GeckoSession$SelectionActionDelegate.onDismissClipboardPermissionRequest(org.mozilla.geckoview.GeckoSession)
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.965 E/GeckoSessionTestRule( 3480): method: public abstract void org.mozilla.geckoview.GeckoSession$ProgressDelegate.onPageStart(org.mozilla.geckoview.GeckoSession,java.lang.String)
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.965 D/GeckoSession( 3480): handleMessage GeckoView:LocationChange uri=about:blank
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.965 E/GeckoSessionTestRule( 3480): 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-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.965 E/GeckoSessionTestRule( 3480): method: public abstract void org.mozilla.geckoview.GeckoSession$NavigationDelegate.onCanGoBack(org.mozilla.geckoview.GeckoSession,boolean)
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.966 E/GeckoSessionTestRule( 3480): method: public abstract void org.mozilla.geckoview.GeckoSession$NavigationDelegate.onCanGoForward(org.mozilla.geckoview.GeckoSession,boolean)
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.966 D/GeckoViewModule( 3480): registerListener GeckoView:FlushSessionState
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.966 D/GeckoSession( 3480): handleMessage GeckoView:PageStop uri=null
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.966 E/GeckoSessionTestRule( 3480): method: public abstract void org.mozilla.geckoview.GeckoSession$ProgressDelegate.onPageStop(org.mozilla.geckoview.GeckoSession,boolean)
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.966 E/GeckoSessionTestRule( 3480): after prepareStatement
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.968 D/GeckoViewSelectionAction( 3480): onEnable
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.968 D/GeckoViewModule( 3480): registerListener ["GeckoView:ExecuteSelectionAction"]
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.969 D/GeckoViewSettings( 3480): onInit
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.969 D/GeckoViewModule( 3480): registerListener ["GeckoView:GetUserAgent"]
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.969 D/GeckoViewSettings( 3480): 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-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.971 D/GeckoViewModule( 3480): registerListener ["GeckoView:WebExtension:SetTabActive"]
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.971 D/GeckoViewSelectionActionDelegate[C](16602): handleEvent: visibilitychange
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.972 D/GeckoViewModule( 3480): registerListener ["ContentBlocking:RequestLog"]
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.972 D/EGL_emulation( 3553): eglMakeCurrent: 0x7d737d83a500: ver 3 0 (tinfo 0x7d737d80c5a0)
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.973 D/GeckoViewMediaControl( 3480): onInitBrowser
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.974 D/GeckoViewMediaControl( 3480): onEnable
[task 2024-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.974 D/GeckoViewModule( 3480): 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-05-07T09:49:00.559Z] 09:49:00 INFO - 05-07 09:48:57.975 D/GeckoViewTranslations( 3480): onInit
[task 2024-05-07T09:49:00.560Z] 09:49:00 INFO - 05-07 09:48:57.975 D/GeckoViewModule( 3480): registerListener ["GeckoView:Translations:Translate","GeckoView:Translations:RestorePage","GeckoView:Translations:GetNeverTranslateSite","GeckoView:Translations:SetNeverTranslateSite"]
[task 2024-05-07T09:49:00.560Z] 09:49:00 INFO - 05-07 09:48:57.975 D/GeckoViewTranslations( 3480): onEnable
[task 2024-05-07T09:49:00.560Z] 09:49:00 INFO - 05-07 09:48:57.976 D/GeckoSession( 3480): handleMessage: GeckoView:DismissClipboardPermissionRequest
[task 2024-05-07T09:49:00.560Z] 09:49:00 INFO - 05-07 09:48:57.978 D/GeckoViewSettings[C](16602): receiveMessage: SettingsUpdate
[task 2024-05-07T09:49:00.560Z] 09:49:00 INFO - 05-07 09:48:57.983 I/GeckoSession( 3480): zerdatime 478149 - chrome startup finished
[task 2024-05-07T09:49:00.560Z] 09:49:00 INFO - 05-07 09:48:57.985 I/Gecko ( 3480): nsWindow[0x7d73437fcf00]::Show 1
[task 2024-05-07T09:49:00.560Z] 09:49:00 INFO - 05-07 09:48:57.992 W/GeckoEditableChild(16602): No editable parent
[task 2024-05-07T09:49:00.561Z] 09:49:00 INFO - 05-07 09:48:57.994 I/Gecko ( 3480): nsWindow[0x7d73437fcf00]::Resize [0.000000 144.000000 0.000000 0.000000] (repaint 0)
[task 2024-05-07T09:49:00.561Z] 09:49:00 INFO - 05-07 09:48:57.996 I/Gecko ( 3480): nsWindow[0x7d73437fcf00]::Resize [0.000000 144.000000 800.000000 1136.000000] (repaint 0)
[task 2024-05-07T09:49:00.561Z] 09:49:00 INFO - 05-07 09:48:57.996 I/Gecko ( 3480): nsWindow: 0x7d73437fcf00 OnSizeChanged [800 1136]
[task 2024-05-07T09:49:00.561Z] 09:49:00 INFO - 05-07 09:48:57.998 D/GeckoViewConsole( 3480): onEvent GeckoView:WebExtension:PortMessageFromApp {"message":{"id":"698ee623-3686-4a23-b8e1-fcce67359ae5","args":{"oldPrefs":{},"newPrefs":{"geo.provider.testing":false}},"type":"SetPrefs"}}
[task 2024-05-07T09:49:00.561Z] 09:49:00 INFO - 05-07 09:48:58.006 D/GeckoViewXUL( 3480): receiveMessage GeckoView:ContentModuleLoaded {}
[task 2024-05-07T09:49:00.561Z] 09:49:00 INFO - 05-07 09:48:58.008 D/GeckoViewXUL( 3480): onEvent GeckoView:UpdateModuleState {"enabled":true,"module":"GeckoViewExperiment"}
[task 2024-05-07T09:49:00.562Z] 09:49:00 INFO - 05-07 09:48:58.009 D/GeckoViewModule( 3480): dispatch GeckoView:SetActive, data={"active":true}
[task 2024-05-07T09:49:00.562Z] 09:49:00 INFO - 05-07 09:48:58.010 D/GeckoViewContent( 3480): onEvent: event=GeckoView:SetActive, data={"active":true}
[task 2024-05-07T09:49:00.562Z] 09:49:00 INFO - 05-07 09:48:58.011 D/GeckoViewModule( 3480): dispatch GeckoView:SetFocused, data={"focused":true}
[task 2024-05-07T09:49:00.562Z] 09:49:00 INFO - 05-07 09:48:58.011 D/GeckoViewContent( 3480): onEvent: event=GeckoView:SetFocused, data={"focused":true}
[task 2024-05-07T09:49:00.562Z] 09:49:00 INFO - 05-07 09:48:58.021 E/eglCodecCommon( 3553): glUtilsParamSize: unknow param 0x00008caa
[task 2024-05-07T09:49:00.562Z] 09:49:00 INFO - 05-07 09:48:58.036 D/GpsNetInitiatedHandler( 1657): location enabled :true
[task 2024-05-07T09:49:00.562Z] 09:49:00 INFO - 05-07 09:48:58.038 D/GeckoViewModule( 3480): dispatch GeckoView:LoadUri, data={"uri":"https://example.com/","flags":0,"headerFilter":1}
[task 2024-05-07T09:49:00.563Z] 09:49:00 INFO - 05-07 09:48:58.039 D/GeckoViewNavigation( 3480): onEvent: event=GeckoView:LoadUri, data={"uri":"https://example.com/","flags":0,"headerFilter":1}
[task 2024-05-07T09:49:00.563Z] 09:49:00 INFO - 05-07 09:48:58.051 D/GeckoViewProgress( 3480): ProgressTracker onStateChange: isTopLevel=true, flags=0xf0001, status=NS_OK
[task 2024-05-07T09:49:00.563Z] 09:49:00 INFO - 05-07 09:48:58.052 D/GeckoViewProgress( 3480): ProgressTracker onStateChange: uri=https://example.com/
[task 2024-05-07T09:49:00.563Z] 09:49:00 INFO - 05-07 09:48:58.052 D/GeckoViewProgress( 3480): ProgressTracker start https://example.com/
[task 2024-05-07T09:49:00.563Z] 09:49:00 INFO - 05-07 09:48:58.053 D/GeckoViewProgress( 3480): ProgressTracker updateProgress
[task 2024-05-07T09:49:00.564Z] 09:49:00 INFO - 05-07 09:48:58.053 D/GeckoViewProgress( 3480): ProgressTracker updateProgress data={"prev":0,"uri":"https://example.com/","locationChange":false,"pageStart":true,"pageStop":false,"firstPaint":false,"pageShow":false,"parsed":false} progress=15
[task 2024-05-07T09:49:00.564Z] 09:49:00 INFO - 05-07 09:48:58.054 D/GeckoSession( 3480): handleMessage GeckoView:ProgressChanged uri=null
[task 2024-05-07T09:49:00.564Z] 09:49:00 INFO - 05-07 09:48:58.054 D/GeckoViewProgress( 3480): StateTracker onStateChange: isTopLevel=true, flags=0xf0001, status=NS_OK loadType=1
[task 2024-05-07T09:49:00.564Z] 09:49:00 INFO - 05-07 09:48:58.055 D/GeckoSession( 3480): handleMessage GeckoView:PageStart uri=https://example.com/
[task 2024-05-07T09:49:00.564Z] 09:49:00 INFO - 05-07 09:48:58.071 W/webrender::device::gl( 3553): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-05-07T09:49:00.564Z] 09:49:00 INFO - 05-07 09:48:58.074 W/webrender::device::gl( 3553): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-05-07T09:49:00.564Z] 09:49:00 INFO - 05-07 09:48:58.084 W/webrender::device::gl( 3553): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-05-07T09:49:00.565Z] 09:49:00 INFO - 05-07 09:48:58.087 I/Gecko ( 3480): [Parent 3480, Main Thread] WARNING: NS_ENSURE_TRUE(mBounceTrackingRecord) failed: file /builds/worker/checkouts/gecko/toolkit/components/antitracking/bouncetrackingprotection/BounceTrackingState.cpp:585
[task 2024-05-07T09:49:00.565Z] 09:49:00 INFO - 05-07 09:48:58.087 I/Gecko ( 3480): [Parent 3480, Main Thread] WARNING: BounceTrackingState::OnDocumentStartRequest failed.: 'NS_SUCCEEDED(rv)', file /builds/worker/checkouts/gecko/netwerk/ipc/DocumentLoadListener.cpp:2581
[task 2024-05-07T09:49:00.565Z] 09:49:00 INFO - 05-07 09:48:58.103 I/art (16755): Late-enabling -Xcheck:jni
[task 2024-05-07T09:49:00.565Z] 09:49:00 INFO - 05-07 09:48:58.104 W/art (16755): Unexpected CPU variant for X86 using defaults: x86_64
[task 2024-05-07T09:49:00.565Z] 09:49:00 INFO - 05-07 09:48:58.106 I/ActivityManager( 1657): Start proc 16755:org.mozilla.geckoview.test:tab36/u0i306 for service org.mozilla.geckoview.test/org.mozilla.gecko.process.GeckoChildProcessServices$tab36
[task 2024-05-07T09:49:00.566Z] 09:49:00 INFO - 05-07 09:48:58.108 D/ServiceAllocator( 3480): org.mozilla.gecko.process.GeckoChildProcessServices$tab36 updateBindings: FOREGROUND priority, 0 importance, 3 successful binds, 0 failed binds, 0 successful unbinds
[task 2024-05-07T09:49:00.566Z] 09:49:00 INFO - 05-07 09:48:58.139 I/ServiceChildProcess(16755): onCreate
[task 2024-05-07T09:49:00.566Z] 09:49:00 INFO - 05-07 09:48:58.142 D/GeckoThread(16755): State changed to LAUNCHED
[task 2024-05-07T09:49:00.566Z] 09:49:00 INFO - 05-07 09:48:58.142 I/GeckoThread(16755): preparing to run Gecko
[task 2024-05-07T09:49:00.566Z] 09:49:00 INFO - 05-07 09:48:58.147 I/Gecko ( 3480): [Parent 3480, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040154 (NS_ERROR_FACTORY_NOT_REGISTERED): file /builds/worker/checkouts/gecko/extensions/spellcheck/src/mozSpellChecker.cpp:379
[task 2024-05-07T09:49:00.566Z] 09:49:00 INFO - 05-07 09:48:58.149 D/ServiceAllocator( 3480): org.mozilla.gecko.process.GeckoChildProcessServices$tab36 updateBindings: FOREGROUND priority, 2 importance, 0 successful binds, 0 failed binds, 0 successful unbinds
[task 2024-05-07T09:49:00.567Z] 09:49:00 INFO - 05-07 09:48:58.150 D/GeckoThread(16755): env var: MOZ_CRASHREPORTER=1
[task 2024-05-07T09:49:00.567Z] 09:49:00 INFO - 05-07 09:48:58.150 D/GeckoThread(16755): env var: MOZ_CRASHREPORTER_SHUTDOWN=1
[task 2024-05-07T09:49:00.567Z] 09:49:00 INFO - 05-07 09:48:58.150 D/GeckoThread(16755): env var: XPCOM_DEBUG_BREAK=stack
[task 2024-05-07T09:49:00.567Z] 09:49:00 INFO - 05-07 09:48:58.150 D/GeckoThread(16755): env var: MOZ_DISABLE_NONLOCAL_CONNECTIONS=1
[task 2024-05-07T09:49:00.567Z] 09:49:00 INFO - 05-07 09:48:58.150 D/GeckoThread(16755): env var: MOZ_IN_AUTOMATION=1
[task 2024-05-07T09:49:00.567Z] 09:49:00 INFO - 05-07 09:48:58.150 D/GeckoThread(16755): env var: R_LOG_VERBOSE=1
[task 2024-05-07T09:49:00.567Z] 09:49:00 INFO - 05-07 09:48:58.150 D/GeckoThread(16755): env var: R_LOG_LEVEL=6
[task 2024-05-07T09:49:00.567Z] 09:49:00 INFO - 05-07 09:48:58.150 D/GeckoThread(16755): env var: R_LOG_DESTINATION=stderr
[task 2024-05-07T09:49:00.568Z] 09:49:00 INFO - 05-07 09:48:58.151 D/GeckoThread(16755): env var: MOZ_WEBRENDER=1
[task 2024-05-07T09:49:00.568Z] 09:49:00 INFO - 05-07 09:48:58.151 D/GeckoThread(16755): env var: MOZ_FORCE_ENABLE_FISSION=1
[task 2024-05-07T09:49:00.568Z] 09:49:00 INFO - 05-07 09:48:58.151 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libmozglue.so: unused DT entry: type 0x8000024 arg 0x408d8
[task 2024-05-07T09:49:00.568Z] 09:49:00 INFO - 05-07 09:48:58.151 D/GeckoViewXUL( 3480): WillChangeBrowserRemoteness
[task 2024-05-07T09:49:00.568Z] 09:49:00 INFO - 05-07 09:48:58.151 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libmozglue.so: unused DT entry: type 0x8000023 arg 0x1d8
[task 2024-05-07T09:49:00.568Z] 09:49:00 INFO - 05-07 09:48:58.151 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libmozglue.so: unused DT entry: type 0x8000025 arg 0x8
[task 2024-05-07T09:49:00.568Z] 09:49:00 INFO - 05-07 09:48:58.152 D/GeckoViewMediaControl( 3480): onDestroyBrowser
[task 2024-05-07T09:49:00.568Z] 09:49:00 INFO - 05-07 09:48:58.154 D/GeckoThread(16755): State changed to MOZGLUE_READY
[task 2024-05-07T09:49:00.569Z] 09:49:00 INFO - 05-07 09:48:58.154 W/ContextImpl(16755): Failed to ensure /data/user/0/org.mozilla.geckoview.test/files: mkdir failed: EACCES (Permission denied)
[task 2024-05-07T09:49:00.569Z] 09:49:00 INFO - 05-07 09:48:58.154 W/ContextImpl(16755): Failed to ensure /data/user/0/org.mozilla.geckoview.test/cache: mkdir failed: EACCES (Permission denied)
[task 2024-05-07T09:49:00.569Z] 09:49:00 INFO - 05-07 09:48:58.155 I/GeckoLoader(16755): Library base=/data/app/org.mozilla.geckoview.test-1/lib/x86_64
[task 2024-05-07T09:49:00.569Z] 09:49:00 INFO - 05-07 09:48:58.155 I/GeckoLoader(16755): Library base=/data/app/org.mozilla.geckoview.test-1/lib/x86_64
[task 2024-05-07T09:49:00.569Z] 09:49:00 INFO - 05-07 09:48:58.155 D/GeckoViewSelectionActionDelegate[C](16602): handleEvent: visibilitychange
[task 2024-05-07T09:49:00.569Z] 09:49:00 INFO - 05-07 09:48:58.156 E/GeckoLibLoad(16755): Load sqlite start
[task 2024-05-07T09:49:00.569Z] 09:49:00 INFO - 05-07 09:48:58.156 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libnss3.so: unused DT entry: type 0x8000024 arg 0x16530
[task 2024-05-07T09:49:00.570Z] 09:49:00 INFO - 05-07 09:48:58.156 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libnss3.so: unused DT entry: type 0x8000023 arg 0x680
[task 2024-05-07T09:49:00.570Z] 09:49:00 INFO - 05-07 09:48:58.156 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libnss3.so: unused DT entry: type 0x8000025 arg 0x8
[task 2024-05-07T09:49:00.570Z] 09:49:00 INFO - 05-07 09:48:58.157 D/GeckoViewSessionStore( 3480): observe browsing-context-did-set-embedder
[task 2024-05-07T09:49:00.570Z] 09:49:00 INFO - 05-07 09:48:58.157 E/GeckoLibLoad(16755): Load sqlite done
[task 2024-05-07T09:49:00.570Z] 09:49:00 INFO - 05-07 09:48:58.157 D/GeckoViewAutoFill[C](16602): handleEvent: pagehide
[task 2024-05-07T09:49:00.570Z] 09:49:00 INFO - 05-07 09:48:58.157 I/GeckoLoader(16755): Library base=/data/app/org.mozilla.geckoview.test-1/lib/x86_64
[task 2024-05-07T09:49:00.570Z] 09:49:00 INFO - 05-07 09:48:58.157 E/GeckoLibLoad(16755): Load nss start
[task 2024-05-07T09:49:00.570Z] 09:49:00 INFO - 05-07 09:48:58.157 E/GeckoLibLoad(16755): Load nss done
[task 2024-05-07T09:49:00.571Z] 09:49:00 INFO - 05-07 09:48:58.157 I/GeckoLoader(16755): Library base=/data/app/org.mozilla.geckoview.test-1/lib/x86_64
[task 2024-05-07T09:49:00.571Z] 09:49:00 INFO - 05-07 09:48:58.157 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so: unused DT entry: type 0x8000024 arg 0x444188
[task 2024-05-07T09:49:00.571Z] 09:49:00 INFO - 05-07 09:48:58.157 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so: unused DT entry: type 0x8000023 arg 0x1bdd0
[task 2024-05-07T09:49:00.571Z] 09:49:00 INFO - 05-07 09:48:58.158 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libxul.so: unused DT entry: type 0x8000025 arg 0x8
[task 2024-05-07T09:49:00.571Z] 09:49:00 INFO - 05-07 09:48:58.158 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libgkcodecs.so: unused DT entry: type 0x8000024 arg 0x36a8
[task 2024-05-07T09:49:00.571Z] 09:49:00 INFO - 05-07 09:48:58.158 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libgkcodecs.so: unused DT entry: type 0x8000023 arg 0xa58
[task 2024-05-07T09:49:00.572Z] 09:49:00 INFO - 05-07 09:48:58.158 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libgkcodecs.so: unused DT entry: type 0x8000025 arg 0x8
[task 2024-05-07T09:49:00.572Z] 09:49:00 INFO - 05-07 09:48:58.159 D/GeckoViewSessionStore( 3480): observe browsing-context-did-set-embedder
[task 2024-05-07T09:49:00.572Z] 09:49:00 INFO - 05-07 09:48:58.164 D/GeckoViewXUL( 3480): DidChangeBrowserRemoteness
[task 2024-05-07T09:49:00.572Z] 09:49:00 INFO - 05-07 09:48:58.165 D/GeckoViewNavigation( 3480): sessionContextId=null
[task 2024-05-07T09:49:00.572Z] 09:49:00 INFO - 05-07 09:48:58.165 D/GeckoViewMediaControl( 3480): onInitBrowser
[task 2024-05-07T09:49:00.572Z] 09:49:00 INFO - 05-07 09:48:58.171 D/GeckoViewAutoFill( 3480): receiveMessage Clear
[task 2024-05-07T09:49:00.572Z] 09:49:00 INFO - 05-07 09:48:58.173 E/eglCodecCommon( 3553): glUtilsParamSize: unknow param 0x00008caa
[task 2024-05-07T09:49:00.572Z] 09:49:00 INFO - 05-07 09:48:58.178 E/GeckoLibLoad(16755): Loaded libs in 20.605500ms total, 10ms(10ms) user, 0ms(0ms) system, 0(0) faults
[task 2024-05-07T09:49:00.572Z] 09:49:00 INFO - 05-07 09:48:58.178 D/GeckoThread(16755): State changed to LIBS_READY
[task 2024-05-07T09:49:00.573Z] 09:49:00 INFO - 05-07 09:48:58.178 W/GeckoThread(16755): zerdatime 478345 - runGecko
[task 2024-05-07T09:49:00.573Z] 09:49:00 INFO - 05-07 09:48:58.185 W/webrender::device::gl( 3553): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-05-07T09:49:00.573Z] 09:49:00 INFO - 05-07 09:48:58.186 W/webrender::device::gl( 3553): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-05-07T09:49:00.573Z] 09:49:00 INFO - 05-07 09:48:58.190 W/webrender::device::gl( 3553): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-05-07T09:49:00.573Z] 09:49:00 INFO - 05-07 09:48:58.212 E/eglCodecCommon( 3553): glUtilsParamSize: unknow param 0x00008caa
[task 2024-05-07T09:49:00.573Z] 09:49:00 INFO - 05-07 09:48:58.226 I/Gecko (16755): [Child 16755, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:494
[task 2024-05-07T09:49:00.573Z] 09:49:00 INFO - 05-07 09:48:58.232 W/webrender::device::gl( 3553): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-05-07T09:49:00.573Z] 09:49:00 INFO - 05-07 09:48:58.238 W/webrender::device::gl( 3553): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-05-07T09:49:00.573Z] 09:49:00 INFO - 05-07 09:48:58.243 W/webrender::device::gl( 3553): Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-05-07T09:49:00.573Z] 09:49:00 INFO - 05-07 09:48:58.289 D/GeckoThread(16755): State changed to RUNNING
[task 2024-05-07T09:49:00.574Z] 09:49:00 INFO - 05-07 09:48:58.322 D/GeckoViewStartup(16755): observe: content-process-ready-for-script
[task 2024-05-07T09:49:00.574Z] 09:49:00 INFO - 05-07 09:48:58.326 D/GeckoViewConsole(16755): enabled = true
[task 2024-05-07T09:49:00.574Z] 09:49:00 INFO - 05-07 09:48:58.375 D/GeckoViewXUL( 3480): receiveMessage GeckoView:ContentModuleLoaded {}
[task 2024-05-07T09:49:00.574Z] 09:49:00 INFO - 05-07 09:48:58.387 E/eglCodecCommon( 3553): glUtilsParamSize: unknow param 0x00008caa
[task 2024-05-07T09:49:00.574Z] 09:49:00 INFO - 05-07 09:48:58.400 D/GeckoViewSelectionActionDelegate[C](16755): handleEvent: visibilitychange
[task 2024-05-07T09:49:00.574Z] 09:49:00 INFO - 05-07 09:48:58.406 D/GeckoViewAutoFill[C](16755): handleEvent: pagehide
[task 2024-05-07T09:49:00.574Z] 09:49:00 INFO - 05-07 09:48:58.408 D/GeckoViewAutoFill( 3480): receiveMessage Clear
[task 2024-05-07T09:49:00.574Z] 09:49:00 INFO - 05-07 09:48:58.413 D/GeckoViewContentBlocking( 3480): onContentBlockingEvent 8000
[task 2024-05-07T09:49:00.574Z] 09:49:00 INFO - 05-07 09:48:58.414 D/GeckoViewContentBlocking( 3480): onContentBlockingEvent matchedList: null
[task 2024-05-07T09:49:00.575Z] 09:49:00 INFO - 05-07 09:48:58.414 D/GeckoViewContentBlocking( 3480): onContentBlockingEvent matchedTrackingLists: []
[task 2024-05-07T09:49:00.575Z] 09:49:00 INFO - 05-07 09:48:58.428 D/GeckoViewNavigation( 3480): onLocationChange
[task 2024-05-07T09:49:00.575Z] 09:49:00 INFO - 05-07 09:48:58.430 D/GeckoViewTranslations( 3480): handleEvent: TranslationsParent:LanguageState
[task 2024-05-07T09:49:00.575Z] 09:49:00 INFO - 05-07 09:48:58.431 D/GeckoSession( 3480): handleMessage GeckoView:LocationChange uri=https://example.com/
[task 2024-05-07T09:49:00.575Z] 09:49:00 INFO - 05-07 09:48:58.431 D/GeckoViewProgress( 3480): SecurityTracker onLocationChange: location=https://example.com/, flags=0
[task 2024-05-07T09:49:00.575Z] 09:49:00 INFO - 05-07 09:48:58.432 D/GeckoViewProgress( 3480): ProgressTracker onLocationChange: location=https://example.com/, flags=0
[task 2024-05-07T09:49:00.575Z] 09:49:00 INFO - 05-07 09:48:58.432 D/GeckoViewProgress( 3480): ProgressTracker changeLocation https://example.com/
[task 2024-05-07T09:49:00.576Z] 09:49:00 INFO - 05-07 09:48:58.432 D/GeckoViewProgress( 3480): onSecurityChange
[task 2024-05-07T09:49:00.576Z] 09:49:00 INFO - 05-07 09:48:58.434 D/GeckoSession( 3480): handleMessage GeckoView:SecurityChanged uri=null
[task 2024-05-07T09:49:00.576Z] 09:49:00 INFO - 05-07 09:48:58.571 D/WebExtension( 3480): handleMessage GeckoView:WebExtension:Connect
[task 2024-05-07T09:49:00.576Z] 09:49:00 INFO - 05-07 09:48:58.619 D/GeckoViewContent( 3480): handleEvent: pagetitlechanged
[task 2024-05-07T09:49:00.576Z] 09:49:00 INFO - 05-07 09:48:58.635 D/GeckoViewContentDelegateChild[C](16755): handleEvent: DOMContentLoaded
[task 2024-05-07T09:49:00.576Z] 09:49:00 INFO - 05-07 09:48:58.650 D/GeckoViewProgressDelegate[C](16755): handleEvent: DOMContentLoaded
[task 2024-05-07T09:49:00.576Z] 09:49:00 INFO - 05-07 09:48:58.654 D/GeckoViewProgress( 3480): receiveMessage: DOMContentLoaded
[task 2024-05-07T09:49:00.576Z] 09:49:00 INFO - 05-07 09:48:58.654 D/GeckoViewProgress( 3480): ProgressTracker handleEvent: DOMContentLoaded
[task 2024-05-07T09:49:00.576Z] 09:49:00 INFO - 05-07 09:48:58.655 D/GeckoViewProgress( 3480): ProgressTracker updateProgress
[task 2024-05-07T09:49:00.577Z] 09:49:00 INFO - 05-07 09:48:58.656 D/GeckoViewProgress( 3480): ProgressTracker updateProgress data={"prev":15,"uri":"https://example.com/","locationChange":true,"pageStart":true,"pageStop":false,"firstPaint":false,"pageShow":false,"parsed":true} progress=55
[task 2024-05-07T09:49:00.577Z] 09:49:00 INFO - 05-07 09:48:58.657 D/GeckoSession( 3480): handleMessage GeckoView:ProgressChanged uri=null
[task 2024-05-07T09:49:00.577Z] 09:49:00 INFO - 05-07 09:48:58.658 D/GeckoViewContent[C](16755): handleEvent: pageshow
[task 2024-05-07T09:49:00.577Z] 09:49:00 INFO - 05-07 09:48:58.659 D/GeckoViewProgressDelegate[C](16755): handleEvent: pageshow
[task 2024-05-07T09:49:00.577Z] 09:49:00 INFO - 05-07 09:48:58.660 D/GeckoViewAutoFill[C](16755): handleEvent: pageshow
[task 2024-05-07T09:49:00.578Z] 09:49:00 INFO - 05-07 09:48:58.662 D/GeckoViewProgress( 3480): receiveMessage: pageshow
[task 2024-05-07T09:49:00.578Z] 09:49:00 INFO - 05-07 09:48:58.662 D/GeckoViewProgress( 3480): ProgressTracker handleEvent: pageshow
[task 2024-05-07T09:49:00.578Z] 09:49:00 INFO - 05-07 09:48:58.663 D/GeckoViewProgress( 3480): ProgressTracker updateProgress
[task 2024-05-07T09:49:00.578Z] 09:49:00 INFO - 05-07 09:48:58.663 D/GeckoViewProgress( 3480): ProgressTracker updateProgress data={"prev":55,"uri":"https://example.com/","locationChange":true,"pageStart":true,"pageStop":false,"firstPaint":false,"pageShow":true,"parsed":true} progress=100
[task 2024-05-07T09:49:00.578Z] 09:49:00 INFO - 05-07 09:48:58.664 D/GeckoSession( 3480): handleMessage GeckoView:ProgressChanged uri=null
[task 2024-05-07T09:49:00.579Z] 09:49:00 INFO - 05-07 09:48:58.668 D/GeckoViewProgress( 3480): ProgressTracker onStateChange: isTopLevel=true, flags=0xc0010, status=NS_OK
[task 2024-05-07T09:49:00.579Z] 09:49:00 INFO - 05-07 09:48:58.668 D/GeckoViewProgress( 3480): ProgressTracker onStateChange: uri=https://example.com/
[task 2024-05-07T09:49:00.579Z] 09:49:00 INFO - 05-07 09:48:58.669 D/GeckoViewProgress( 3480): ProgressTracker stop
[task 2024-05-07T09:49:00.579Z] 09:49:00 INFO - 05-07 09:48:58.669 D/GeckoViewProgress( 3480): ProgressTracker updateProgress
[task 2024-05-07T09:49:00.579Z] 09:49:00 INFO - 05-07 09:48:58.670 D/GeckoViewProgress( 3480): StateTracker onStateChange: isTopLevel=true, flags=0xc0010, status=NS_OK loadType=1
[task 2024-05-07T09:49:00.579Z] 09:49:00 INFO - 05-07 09:48:58.671 D/GeckoSession( 3480): handleMessage GeckoView:PageStop uri=null
[task 2024-05-07T09:49:00.579Z] 09:49:00 INFO - 05-07 09:48:58.671 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libsoftokn3.so: unused DT entry: type 0x8000024 arg 0x26a8
[task 2024-05-07T09:49:00.580Z] 09:49:00 INFO - 05-07 09:48:58.671 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libsoftokn3.so: unused DT entry: type 0x8000023 arg 0x68
[task 2024-05-07T09:49:00.580Z] 09:49:00 INFO - 05-07 09:48:58.671 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libsoftokn3.so: unused DT entry: type 0x8000025 arg 0x8
[task 2024-05-07T09:49:00.580Z] 09:49:00 INFO - 05-07 09:48:58.672 I/Gecko ( 3480): [Parent 3480, Main Thread] WARNING: NS_ENSURE_TRUE(mBounceTrackingRecord) failed: file /builds/worker/checkouts/gecko/toolkit/components/antitracking/bouncetrackingprotection/BounceTrackingState.cpp:657
[task 2024-05-07T09:49:00.580Z] 09:49:00 INFO - 05-07 09:48:58.672 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libfreebl3.so: unused DT entry: type 0x8000024 arg 0xf20
[task 2024-05-07T09:49:00.580Z] 09:49:00 INFO - 05-07 09:48:58.672 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libfreebl3.so: unused DT entry: type 0x8000023 arg 0x70
[task 2024-05-07T09:49:00.580Z] 09:49:00 INFO - 05-07 09:48:58.672 W/linker (16755): /data/app/org.mozilla.geckoview.test-1/lib/x86_64/libfreebl3.so: unused DT entry: type 0x8000025 arg 0x8
[task 2024-05-07T09:49:00.581Z] 09:49:00 INFO - 05-07 09:48:58.673 I/GeckoSessionTestRule( 3480): network is posting location, lat: 1.1111 lon: 2.2222 acc: 4.0
[task 2024-05-07T09:49:00.581Z] 09:49:00 INFO - 05-07 09:48:58.682 E/eglCodecCommon( 3553): glUtilsParamSize: unknow param 0x00008caa
[task 2024-05-07T09:49:00.581Z] 09:49:00 INFO - 05-07 09:48:58.684 I/GeckoSessionTestRule( 3480): gps is posting location, lat: 3.3333 lon: 4.4444 acc: 1.0E-6
[task 2024-05-07T09:49:00.581Z] 09:49:00 INFO - 05-07 09:48:58.686 D/GeckoViewConsole( 3480): onEvent GeckoView:WebExtension:PortMessageFromApp {"message":{"id":"09370f7e-1fb6-4a60-8e73-948c8f4cb5a5","eval":"this['f609d4e6-3fdb-4a09-b32b-c88430735689'] = \n new Promise((resolve, reject) =>\n window.navigator.geolocation.getCurrentPosition(\n position => resolve(\n {latitude: position.coords.latitude,\n longitude: position.coords.longitude,\n accuracy: position.coords.accuracy}),\n error => reject(error.code),\n {maximumAge: 0,\n timeout: 6001,\n enableHighAccuracy: true })); true"}}
[task 2024-05-07T09:49:00.581Z] 09:49:00 INFO - 05-07 09:48:58.690 D/GeckoViewContentDelegateChild[C](16755): handleEvent: MozFirstContentfulPaint
[task 2024-05-07T09:49:00.581Z] 09:49:00 INFO - 05-07 09:48:58.693 D/GeckoViewContentDelegateParent( 3480): receiveMessage: DispatcherMessage
[task 2024-05-07T09:49:00.582Z] 09:49:00 INFO - 05-07 09:48:58.701 D/GeckoViewContentDelegateChild[C](16755): handleEvent: MozFirstContentfulPaint
[task 2024-05-07T09:49:00.582Z] 09:49:00 INFO - 05-07 09:48:58.708 D/GeckoViewConsole( 3480): onEvent GeckoView:WebExtension:PortMessageFromApp {"message":{"id":"4e8b13c0-4765-4388-9fac-77475db763c5","eval":"this['f609d4e6-3fdb-4a09-b32b-c88430735689']"}}
[task 2024-05-07T09:49:00.582Z] 09:49:00 INFO - 05-07 09:48:58.710 D/GeckoViewContentDelegateParent( 3480): receiveMessage: DispatcherMessage
[task 2024-05-07T09:49:00.582Z] 09:49:00 INFO - 05-07 09:48:58.715 D/GeckoViewPermissionParent( 3480): receiveMessage DispatcherQuery
[task 2024-05-07T09:49:00.582Z] 09:49:00 INFO - 05-07 09:48:58.716 D/GeckoSession( 3480): handleMessage: GeckoView:ContentPermission
[task 2024-05-07T09:49:00.582Z] 09:49:00 INFO - 05-07 09:48:58.717 D/GeckoViewContentDelegateParent( 3480): receiveMessage: DispatcherMessage
[task 2024-05-07T09:49:00.582Z] 09:49:00 INFO - 05-07 09:48:58.722 D/GeckoViewPermissionParent( 3480): receiveMessage GetAppPermissions
[task 2024-05-07T09:49:00.582Z] 09:49:00 INFO - 05-07 09:48:58.724 D/GeckoSession( 3480): handleMessage: GeckoView:AndroidPermission
[task 2024-05-07T09:49:00.582Z] 09:49:00 INFO - 05-07 09:48:58.734 I/GeckoSessionTestRule( 3480): network is posting location, lat: 1.1111 lon: 2.2222 acc: 4.0
[task 2024-05-07T09:49:00.583Z] 09:49:00 INFO - 05-07 09:48:58.734 I/GeckoSessionTestRule( 3480): gps is posting location, lat: 3.3333 lon: 4.4444 acc: 1.0E-6
[task 2024-05-07T09:49:00.583Z] 09:49:00 INFO - 05-07 09:48:58.848 D/EGL_emulation( 3553): eglMakeCurrent: 0x7d737d83a500: ver 3 0 (tinfo 0x7d737d80c5a0)
[task 2024-05-07T09:49:00.583Z] 09:49:00 INFO - 05-07 09:48:58.852 D/GeckoViewModule( 3480): dispatch GeckoView:SetActive, data={"active":false}
[task 2024-05-07T09:49:00.583Z] 09:49:00 INFO - 05-07 09:48:58.852 D/GeckoViewProgressDelegate[C](16755): handleEvent: MozAfterPaint
[task 2024-05-07T09:49:00.583Z] 09:49:00 INFO - 05-07 09:48:58.853 D/GeckoViewContent( 3480): onEvent: event=GeckoView:SetActive, data={"active":false}
[task 2024-05-07T09:49:00.583Z] 09:49:00 INFO - 05-07 09:48:58.854 D/GeckoViewModule( 3480): dispatch GeckoView:FlushSessionState, data=null
[task 2024-05-07T09:49:00.583Z] 09:49:00 INFO - 05-07 09:48:58.854 D/GeckoViewProgress( 3480): onEvent: event=GeckoView:FlushSessionState, data=null
[task 2024-05-07T09:49:00.584Z] 09:49:00 INFO - 05-07 09:48:58.855 D/GeckoViewModule( 3480): dispatch GeckoView:SetFocused, data={"focused":false}
[task 2024-05-07T09:49:00.584Z] 09:49:00 INFO - 05-07 09:48:58.856 D/GeckoViewContent( 3480): onEvent: event=GeckoView:SetFocused, data={"focused":false}
[task 2024-05-07T09:49:00.584Z] 09:49:00 INFO - 05-07 09:48:58.858 D/GpsNetInitiatedHandler( 1657): location enabled :true
[task 2024-05-07T09:49:00.584Z] 09:49:00 INFO - 05-07 09:48:58.858 E/GeckoSessionTestRule( 3480): after evaluate
[task 2024-05-07T09:49:00.584Z] 09:49:00 INFO - 05-07 09:48:58.859 D/GpsNetInitiatedHandler( 1657): location enabled :true
[task 2024-05-07T09:49:00.584Z] 09:49:00 INFO - 05-07 09:48:58.861 D/GeckoViewProgress( 3480): receiveMessage: MozAfterPaint
[task 2024-05-07T09:49:00.584Z] 09:49:00 INFO - 05-07 09:48:58.861 D/GeckoSession( 3480): handleMessage: GeckoView:DismissClipboardPermissionRequest
[task 2024-05-07T09:49:00.585Z] 09:49:00 INFO - 05-07 09:48:58.863 D/GeckoViewSessionStateAggregator[C](16755): receiveMessage: GeckoView:FlushSessionState
[task 2024-05-07T09:49:00.585Z] 09:49:00 INFO - 05-07 09:48:58.864 D/GeckoViewContentDelegateChild[C](16755): handleEvent: MozPaintStatusReset
[task 2024-05-07T09:49:00.585Z] 09:49:00 INFO - 05-07 09:48:58.864 D/GeckoViewConsole( 3480): onEvent GeckoView:WebExtension:PortMessageFromApp {"message":{"id":"65687b19-d36b-49bf-833c-6b65232dd3f2","args":{"oldPrefs":{"geo.provider.testing":true}},"type":"RestorePrefs"}}
[task 2024-05-07T09:49:00.585Z] 09:49:00 INFO - 05-07 09:48:58.866 D/GeckoViewContentDelegateParent( 3480): receiveMessage: DispatcherMessage
[task 2024-05-07T09:49:00.585Z] 09:49:00 INFO - 05-07 09:48:58.878 E/GeckoSessionTestRule( 3480): after performTestEndCheck
[task 2024-05-07T09:49:00.585Z] 09:49:00 INFO - 05-07 09:48:58.880 D/GeckoViewContent( 3480): handleEvent: DOMWindowClose
[task 2024-05-07T09:49:00.586Z] 09:49:00 INFO - 05-07 09:48:58.881 D/GeckoViewConsole( 3480): onEvent GeckoView:WebExtension:List null
[task 2024-05-07T09:49:00.586Z] 09:49:00 INFO - 05-07 09:48:58.887 I/Gecko ( 3480): nsWindow[0x7d73437fcf00]::Show 0
[task 2024-05-07T09:49:00.586Z] 09:49:00 INFO - 05-07 09:48:58.887 E/GeckoSessionTestRule( 3480): test_end c5ee677f-bc83-49bd-9e28-2d35f3d0f059 highAccuracyTest(org.mozilla.geckoview.test.GeolocationTest)
[task 2024-05-07T09:49:00.586Z] 09:49:00 WARNING - TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.GeolocationTest#highAccuracyTest | java.lang.AssertionError: High accuracy longitude is expected.
[task 2024-05-07T09:49:00.586Z] 09:49:00 INFO - TEST-INFO took 4644ms
[task 2024-05-07T09:49:00.586Z] 09:49:00 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=1141
[task 2024-05-07T09:49:00.587Z] 09:49:00 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2024-05-07T09:49:00.587Z] 09:49:00 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2024-05-07T09:49:00.587Z] 09:49:00 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=jsContentRequestForLocation
[task 2024-05-07T09:49:00.587Z] 09:49:00 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.GeolocationTest
[task 2024-05-07T09:49:00.587Z] 09:49:00 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=382
[task 2024-05-07T09:49:00.587Z] 09:49:00 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 1
[task 2024-05-07T09:49:00.587Z] 09:49:00 INFO - TEST-START | org.mozilla.geckoview.test.GeolocationTest#jsContentRequestForLocation
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•1 year ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•