Closed Bug 1964346 Opened 1 year ago Closed 1 year ago

Frequent /webdriver/tests/bidi/emulation/set_geolocation_override/contexts.py | test_contexts - AssertionError: assert {'latitude': 37.41857, 'longitude': -122.08769, 'accuracy': 42} == {'code': 3, 'message': | single tracking bug

Categories

(Remote Protocol :: WebDriver BiDi, defect, P5)

defect
Points:
2

Tracking

(firefox139 wontfix, firefox140 fixed)

RESOLVED FIXED
140 Branch
Tracking Status
firefox139 --- wontfix
firefox140 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: Sasha)

References

Details

(Keywords: intermittent-failure, Whiteboard: [webdriver:m16], [wptsync upstream])

Attachments

(1 file, 1 obsolete file)

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


[task 2025-05-05T05:46:25.307Z] 05:46:25     INFO - PID 17125 | 1746423985306	Marionette	DEBUG	Marionette stopped listening
[task 2025-05-05T05:46:25.409Z] 05:46:25     INFO - PID 17125 | 1746423985407	Marionette	DEBUG	0 <- [1,39,null,{"cause":"shutdown","forced":false,"in_app":true}]
[task 2025-05-05T05:46:25.521Z] 05:46:25     INFO - PID 17125 | 1746423985511	RemoteAgent	TRACE	MessageHandler WINDOW_GLOBAL for session 8d045f86-acfb-496d-89ac-bb5e15e0a649 is being destroyed
[task 2025-05-05T05:46:25.521Z] 05:46:25     INFO - PID 17125 | 1746423985512	RemoteAgent	TRACE	Unregistered MessageHandler WINDOW_GLOBAL for session 8d045f86-acfb-496d-89ac-bb5e15e0a649
[task 2025-05-05T05:46:25.685Z] 05:46:25     INFO - PID 17125 | 1746423985680	webdriver::server	DEBUG	Teardown session
[task 2025-05-05T05:46:25.711Z] 05:46:25     INFO - PID 17125 | *** WIFI GEO: startup called.
[task 2025-05-05T05:46:25.711Z] 05:46:25     INFO - PID 17125 | *** WIFI GEO: watch called
[task 2025-05-05T05:46:25.711Z] 05:46:25     INFO - PID 17125 | *** WIFI GEO: onStatus called.wifi-timeout
[task 2025-05-05T05:46:25.711Z] 05:46:25     INFO - PID 17125 | *** WIFI GEO: Use request cache:true reason:New req. is GeoIP.
[task 2025-05-05T05:46:25.739Z] 05:46:25     INFO - PID 17125 | 1746423985727	Marionette	DEBUG	Closed connection 0
[task 2025-05-05T05:46:26.263Z] 05:46:26     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:26.263Z] 05:46:26     INFO - PID 17125 | Suppressions used:
[task 2025-05-05T05:46:26.263Z] 05:46:26     INFO - PID 17125 |   count      bytes template
[task 2025-05-05T05:46:26.263Z] 05:46:26     INFO - PID 17125 |      31      16288 nsComponentManagerImpl
[task 2025-05-05T05:46:26.263Z] 05:46:26     INFO - PID 17125 |       2        288 libfontconfig.so
[task 2025-05-05T05:46:26.263Z] 05:46:26     INFO - PID 17125 |       1       9496 style::sharing::SHARING_CACHE_KEY
[task 2025-05-05T05:46:26.263Z] 05:46:26     INFO - PID 17125 |       1       4104 style::bloom::BLOOM_KEY
[task 2025-05-05T05:46:26.263Z] 05:46:26     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:27.052Z] 05:46:27     INFO - PID 17125 | *** WIFI GEO: shutdown called
[task 2025-05-05T05:46:27.672Z] 05:46:27     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:27.672Z] 05:46:27     INFO - PID 17125 | Suppressions used:
[task 2025-05-05T05:46:27.672Z] 05:46:27     INFO - PID 17125 |   count      bytes template
[task 2025-05-05T05:46:27.672Z] 05:46:27     INFO - PID 17125 |      31      16288 nsComponentManagerImpl
[task 2025-05-05T05:46:27.672Z] 05:46:27     INFO - PID 17125 |       2        288 libfontconfig.so
[task 2025-05-05T05:46:27.672Z] 05:46:27     INFO - PID 17125 |       1       9496 style::sharing::SHARING_CACHE_KEY
[task 2025-05-05T05:46:27.676Z] 05:46:27     INFO - PID 17125 |       1       4104 style::bloom::BLOOM_KEY
[task 2025-05-05T05:46:27.676Z] 05:46:27     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:28.720Z] 05:46:28     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:28.724Z] 05:46:28     INFO - PID 17125 | Suppressions used:
[task 2025-05-05T05:46:28.727Z] 05:46:28     INFO - PID 17125 |   count      bytes template
[task 2025-05-05T05:46:28.729Z] 05:46:28     INFO - PID 17125 |      31      16288 nsComponentManagerImpl
[task 2025-05-05T05:46:28.732Z] 05:46:28     INFO - PID 17125 |       2        288 libfontconfig.so
[task 2025-05-05T05:46:28.732Z] 05:46:28     INFO - PID 17125 |       1       9496 style::sharing::SHARING_CACHE_KEY
[task 2025-05-05T05:46:28.735Z] 05:46:28     INFO - PID 17125 |       1       4104 style::bloom::BLOOM_KEY
[task 2025-05-05T05:46:28.737Z] 05:46:28     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:31.041Z] 05:46:31     INFO - PID 17125 | [Parent 17142, IPC I/O Parent] WARNING: Process 17463 may be hanging at shutdown; will wait for up to 40000ms: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/process_watcher_posix_sigchld.cc:203
[task 2025-05-05T05:46:31.555Z] 05:46:31     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:31.559Z] 05:46:31     INFO - PID 17125 | Suppressions used:
[task 2025-05-05T05:46:31.559Z] 05:46:31     INFO - PID 17125 |   count      bytes template
[task 2025-05-05T05:46:31.559Z] 05:46:31     INFO - PID 17125 |      31      16288 nsComponentManagerImpl
[task 2025-05-05T05:46:31.559Z] 05:46:31     INFO - PID 17125 |       2        288 libfontconfig.so
[task 2025-05-05T05:46:31.559Z] 05:46:31     INFO - PID 17125 |       1       9496 style::sharing::SHARING_CACHE_KEY
[task 2025-05-05T05:46:31.559Z] 05:46:31     INFO - PID 17125 |       1       4104 style::bloom::BLOOM_KEY
[task 2025-05-05T05:46:31.559Z] 05:46:31     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:31.650Z] 05:46:31     INFO - PID 17125 | [Parent 17142, IPC I/O Parent] WARNING: Process 17528 may be hanging at shutdown; will wait for up to 39400ms: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/process_watcher_posix_sigchld.cc:203
[task 2025-05-05T05:46:32.785Z] 05:46:32     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:32.792Z] 05:46:32     INFO - PID 17125 | Suppressions used:
[task 2025-05-05T05:46:32.792Z] 05:46:32     INFO - PID 17125 |   count      bytes template
[task 2025-05-05T05:46:32.792Z] 05:46:32     INFO - PID 17125 |      31      16288 nsComponentManagerImpl
[task 2025-05-05T05:46:32.792Z] 05:46:32     INFO - PID 17125 |       2        288 libfontconfig.so
[task 2025-05-05T05:46:32.792Z] 05:46:32     INFO - PID 17125 |       1       9496 style::sharing::SHARING_CACHE_KEY
[task 2025-05-05T05:46:32.792Z] 05:46:32     INFO - PID 17125 |       1       4104 style::bloom::BLOOM_KEY
[task 2025-05-05T05:46:32.792Z] 05:46:32     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:32.958Z] 05:46:32     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:32.958Z] 05:46:32     INFO - PID 17125 | Suppressions used:
[task 2025-05-05T05:46:32.959Z] 05:46:32     INFO - PID 17125 |   count      bytes template
[task 2025-05-05T05:46:32.959Z] 05:46:32     INFO - PID 17125 |      31      16288 nsComponentManagerImpl
[task 2025-05-05T05:46:32.959Z] 05:46:32     INFO - PID 17125 |       2        288 libfontconfig.so
[task 2025-05-05T05:46:32.959Z] 05:46:32     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:33.046Z] 05:46:33     INFO - PID 17125 | [Parent 17142, IPC I/O Parent] WARNING: Process 17292 may be hanging at shutdown; will wait for up to 38000ms: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/process_watcher_posix_sigchld.cc:203
[task 2025-05-05T05:46:33.083Z] 05:46:33     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:33.083Z] 05:46:33     INFO - PID 17125 | Suppressions used:
[task 2025-05-05T05:46:33.083Z] 05:46:33     INFO - PID 17125 |   count      bytes template
[task 2025-05-05T05:46:33.083Z] 05:46:33     INFO - PID 17125 |      31      16288 nsComponentManagerImpl
[task 2025-05-05T05:46:33.083Z] 05:46:33     INFO - PID 17125 |       2        288 libfontconfig.so
[task 2025-05-05T05:46:33.083Z] 05:46:33     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:33.324Z] 05:46:33     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:33.324Z] 05:46:33     INFO - PID 17125 | Suppressions used:
[task 2025-05-05T05:46:33.327Z] 05:46:33     INFO - PID 17125 |   count      bytes template
[task 2025-05-05T05:46:33.327Z] 05:46:33     INFO - PID 17125 |      31      16288 nsComponentManagerImpl
[task 2025-05-05T05:46:33.327Z] 05:46:33     INFO - PID 17125 |       2        288 libfontconfig.so
[task 2025-05-05T05:46:33.327Z] 05:46:33     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:33.373Z] 05:46:33     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:33.373Z] 05:46:33     INFO - PID 17125 | Suppressions used:
[task 2025-05-05T05:46:33.374Z] 05:46:33     INFO - PID 17125 |   count      bytes template
[task 2025-05-05T05:46:33.377Z] 05:46:33     INFO - PID 17125 |      31      16288 nsComponentManagerImpl
[task 2025-05-05T05:46:33.377Z] 05:46:33     INFO - PID 17125 |       2        288 libfontconfig.so
[task 2025-05-05T05:46:33.377Z] 05:46:33     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:33.453Z] 05:46:33     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:33.453Z] 05:46:33     INFO - PID 17125 | Suppressions used:
[task 2025-05-05T05:46:33.453Z] 05:46:33     INFO - PID 17125 |   count      bytes template
[task 2025-05-05T05:46:33.453Z] 05:46:33     INFO - PID 17125 |      31      16288 nsComponentManagerImpl
[task 2025-05-05T05:46:33.453Z] 05:46:33     INFO - PID 17125 |       2        288 libfontconfig.so
[task 2025-05-05T05:46:33.453Z] 05:46:33     INFO - PID 17125 |       1       9496 style::sharing::SHARING_CACHE_KEY
[task 2025-05-05T05:46:33.453Z] 05:46:33     INFO - PID 17125 |       1       4104 style::bloom::BLOOM_KEY
[task 2025-05-05T05:46:33.453Z] 05:46:33     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:33.591Z] 05:46:33     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:33.591Z] 05:46:33     INFO - PID 17125 | Suppressions used:
[task 2025-05-05T05:46:33.592Z] 05:46:33     INFO - PID 17125 |   count      bytes template
[task 2025-05-05T05:46:33.592Z] 05:46:33     INFO - PID 17125 |      31      16288 nsComponentManagerImpl
[task 2025-05-05T05:46:33.593Z] 05:46:33     INFO - PID 17125 |       2        288 libfontconfig.so
[task 2025-05-05T05:46:33.593Z] 05:46:33     INFO - PID 17125 |       1       9496 style::sharing::SHARING_CACHE_KEY
[task 2025-05-05T05:46:33.594Z] 05:46:33     INFO - PID 17125 |       1       4104 style::bloom::BLOOM_KEY
[task 2025-05-05T05:46:33.594Z] 05:46:33     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:34.713Z] 05:46:34     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:34.714Z] 05:46:34     INFO - PID 17125 | Suppressions used:
[task 2025-05-05T05:46:34.714Z] 05:46:34     INFO - PID 17125 |   count      bytes template
[task 2025-05-05T05:46:34.714Z] 05:46:34     INFO - PID 17125 |       2         64 nsComponentManagerImpl
[task 2025-05-05T05:46:34.715Z] 05:46:34     INFO - PID 17125 |       2        288 libfontconfig.so
[task 2025-05-05T05:46:34.715Z] 05:46:34     INFO - PID 17125 |       2      18992 style::sharing::SHARING_CACHE_KEY
[task 2025-05-05T05:46:34.716Z] 05:46:34     INFO - PID 17125 |       2       8208 style::bloom::BLOOM_KEY
[task 2025-05-05T05:46:34.716Z] 05:46:34     INFO - PID 17125 |       2         14 libglib-2.0.so
[task 2025-05-05T05:46:34.717Z] 05:46:34     INFO - PID 17125 | -----------------------------------------------------
[task 2025-05-05T05:46:34.808Z] 05:46:34     INFO - PID 17125 | 1746423994807	geckodriver::browser	DEBUG	Browser process stopped: exit status: 0
[task 2025-05-05T05:46:34.809Z] 05:46:34     INFO - PID 17125 | 1746423994808	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2025-05-05T05:46:34.811Z] 05:46:34     INFO - STDOUT: =================================== FAILURES ===================================
[task 2025-05-05T05:46:34.813Z] 05:46:34     INFO - STDOUT: ________________________________ test_contexts _________________________________
[task 2025-05-05T05:46:34.814Z] 05:46:34     INFO - STDOUT: bidi_session = <webdriver.bidi.client.BidiSession object at 0x7f8a34bff610>
[task 2025-05-05T05:46:34.814Z] 05:46:34     INFO - STDOUT: new_tab = {'context': 'a5ea80c4-cb05-4a64-8af3-160cf6fa31ff'}
[task 2025-05-05T05:46:34.815Z] 05:46:34     INFO - STDOUT: top_context = {'children': [], 'clientWindow': 'a0fedfd6-d06a-4aac-b34c-47b443898b7c', 'context': 'f4445211-a688-415b-88e7-89e9da005155', 'originalOpener': None, ...}
[task 2025-05-05T05:46:34.816Z] 05:46:34     INFO - STDOUT: url = <function url.<locals>.url at 0x7f8a34bb03a0>
[task 2025-05-05T05:46:34.816Z] 05:46:34     INFO - STDOUT: set_geolocation_permission = <function set_geolocation_permission.<locals>.set_geolocation_permission at 0x7f8a34bb0670>
[task 2025-05-05T05:46:34.817Z] 05:46:34     INFO - STDOUT:     async def test_contexts(
[task 2025-05-05T05:46:34.818Z] 05:46:34     INFO - STDOUT:         bidi_session, new_tab, top_context, url, set_geolocation_permission
[task 2025-05-05T05:46:34.818Z] 05:46:34     INFO - STDOUT:     ):
[task 2025-05-05T05:46:34.819Z] 05:46:34     INFO - STDOUT:         test_url = url("/common/blank.html")
[task 2025-05-05T05:46:34.820Z] 05:46:34     INFO - STDOUT:         await bidi_session.browsing_context.navigate(
[task 2025-05-05T05:46:34.820Z] 05:46:34     INFO - STDOUT:             context=new_tab["context"],
[task 2025-05-05T05:46:34.821Z] 05:46:34     INFO - STDOUT:             url=test_url,
[task 2025-05-05T05:46:34.822Z] 05:46:34     INFO - STDOUT:             wait="complete",
[task 2025-05-05T05:46:34.822Z] 05:46:34     INFO - STDOUT:         )
[task 2025-05-05T05:46:34.823Z] 05:46:34     INFO - STDOUT:         await bidi_session.browsing_context.navigate(
[task 2025-05-05T05:46:34.823Z] 05:46:34     INFO - STDOUT:             context=top_context["context"],
[task 2025-05-05T05:46:34.824Z] 05:46:34     INFO - STDOUT:             url=test_url,
[task 2025-05-05T05:46:34.824Z] 05:46:34     INFO - STDOUT:             wait="complete",
[task 2025-05-05T05:46:34.825Z] 05:46:34     INFO - STDOUT:         )
[task 2025-05-05T05:46:34.825Z] 05:46:34     INFO - STDOUT:         await set_geolocation_permission(new_tab)
[task 2025-05-05T05:46:34.826Z] 05:46:34     INFO - STDOUT:     
[task 2025-05-05T05:46:34.826Z] 05:46:34     INFO - STDOUT:         default_coordinates = await get_current_geolocation(bidi_session, new_tab)
[task 2025-05-05T05:46:34.827Z] 05:46:34     INFO - STDOUT:     
[task 2025-05-05T05:46:34.828Z] 05:46:34     INFO - STDOUT:         assert default_coordinates != TEST_COORDINATES
[task 2025-05-05T05:46:34.828Z] 05:46:34     INFO - STDOUT: >       assert (
[task 2025-05-05T05:46:34.829Z] 05:46:34     INFO - STDOUT:             await get_current_geolocation(bidi_session, top_context) == default_coordinates
[task 2025-05-05T05:46:34.831Z] 05:46:34     INFO - 
[task 2025-05-05T05:46:34.831Z] 05:46:34     INFO - TEST-UNEXPECTED-FAIL | /webdriver/tests/bidi/emulation/set_geolocation_override/contexts.py | test_contexts - AssertionError: assert {'latitude': 37.41857, 'longitude': -122.08769, 'accuracy': 42} == {'code': 3, 'message': 'Position acquisition timed out'}
[task 2025-05-05T05:46:34.831Z] 05:46:34     INFO - bidi_session = <webdriver.bidi.client.BidiSession object at 0x7f8a34bff610>
[task 2025-05-05T05:46:34.831Z] 05:46:34     INFO - new_tab = {'context': 'a5ea80c4-cb05-4a64-8af3-160cf6fa31ff'}
[task 2025-05-05T05:46:34.831Z] 05:46:34     INFO - top_context = {'children': [], 'clientWindow': 'a0fedfd6-d06a-4aac-b34c-47b443898b7c', 'context': 'f4445211-a688-415b-88e7-89e9da005155', 'originalOpener': None, ...}
[task 2025-05-05T05:46:34.831Z] 05:46:34     INFO - url = <function url.<locals>.url at 0x7f8a34bb03a0>
[task 2025-05-05T05:46:34.831Z] 05:46:34     INFO - set_geolocation_permission = <function set_geolocation_permission.<locals>.set_geolocation_permission at 0x7f8a34bb0670>
[task 2025-05-05T05:46:34.831Z] 05:46:34     INFO - 
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -     async def test_contexts(
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -         bidi_session, new_tab, top_context, url, set_geolocation_permission
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -     ):
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -         test_url = url("/common/blank.html")
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -         await bidi_session.browsing_context.navigate(
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -             context=new_tab["context"],
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -             url=test_url,
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -             wait="complete",
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -         )
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -         await bidi_session.browsing_context.navigate(
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -             context=top_context["context"],
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -             url=test_url,
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -             wait="complete",
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -         )
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -         await set_geolocation_permission(new_tab)
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -     
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -         default_coordinates = await get_current_geolocation(bidi_session, new_tab)
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -     
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -         assert default_coordinates != TEST_COORDINATES
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - >       assert (
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -             await get_current_geolocation(bidi_session, top_context) == default_coordinates
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -         )
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - E       AssertionError: assert {'latitude': 37.41857, 'longitude': -122.08769, 'accuracy': 42} == {'code': 3, 'message': 'Position acquisition timed out'}
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - E         
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - E         Left contains 3 more items:
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - E         {'accuracy': 42, 'latitude': 37.41857, 'longitude': -122.08769}
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - E         Right contains 2 more items:
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - E         {'code': 3, 'message': 'Position acquisition timed out'}
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - E         
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - E         Full diff:
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - E           {
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - E         -     'code': 3,
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - E         -     'message': 'Position acquisition timed out',
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - E         +     'accuracy': 42,
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - E         +     'latitude': 37.41857,
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - E         +     'longitude': -122.08769,
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - E           }
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - 
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - bidi_session = <webdriver.bidi.client.BidiSession object at 0x7f8a34bff610>
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - default_coordinates = {'code': 3, 'message': 'Position acquisition timed out'}
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - new_tab    = {'context': 'a5ea80c4-cb05-4a64-8af3-160cf6fa31ff'}
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - set_geolocation_permission = <function set_geolocation_permission.<locals>.set_geolocation_permission at 0x7f8a34bb0670>
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - test_url   = 'https://web-platform.test:8443/common/blank.html'
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO - top_context = {'children': [],
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -  'clientWindow': 'a0fedfd6-d06a-4aac-b34c-47b443898b7c',
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -  'context': 'f4445211-a688-415b-88e7-89e9da005155',
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -  'originalOpener': None,
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -  'parent': None,
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -  'url': 'about:blank',
[task 2025-05-05T05:46:34.832Z] 05:46:34     INFO -  'userContext': 'default'}
[task 2025-05-05T05:46:34.833Z] 05:46:34     INFO - url        = <function url.<locals>.url at 0x7f8a34bb03a0>
[task 2025-05-05T05:46:34.833Z] 05:46:34     INFO - 
[task 2025-05-05T05:46:34.833Z] 05:46:34     INFO - tests/web-platform/tests/webdriver/tests/bidi/emulation/set_geolocation_override/contexts.py:30: AssertionError
[task 2025-05-05T05:46:34.833Z] 05:46:34     INFO - .
[task 2025-05-05T05:46:34.833Z] 05:46:34     INFO - TEST-OK | /webdriver/tests/bidi/emulation/set_geolocation_override/contexts.py | took 19158ms
[task 2025-05-05T05:46:34.915Z] 05:46:34     INFO - STDOUT:         )
[task 2025-05-05T05:46:34.916Z] 05:46:34     INFO - STDOUT: E       AssertionError: assert {'latitude': 37.41857, 'longitude': -122.08769, 'accuracy': 42} == {'code': 3, 'message': 'Position acquisition timed out'}
[task 2025-05-05T05:46:34.916Z] 05:46:34     INFO - STDOUT: E         
[task 2025-05-05T05:46:34.917Z] 05:46:34     INFO - STDOUT: E         Left contains 3 more items:
[task 2025-05-05T05:46:34.917Z] 05:46:34     INFO - STDOUT: E         {'accuracy': 42, 'latitude': 37.41857, 'longitude': -122.08769}
[task 2025-05-05T05:46:34.918Z] 05:46:34     INFO - STDOUT: E         Right contains 2 more items:
[task 2025-05-05T05:46:34.918Z] 05:46:34     INFO - STDOUT: E         {'code': 3, 'message': 'Position acquisition timed out'}
[task 2025-05-05T05:46:34.918Z] 05:46:34     INFO - STDOUT: E         
[task 2025-05-05T05:46:34.918Z] 05:46:34     INFO - STDOUT: E         Full diff:
[task 2025-05-05T05:46:34.919Z] 05:46:34     INFO - STDOUT: E           {
[task 2025-05-05T05:46:34.919Z] 05:46:34     INFO - STDOUT: E         -     'code': 3,
[task 2025-05-05T05:46:34.919Z] 05:46:34     INFO - STDOUT: E         -     'message': 'Position acquisition timed out',
[task 2025-05-05T05:46:34.920Z] 05:46:34     INFO - STDOUT: E         +     'accuracy': 42,
[task 2025-05-05T05:46:34.920Z] 05:46:34     INFO - STDOUT: E         +     'latitude': 37.41857,
[task 2025-05-05T05:46:34.920Z] 05:46:34     INFO - STDOUT: E         +     'longitude': -122.08769,
[task 2025-05-05T05:46:34.921Z] 05:46:34     INFO - STDOUT: E           }
[task 2025-05-05T05:46:34.921Z] 05:46:34     INFO - STDOUT: bidi_session = <webdriver.bidi.client.BidiSession object at 0x7f8a34bff610>
[task 2025-05-05T05:46:34.922Z] 05:46:34     INFO - STDOUT: default_coordinates = {'code': 3, 'message': 'Position acquisition timed out'}
[task 2025-05-05T05:46:34.922Z] 05:46:34     INFO - STDOUT: new_tab    = {'context': 'a5ea80c4-cb05-4a64-8af3-160cf6fa31ff'}
[task 2025-05-05T05:46:34.923Z] 05:46:34     INFO - STDOUT: set_geolocation_permission = <function set_geolocation_permission.<locals>.set_geolocation_permission at 0x7f8a34bb0670>
[task 2025-05-05T05:46:34.923Z] 05:46:34     INFO - STDOUT: test_url   = 'https://web-platform.test:8443/common/blank.html'
[task 2025-05-05T05:46:34.924Z] 05:46:34     INFO - STDOUT: top_context = {'children': [],
[task 2025-05-05T05:46:34.924Z] 05:46:34     INFO -  'clientWindow': 'a0fedfd6-d06a-4aac-b34c-47b443898b7c',
[task 2025-05-05T05:46:34.924Z] 05:46:34     INFO -  'context': 'f4445211-a688-415b-88e7-89e9da005155',
[task 2025-05-05T05:46:34.924Z] 05:46:34     INFO -  'originalOpener': None,
[task 2025-05-05T05:46:34.924Z] 05:46:34     INFO -  'parent': None,
[task 2025-05-05T05:46:34.924Z] 05:46:34     INFO -  'url': 'about:blank',
[task 2025-05-05T05:46:34.924Z] 05:46:34     INFO -  'userContext': 'default'}
[task 2025-05-05T05:46:34.924Z] 05:46:34     INFO - STDOUT: url        = <function url.<locals>.url at 0x7f8a34bb03a0>
[task 2025-05-05T05:46:34.925Z] 05:46:34     INFO - STDOUT: tests/web-platform/tests/webdriver/tests/bidi/emulation/set_geolocation_override/contexts.py
[task 2025-05-05T05:46:34.925Z] 05:46:34     INFO - STDOUT: :30: AssertionError
[task 2025-05-05T05:46:34.925Z] 05:46:34     INFO - STDOUT: =========================== short test summary info ============================
[task 2025-05-05T05:46:34.926Z] 05:46:34     INFO - STDOUT: FAILED tests/web-platform/tests/webdriver/tests/bidi/emulation/set_geolocation_override/contexts.py::test_contexts - AssertionError: assert {'latitude': 37.41857, 'longitude': -122.08769, 'accuracy': 42} == {'code': 3, 'message': 'Position acquisition timed out'}
[task 2025-05-05T05:46:34.926Z] 05:46:34     INFO -   
[task 2025-05-05T05:46:34.926Z] 05:46:34     INFO -   Left contains 3 more items:
[task 2025-05-05T05:46:34.926Z] 05:46:34     INFO -   {'accuracy': 42, 'latitude': 37.41857, 'longitude': -122.08769}
[task 2025-05-05T05:46:34.926Z] 05:46:34     INFO -   Right contains 2 more items:
[task 2025-05-05T05:46:34.927Z] 05:46:34     INFO -   {'code': 3, 'message': 'Position acquisition timed out'}
[task 2025-05-05T05:46:34.927Z] 05:46:34     INFO -   
[task 2025-05-05T05:46:34.927Z] 05:46:34     INFO -   Full diff:
[task 2025-05-05T05:46:34.927Z] 05:46:34     INFO -     {
[task 2025-05-05T05:46:34.927Z] 05:46:34     INFO -   -     'code': 3,
[task 2025-05-05T05:46:34.927Z] 05:46:34     INFO -   -     'message': 'Position acquisition timed out',
[task 2025-05-05T05:46:34.927Z] 05:46:34     INFO -   +     'accuracy': 42,
[task 2025-05-05T05:46:34.927Z] 05:46:34     INFO -   +     'latitude': 37.41857,
[task 2025-05-05T05:46:34.927Z] 05:46:34     INFO -   +     'longitude': -122.08769,
[task 2025-05-05T05:46:34.927Z] 05:46:34     INFO -     }
[task 2025-05-05T05:46:34.928Z] 05:46:34     INFO - STDOUT: ========================= 1 failed, 1 passed in 18.90s =========================
[task 2025-05-05T05:46:34.928Z] 05:46:34     INFO - Closing logging queue
[task 2025-05-05T05:46:34.928Z] 05:46:34     INFO - queue closed
Summary: Intermittent /webdriver/tests/bidi/emulation/set_geolocation_override/contexts.py | test_contexts - AssertionError: assert {'latitude': 37.41857, 'longitude': -122.08769, 'accuracy': 42} == {'code': 3, 'message': 'Position acquisition timed out'} → Frequent /webdriver/tests/bidi/emulation/set_geolocation_override/contexts.py | test_contexts - AssertionError: assert {'latitude': 37.41857, 'longitude': -122.08769, 'accuracy': 42} == {'code': 3, 'message': 'Position acquisition timed out'}

We seem to try to request the geo location with a timeout for script.evaluate with 500ms. This is most likely too low for ASAN builds. We should probably multiply it with configuration["timeout_multiplier"].

Flags: needinfo?(aborovova)
Summary: Frequent /webdriver/tests/bidi/emulation/set_geolocation_override/contexts.py | test_contexts - AssertionError: assert {'latitude': 37.41857, 'longitude': -122.08769, 'accuracy': 42} == {'code': 3, 'message': 'Position acquisition timed out'} → Frequent /webdriver/tests/bidi/emulation/set_geolocation_override/contexts.py | test_contexts - AssertionError: assert {'latitude': 37.41857, 'longitude': -122.08769, 'accuracy': 42} == {'code': 3, 'message': | single tracking bug
Assignee: nobody → aborovova
Status: NEW → ASSIGNED
Flags: needinfo?(aborovova)
Points: --- → 2
Whiteboard: [webdriver:m16]
Pushed by aborovova@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/127a915ce538 [wdspec] Use timeout multiplier when requesting the geolocation coordinates. r=webdriver-reviewers,whimboo
Failed to create upstream wpt PR due to merge conflicts. This requires fixup from a wpt sync admin.
Flags: needinfo?(james)
Flags: needinfo?(aborovova)
Whiteboard: [webdriver:m16] → [webdriver:m16], [wptsync upstream error]
Status: ASSIGNED → RESOLVED
Closed: 1 year ago
Resolution: --- → FIXED
Target Milestone: --- → 140 Branch
Created web-platform-tests PR https://github.com/web-platform-tests/wpt/pull/52361 for changes under testing/web-platform/tests
Whiteboard: [webdriver:m16], [wptsync upstream error] → [webdriver:m16], [wptsync upstream]
Flags: needinfo?(james)
Flags: needinfo?(aborovova)
Upstream PR merged by moz-wptsync-bot
Depends on: 1964731
Duplicate of this bug: 1964775

Beta is affected as well. Shall we as well uplift?

Flags: needinfo?(aborovova)
No longer blocks: 1960072
Attachment #9485925 - Flags: approval-mozilla-beta?
Flags: needinfo?(aborovova)

firefox-beta Uplift Approval Request

  • User impact if declined: Tests will keep on failing on beta
  • Code covered by automated testing: yes
  • Fix verified in Nightly: yes
  • Needs manual QE test: no
  • Steps to reproduce for manual QE testing: None
  • Risk associated with taking this patch: Low
  • Explanation of risk level: Changes affect only tests
  • String changes made/needed: None
  • Is Android affected?: yes
Attachment #9485925 - Flags: approval-mozilla-beta? → approval-mozilla-beta+
Attachment #9485925 - Flags: approval-mozilla-beta+ → approval-mozilla-beta-

Hi Donal, would you mind explaining why the patch got denied for beta? It's not too late yet, or?

Flags: needinfo?(dmeehan)

Hi :whimboo, there's a comment on the phabricator revision targeting beta
https://phabricator.services.mozilla.com/D248177
I'll happily take it once it's been looked at

Flags: needinfo?(dmeehan)
Attachment #9485925 - Flags: approval-mozilla-beta- → approval-mozilla-beta+

Backout for causing wd failures on beta:
Backout link: https://hg.mozilla.org/releases/mozilla-beta/rev/bb653acd26b2fc5383bcc08aa030317a6026eaaf
Push link: https://treeherder.mozilla.org/jobs?repo=mozilla-beta&group_state=expanded&resultStatus=testfailed%2Cbusted%2Cexception%2Cusercancel&revision=dc0cb8017c8a659b249bd8f3dc15a1fbde5e524d&selectedTaskRun=U5hLhlRhSdqp8b1cnaHt0g.0
Log: https://treeherder.mozilla.org/logviewer?job_id=507834624&repo=mozilla-beta
Line: TEST-UNEXPECTED-FAIL | /webdriver/tests/bidi/emulation/set_geolocation_override/coordinates.py | test_reset_without_override - AssertionError: assert {'code': 3, 'message': 'Position acquisition timed out'} == {'latitude': 37.41857, 'longitude': -122.08769, 'accuracy': 42}
Log : https://treeherder.mozilla.org/logviewer?job_id=507835219&repo=mozilla-beta
Line: TEST-UNEXPECTED-FAIL | /webdriver/tests/bidi/emulation/set_geolocation_override/user_contexts.py | test_user_contexts - AssertionError: assert {'latitude': 37.41857, 'longitude': -122.08769, 'accuracy': 42} == {'code': 3, 'message': 'Position acquisition timed out'}

Flags: needinfo?(aborovova)

To avoid these failures, we need to uplift bug 1960651.
I've asked on the bug.

Flags: needinfo?(aborovova)
See Also: → 1966071
Attachment #9485925 - Flags: approval-mozilla-release+
Attachment #9485925 - Attachment is obsolete: true
Attachment #9485925 - Flags: approval-mozilla-release+ → approval-mozilla-release-
Depends on: 1960651
No longer depends on: 1964731
See Also: → 1964731
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: