Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Error page shown after login in the Firefox Sync service #1691

Closed
javifernandez opened this issue Jan 16, 2025 · 2 comments
Closed

Error page shown after login in the Firefox Sync service #1691

javifernandez opened this issue Jan 16, 2025 · 2 comments
Labels
bug Something isn't working

Comments

@javifernandez
Copy link
Member

Configuration

Wolvic version: 1.8
Wolvic build ID: 190161443

Hardware: Quest3 SO V71

Steps to Reproduce

  1. Go to the settings dialog
  2. Launch the Firefox Sync login website
  3. Login in the Firefox Sync service

Current Behavior

An error page is shown after completing the login process.

The sync process looks like completed, though. After a few seconds, the conf dialog is opened and the Sync login is shown, as well as the buttons to start a new sync and logout are also displayed.

The sync takes some time, I'd say more than usual, so there is no new data in the Saved Logins, Bookmarks or History. Sometimes it requires to restart Wolvic.

Expected Behavior

The Sync process happens normally and no error page is shown after successfully completing the login process.

Possible Solution

Context

Error Logs and Stack Traces

31775-32058 VrApi                    I  FPS=90/90,Prd=24ms,Tear=0,Early=0,Stale=0,Stale2/5/10/max=0/0/0/0,VSnc=1,Lat=-1,Fov=0,CPU4/GPU=2/1,1382/350MHz,OC=3F,TA=0/0/0,SP=N/N/N,Mem=1555MHz,Free=3610MB,PLS=0,Temp=36.0C/0.0C,TW=2.50ms,App=2.04ms,GD=0.71ms,CPU&GPU=4.82ms,LCnt=7(DR0,LM2),GPU%=0.51,CPU%=0.06(W0.14),DSF=1.00,CFL=10.98/15.85,ICFLp95=14.25,LD=0,SF=1.00,LP=0,DVFS=0
31775-31822 Deque                    I  AddEventToQueue called. eventInfo.type: 52, eventInfo.next: 1
31775-31822 VRB                      I  OpenXR: NEW active mapping /interaction_profiles/ext/hand_interaction_ext
31775-31822 VRB                      I  OpenXR: NEW active mapping /interaction_profiles/ext/hand_interaction_ext
31775-31801 GeckoIdleService         D  Get idle time: time since reset 475 msec
31775-31801 GeckoIdleService         D  Idle timer callback: current idle time 475 msec
31775-31801 GeckoIdleService         D  next timeout 4525 msec from now
31775-31801 GeckoIdleService         D  SetTimerExpiryIfBefore: next timeout 4525 msec from now
31775-31801 GeckoIdleService         D  reset timer expiry to 4535 msec from now
31775-32058 VrApi                    I  FPS=90/90,Prd=24ms,Tear=0,Early=0,Stale=0,Stale2/5/10/max=0/0/0/0,VSnc=1,Lat=-1,Fov=0,CPU4/GPU=2/1,1382/350MHz,OC=3F,TA=0/0/0,SP=N/N/N,Mem=1555MHz,Free=3610MB,PLS=0,Temp=36.0C/0.0C,TW=2.45ms,App=1.63ms,GD=0.71ms,CPU&GPU=3.92ms,LCnt=7(DR0,LM2),GPU%=0.49,CPU%=0.09(W0.14),DSF=1.00,CFL=10.93/16.07,ICFLp95=14.24,LD=0,SF=1.00,LP=0,DVFS=0
31775-32056 InputDevic...ckedRemote  I  REMOTE: Hand=1 IndexAnalog=0.00 GripAnalog=0.00 Buttons=0x00000000
31775-32056 InputDevic...ckedRemote  I  REMOTE: Hand=2 IndexAnalog=1.00 GripAnalog=0.00 Buttons=0x20000000
31775-31822 Deque                    I  AddEventToQueue called. eventInfo.type: 52, eventInfo.next: 1
31775-31822 VRB                      I  OpenXR: NEW active mapping /interaction_profiles/oculus/touch_controller
31775-31822 VRB                      I  OpenXR: NEW active mapping /interaction_profiles/oculus/touch_controller
31775-32058 VrApi                    I  FPS=91/90,Prd=23ms,Tear=0,Early=0,Stale=0,Stale2/5/10/max=0/0/0/0,VSnc=1,Lat=-1,Fov=0,CPU4/GPU=2/1,1382/350MHz,OC=3F,TA=0/0/0,SP=N/N/N,Mem=1555MHz,Free=3610MB,PLS=0,Temp=36.0C/0.0C,TW=2.89ms,App=1.87ms,GD=0.70ms,CPU&GPU=4.90ms,LCnt=8(DR0,LM2),GPU%=0.53,CPU%=0.10(W0.11),DSF=1.00,CFL=10.96/15.94,ICFLp95=14.39,LD=0,SF=1.00,LP=0,DVFS=0
31775-31804 logins                   D  check_canary
31775-31804 logins                   D  get_by_base_domain
31775-31775 mozac-fxawebchannel      D  Processing WebChannel command: CAN_LINK_ACCOUNT
31775-31822 VRB                      I  Widget with handle 9 already added, updating it.
31775-31787 OpenGLRenderer           I  Davey! duration=9223317479328ms; Flags=0, FrameTimelineVsyncId=641468, IntendedVsync=54557519647022, Vsync=54557519647022, InputEventId=0, HandleInputStart=54557519845378, AnimationStart=54557519846576, PerformTraversalsStart=54557520049910, DrawStart=54557526474441, FrameDeadline=54557540869244, FrameInterval=54557519840326, FrameStartTime=11111111, SyncQueued=54557532440119, SyncStart=54557539495328, IssueDrawCommandsStart=54557539528089, SwapBuffers=54557539660380, FrameCompleted=9223372036854775807, DequeueBufferDuration=8125, QueueBufferDuration=319270, GpuCompleted=9223372036854775807, SwapBuffersCompleted=54557540190901, DisplayPresentTime=0, 
31775-32058 VrApi                    I  FPS=91/90,Prd=25ms,Tear=0,Early=0,Stale=0,Stale2/5/10/max=0/0/0/0,VSnc=1,Lat=-1,Fov=0,CPU4/GPU=2/1,1382/350MHz,OC=3F,TA=0/0/0,SP=N/N/N,Mem=1555MHz,Free=3610MB,PLS=0,Temp=36.0C/0.0C,TW=2.90ms,App=2.60ms,GD=0.70ms,CPU&GPU=5.94ms,LCnt=8(DR0,LM2),GPU%=0.57,CPU%=0.23(W0.27),DSF=1.00,CFL=10.99/15.64,ICFLp95=14.44,LD=0,SF=1.00,LP=0,DVFS=0
31775-32058 VrApi                    I  FPS=90/90,Prd=25ms,Tear=0,Early=0,Stale=0,Stale2/5/10/max=0/0/0/0,VSnc=1,Lat=-1,Fov=0,CPU4/GPU=2/1,1382/350MHz,OC=3F,TA=0/0/0,SP=N/N/N,Mem=1708MHz,Free=3610MB,PLS=0,Temp=36.0C/0.0C,TW=3.00ms,App=2.21ms,GD=0.71ms,CPU&GPU=5.06ms,LCnt=9(DR0,LM2),GPU%=0.56,CPU%=0.16(W0.26),DSF=1.00,CFL=11.12/16.02,ICFLp95=14.71,LD=0,SF=1.00,LP=0,DVFS=0
31775-32058 VrApi                    I  FPS=91/90,Prd=25ms,Tear=0,Early=0,Stale=0,Stale2/5/10/max=0/0/0/0,VSnc=1,Lat=-1,Fov=0,CPU4/GPU=2/1,1382/350MHz,OC=3F,TA=0/0/0,SP=N/N/N,Mem=1708MHz,Free=3610MB,PLS=0,Temp=36.0C/0.0C,TW=2.66ms,App=1.62ms,GD=0.70ms,CPU&GPU=6.07ms,LCnt=9(DR0,LM2),GPU%=0.51,CPU%=0.08(W0.15),DSF=1.00,CFL=11.18/16.30,ICFLp95=15.16,LD=0,SF=1.00,LP=0,DVFS=0
31775-31775 mozac-fxawebchannel      D  Processing WebChannel command: LOGIN
31775-31979 FirefoxAccount           I  Executing: setUserData
31775-31979 fxa_client               D  set_user_data
31775-31979 fxa_client               D  to_json
31775-31979 WrappingPe...ceCallback  D  Logging state to mozilla.components.service.fxa.StorageWrapper$PersistenceCallback@9b06b53
31775-31979 FxaStatePe...ceCallback  D  Persisting account state into mozilla.components.service.fxa.SharedPrefAccountStorage@6032c90
31775-31979 FirefoxAccount           I  Successfully executed: setUserData
31775-31801 GeckoIdleService         D  Get idle time: time since reset 32 msec
31775-31801 GeckoIdleService         D  Idle timer callback: current idle time 32 msec
31775-31801 GeckoIdleService         D  next timeout 4967 msec from now
31775-31801 GeckoIdleService         D  SetTimerExpiryIfBefore: next timeout 4967 msec from now
31775-31801 GeckoIdleService         D  reset timer expiry to 4977 msec from now
31775-32058 VrApi                    I  FPS=90/90,Prd=25ms,Tear=0,Early=0,Stale=0,Stale2/5/10/max=0/0/0/0,VSnc=1,Lat=-1,Fov=0,CPU4/GPU=2/1,1382/350MHz,OC=3F,TA=0/0/0,SP=N/N/N,Mem=1708MHz,Free=3610MB,PLS=0,Temp=36.0C/0.0C,TW=2.44ms,App=1.77ms,GD=0.70ms,CPU&GPU=4.73ms,LCnt=8(DR0,LM2),GPU%=0.47,CPU%=0.28(W0.36),DSF=1.00,CFL=11.02/16.06,ICFLp95=14.87,LD=0,SF=1.00,LP=0,DVFS=0
31775-31775 mozac-fxawebchannel      D  Processing WebChannel command: OAUTH_LOGIN
31775-31979 fxa_client               D  handle_public_event
31775-31979 FirefoxAcc...ateMachine  I  Processing event 'AuthData(authData=authType: mozilla.components.concept.sync.AuthType$Signin@2aa3066, code: XXX, state: XXX, declinedEngines: null)' for state Idle(accountState=Authenticating(oAuthUrl=https://accounts.firefox.com/authorization?action=email&response_type=code&entrypoint=&client_id=a2270f727f45f648&scope=profile+https%3A%2F%2Fidentity.mozilla.com%2Fapps%2Foldsync&state=ookwAdb6du6EMhIYcvc_0g&code_challenge_method=S256&code_challenge=_YX-wjrVaSSJMUV1u4634VZIp5dbQxv_RZDmdLbwWwM&access_type=offline&keys_jwk=eyJrdHkiOiJFQyIsImNydiI6IlAtMjU2IiwieCI6IllsZWJGek1MY29qQjI5cmcwM2pKVGt0WlBhSE9xbS0tTW1XaEJjMm1fT3ciLCJ5IjoiMG1ySGNXdFdVdERpODJ2SUNqdVV0LVR5eTJpdGhjdUJPSzIyOHFYN1BHNCJ9&context=oauth_webchannel_v1)). Next state is Active(progressState=CompletingAuthentication)
31775-31979 fxa_client               D  check_internal_state
31775-31979 FirefoxAcc...ateMachine  I  withRetries: attempt 1/3
31775-31804 FirefoxAccount           I  Executing: complete oauth flow
31775-31804 fxa_client               D  complete_oauth_flow
31775-31822 Deque                    I  AddEventToQueue called. eventInfo.type: 52, eventInfo.next: 1
31775-32110 places                   D  apply_observation
31775-32110 sql_support::conn_ext    D  Transaction commited after 7.124011ms
31775-32110 places                   D  apply_observation
31775-32110 sql_support::conn_ext    D  Transaction commited after 2.601147ms
31775-31888 places                   D  get_visit_infos
31775-31875 places                   D  bookmarks_get_all_with_url
31775-31882 places                   D  get_visit_infos
31775-32058 VrApi                    I  FPS=91/90,Prd=24ms,Tear=0,Early=0,Stale=0,Stale2/5/10/max=0/0/0/0,VSnc=1,Lat=-1,Fov=0,CPU4/GPU=2/1,1382/350MHz,OC=3F,TA=0/0/0,SP=N/N/N,Mem=3196MHz,Free=3610MB,PLS=0,Temp=36.0C/0.0C,TW=2.61ms,App=2.42ms,GD=0.71ms,CPU&GPU=4.72ms,LCnt=8(DR0,LM2),GPU%=0.52,CPU%=0.11(W0.18),DSF=1.00,CFL=10.98/15.95,ICFLp95=14.42,LD=0,SF=1.00,LP=0,DVFS=0
31775-31775 mozac-fxawebchannel      D  Processing WebChannel command: FXA_STATUS
31775-32477 places                   D  bookmarks_get_all_with_url
31775-31882 places                   D  bookmarks_get_all_with_url
31775-32110 places                   D  apply_observation
31775-32110 sql_support::conn_ext    D  Transaction commited after 6.683646ms
31775-31882 places                   D  get_visit_infos
31775-32110 places                   D  apply_observation
31775-31804 fxa_client               D  to_json
31775-31804 WrappingPe...ceCallback  D  Logging state to mozilla.components.service.fxa.StorageWrapper$PersistenceCallback@9b06b53
31775-32110 sql_support::conn_ext    D  Transaction commited after 3.811303ms
31775-31804 FxaStatePe...ceCallback  D  Persisting account state into mozilla.components.service.fxa.SharedPrefAccountStorage@c687340
31775-31804 FirefoxAccount           I  Successfully executed: complete oauth flow
31775-31979 fxa_client               D  handle_internal_event
31775-31979 FirefoxAcc...ateMachine  I  withServiceRetries: attempt 1/3
31775-31804 fxa_client               D  check_internal_state
31775-31804 fxa_client               D  initialize_device
31775-32478 places                   D  get_visit_infos
31775-32110 places                   D  apply_observation
31775-32110 sql_support::conn_ext    D  Transaction commited after 3.714792ms
31775-32478 places                   D  get_visit_infos
31775-31804 fxa_client               D  to_json
31775-31804 WrappingPe...ceCallback  D  Logging state to mozilla.components.service.fxa.StorageWrapper$PersistenceCallback@9b06b53
31775-31804 FxaStatePe...ceCallback  D  Persisting account state into mozilla.components.service.fxa.SharedPrefAccountStorage@fcb657a
31775-31804 fxa_client               D  handle_internal_event
31775-31979 FirefoxAcc...ateMachine  I  Ran 'AuthData(authData=authType: mozilla.components.concept.sync.AuthType$Signin@2aa3066, code: XXX, state: XXX, declinedEngines: null)' side-effects for state Active(progressState=CompletingAuthentication), got successive event CompletedAuthentication(authType=mozilla.components.concept.sync.AuthType$Signin@2aa3066)
31775-31979 fxa_client               D  check_public_state
31775-31979 FirefoxAcc...ateMachine  I  Processing event 'CompletedAuthentication(authType=mozilla.components.concept.sync.AuthType$Signin@2aa3066)' for state Active(progressState=CompletingAuthentication). Next state is Idle(accountState=mozilla.components.service.fxa.manager.AccountState$Authenticated@8e1912b)
31775-31804 FirefoxAccount           I  Executing: get access token
31775-31804 fxa_client               D  get_access_token
31775-31804 fxa_client               D  to_json
31775-31804 WrappingPe...ceCallback  D  Logging state to mozilla.components.service.fxa.StorageWrapper$PersistenceCallback@9b06b53
31775-31804 FxaStatePe...ceCallback  D  Persisting account state into mozilla.components.service.fxa.SharedPrefAccountStorage@71a5f46
31775-31804 FirefoxAccount           I  Successfully executed: get access token
31775-31804 FirefoxAccount           I  Executing: getTokenServerEndpointURL
31775-31804 fxa_client               D  get_token_server_endpoint_url
31775-31804 FirefoxAccount           I  Successfully executed: getTokenServerEndpointURL
31775-31979 fxa_client               D  get_current_device_id
31775-31979 BgSyncManager            D  Enabling...
31775-31979 WMSyncDispatcher         D  Cancelling periodic syncing
31775-31979 WMSyncDispatcher         D  Starting periodic syncing, period = 1440, time unit = MINUTES
31775-31979 BgSyncManager            D  set and initialized new dispatcher: mozilla.components.service.fxa.sync.WorkManagerSyncDispatcher@288212a
31775-31979 WMSyncDispatcher         D  Immediate sync requested, reason = mozilla.components.service.fxa.sync.SyncReason$FirstSync@e8d1b1b, debounce = false
31775-31804 FxaDeviceConstellation   I  Executing: changing device name
31775-31804 fxa_client               D  set_device_name
31775-32478 SyncWorker               D  Starting sync... Tagged as: [Immediate, mozilla.components.service.fxa.sync.WorkManagerSyncWorker, Common]
31775-32478 places                   D  register_with_sync_manager
31775-32478 places                   D  register_with_sync_manager
31775-32478 logins                   D  register_with_sync_manager
31775-32478 logins                   D  check_canary
31775-32478 sync_manager             D  new
31775-32478 sync_manager             D  sync
31775-32478 sync_manager::manager    I  breadcrumb: SyncManager::sync started
31775-32478 sql_suppor...n_database  D  places: opening database
31775-32478 sql_suppor...n_database  D  places: checking if initialization is necessary
31775-32478 sql_suppor...n_database  D  places: preparing
31775-32478 sql_suppor...n_database  D  places: finishing writable database open
31775-32478 sql_suppor...n_database  D  places: database open successful
31775-32478 sync_manager::manager    I  breadcrumb: Checking engines requested (Some { engines: ["history", "bookmarks", "passwords"] }) vs local engines (["passwords", "bookmarks", "history"])
31775-32478 sync_manager::manager    D  Not under backoff
31775-32478 sync_manager::manager    I  No backoff in effect (or we decided to ignore it), starting sync
31775-32478 sync15::cl...c_multiple  I  Syncing 3 engines
31775-32478 sync15::cl...c_multiple  I  Loading/initializing persisted state
31775-32478 sync15::cl...c_multiple  I  The application didn't give us persisted state - this is only expected on the very first run for a given user.
31775-32478 sync15::cl...c_multiple  I  Preparing client info
31775-32478 sync15::cl...c_multiple  D  mem_cached_state was stale or missing, need setup
31775-32478 sync15::cl...c_multiple  I  Entering sync state machine
31775-32478 sync15::cl...c_multiple  I  Advancing state machine to ready (full)
31775-32478 sync15::client::token    D  Fetching token from https://token.services.mozilla.com/1.0/sync/1.5
31775-32058 VrApi                    I  FPS=90/90,Prd=24ms,Tear=0,Early=0,Stale=1,Stale2/5/10/max=0/0/0/1,VSnc=1,Lat=-1,Fov=0,CPU4/GPU=2/1,1382/350MHz,OC=3F,TA=0/0/0,SP=N/N/N,Mem=1708MHz,Free=3610MB,PLS=0,Temp=36.0C/0.0C,TW=2.60ms,App=1.94ms,GD=0.70ms,CPU&GPU=4.82ms,LCnt=7(DR0,LM2),GPU%=0.51,CPU%=0.71(W0.82),DSF=1.00,CFL=11.20/15.85,ICFLp95=14.56,LD=0,SF=1.00,LP=0,DVFS=0
31775-31785 System                   W  A resource failed to call close. 
31775-31804 fxa_client               D  to_json
31775-31804 WrappingPe...ceCallback  D  Logging state to mozilla.components.service.fxa.StorageWrapper$PersistenceCallback@9b06b53
31775-31804 FxaStatePe...ceCallback  D  Persisting account state into mozilla.components.service.fxa.SharedPrefAccountStorage@a413d7
31775-31804 FxaDeviceConstellation   I  Successfully executed: changing device name
31775-31804 FxaDeviceConstellation   I  Refreshing device list...
31775-31804 FxaDeviceConstellation   I  Executing: fetching all devices
31775-31804 fxa_client               D  get_devices
31775-31804 fxa_client...ttp_client  I  breadcrumb: get_devices timestamp: 1735255735115, refresh len: 64
31775-31804 FxaDeviceConstellation   I  Successfully executed: fetching all devices
31775-31804 FxaDeviceConstellation   I  Current device needs push endpoint registration, so checking for missed commands
31775-31804 FxaDeviceConstellation   I  Executing: polling for device commands
31775-31804 fxa_client               D  poll_device_commands
31775-32478 sync15::cl...age_client  I  Successful request to "/1.5/204614797/info/configuration", incoming x-last-modified=ServerTimestamp(0)
31775-31804 fxa_client               D  to_json
31775-31804 WrappingPe...ceCallback  D  Logging state to mozilla.components.service.fxa.StorageWrapper$PersistenceCallback@9b06b53
31775-31804 FxaStatePe...ceCallback  D  Persisting account state into mozilla.components.service.fxa.SharedPrefAccountStorage@927a6cf
31775-31804 FxaDeviceConstellation   I  Successfully executed: polling for device commands
31775-31804 AccountEve...ntegration  I  Received events, notifying listeners
31775-31775 DeviceEventsObserver     I  Received 0 device event(s)
31775-31804 fxa_client               D  gather_telemetry
31775-31804 FxaDeviceConstellation   I  Refreshed device list; saw 2 device(s).
31775-31775 FxaDeviceConstellation   D  registering device observer
31775-31804 FirefoxAccount           I  Executing: getProfile
31775-31979 WMSyncDispatcher         D  Immediate sync requested, reason = mozilla.components.service.fxa.sync.SyncReason$EngineChange@1a01c3a, debounce = true
31775-31804 fxa_client               D  get_profile
31775-31882 places                   D  bookmarks_get_all_with_url
31775-31775 fxa_client               D  get_connection_success_url
31775-32058 VrApi                    I  FPS=90/90,Prd=24ms,Tear=0,Early=0,Stale=0,Stale2/5/10/max=0/0/0/0,VSnc=1,Lat=-1,Fov=0,CPU4/GPU=2/1,1382/350MHz,OC=3F,TA=0/0/0,SP=N/N/N,Mem=3196MHz,Free=3610MB,PLS=0,Temp=36.0C/0.0C,TW=2.74ms,App=2.12ms,GD=0.71ms,CPU&GPU=3.64ms,LCnt=7(DR0,LM2),GPU%=0.52,CPU%=0.30(W0.40),DSF=1.00,CFL=11.16/15.76,ICFLp95=14.51,LD=0,SF=1.00,LP=0,DVFS=0
31775-32058 VrApi                    I  FPS=90/90,Prd=24ms,Tear=0,Early=0,Stale=0,Stale2/5/10/max=0/0/0/0,VSnc=1,Lat=-1,Fov=0,CPU4/GPU=2/1,1382/350MHz,OC=3F,TA=0/0/0,SP=N/N/N,Mem=1555MHz,Free=3610MB,PLS=0,Temp=36.0C/0.0C,TW=2.27ms,App=1.64ms,GD=0.71ms,CPU&GPU=3.16ms,LCnt=6(DR0,LM2),GPU%=0.46,CPU%=0.05(W0.11),DSF=1.00,CFL=11.06/15.92,ICFLp95=14.51,LD=0,SF=1.00,LP=0,DVFS=0
@javifernandez
Copy link
Member Author

This is the error page shown after login.

Image

@javifernandez javifernandez added the bug Something isn't working label Jan 17, 2025
@svillar
Copy link
Member

svillar commented Jan 20, 2025

I think there is no point in having this and #1692 as they're the same. The error page is shown because the process crashed

@svillar svillar closed this as completed Jan 20, 2025
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
bug Something isn't working
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@svillar @javifernandez