Discuss
Hi
Since last upgade it seems Firefox syncserver isnt working well. _heartbeat_ page is showing that the server is running well. but i got logs of error from about:sync-log
i reinstalled that just in case but i still hit that line:
Sync.ErrorHandler ERROR Sync encountered a login error
i followed the after-installation notes :
logout from firefox sync
change URI in about:config, restart
login again.
if anyone has pointers
after the 0.21.0 update i hit few
Sync.ErrorHandler ERROR Sync encountered a login error
1757674003051 Sync.SyncScheduler DEBUG Clearing sync triggers and the global score.
1757674003051 Sync.SyncScheduler DEBUG Next sync in 3600000 ms. (why=schedule)
1757674003052 Sync.Service DEBUG Exception calling WrappedLock: Error: Login failed: success.status_ok(resource://services-sync/service.sys.mjs:1051:15) JS Stack trace: onNotify@service.sys.mjs:1051:15
1757674003052 Sync.Service DEBUG Not syncing: login returned false.
1757674003052 FirefoxAccounts TRACE not checking freshness of profile as it remains recent
orhtej2
September 13, 2025, 10:25am
3
Reported tracking 0.21.0 possibly broke login · Issue #100 · YunoHost-Apps/syncserver-rs_ynh · GitHub , Ill have a look soon .
in the meanwhile you can restore pre-upgrade backup to go back to known good version perhaps?
orhtej2
September 14, 2025, 10:27pm
4
(progress update)
I’ve pinpointed the issue to difference between MySQL vs MariaDB, looking for solution…
wasnt able to restore to a working version since i reinstalled syncserver-rs, but i can wait -and upgrade until it works again also thanks for taking time to lookâ„¢
orhtej2
September 16, 2025, 8:36pm
6
Fix will be landing on testing soon , it’s available here and it worked for me exactly once
orhtej2
September 16, 2025, 9:22pm
7
Aaaand I accidentally released it as 0.21.0~ynh2
Fingers crossed it works as expected
maybe i’m doing something wrong?
1758071889199 Sync.Status INFO Resetting Status.
1758071889199 Sync.Status DEBUG Status.service: undefined => success.status_ok
1758071889202 FirefoxAccounts TRACE initializing new storage manager
1758071889202 FirefoxAccounts TRACE starting fetch of json user data
1758071889203 Sync.RemoteTabs INFO Doing a tab sync.
1758071889211 Sync.SyncScheduler TRACE Setting SyncScheduler policy values to defaults.
1758071889211 Sync.SyncScheduler DEBUG Clearing sync triggers and the global score.
1758071889212 Sync.Service INFO Loading Weave 1.144.0
1758071889213 Sync.Engine.Clients DEBUG Engine constructed
1758071889215 Sync.Engine.Clients DEBUG Resetting clients last sync time
1758071889215 Sync.Service DEBUG User-Agent: Firefox/142.0.1 (Linux x86_64) FxSync/1.144.0.20250827004350.desktop
1758071889215 Sync.RemoteTabs DEBUG Initializing TabListComponent
1758071889216 Sync.RemoteTabs INFO Generating tab list with filter:
1758071889216 Sync.RemoteTabs DEBUG Sync isn't yet ready, so returning an empty tab list
1758071889230 Sync.Engine.Addons DEBUG Engine constructed
1758071889267 FirefoxAccounts TRACE finished fetch of json user data - took: 65
1758071889267 FirefoxAccounts DEBUG reading secure storage with existing: []
1758071889267 FirefoxAccounts TRACE starting fetch of user data from the login manager
1758071889307 FirefoxAccounts DEBUG secure read fetched items: ["scopedKeys"]
1758071889307 FirefoxAccounts TRACE initializing of new storage manager done
1758071889316 Sync.Engine.Addons DEBUG SyncEngine initialized: addons
1758071889350 Sync.Engine.Passwords DEBUG Engine constructed
1758071889368 Sync.Engine.Passwords DEBUG SyncEngine initialized: passwords
1758071889369 Sync.Engine.Prefs DEBUG Engine constructed
1758071889376 Sync.Engine.Prefs DEBUG SyncEngine initialized: prefs
1758071889378 Sync.Engine.Bookmarks DEBUG Engine constructed
1758071889389 Sync.Engine.Bookmarks DEBUG SyncEngine initialized: bookmarks
1758071889392 Sync.Engine.Forms DEBUG Engine constructed
1758071889400 Sync.Engine.Forms DEBUG SyncEngine initialized: forms
1758071889401 Sync.Engine.History DEBUG Engine constructed
1758071889406 Sync.Engine.History DEBUG SyncEngine initialized: history
1758071889409 Sync.Engine.Tabs DEBUG Engine constructed
1758071889417 Sync.Engine.Tabs DEBUG SyncEngine initialized: tabs
1758071889428 Sync.Engine.Tabs INFO Got a bridged engine!
1758071889429 Sync.Engine.Addresses DEBUG Engine constructed
1758071889443 Sync.Engine.Addresses DEBUG SyncEngine initialized: addresses
1758071889444 Sync.Engine.CreditCards DEBUG Engine constructed
1758071889459 Sync.Engine.CreditCards DEBUG SyncEngine initialized: creditcards
1758071889461 Sync.Engine.Extension-Storage DEBUG Engine constructed
1758071889472 Sync.Engine.Extension-Storage DEBUG SyncEngine initialized: extension-storage
1758071889479 Sync.Engine.Extension-Storage INFO Got a bridged engine!
1758071889479 Sync.Service INFO Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0
1758071889479 Sync.AddonsReconciler INFO Registering as Add-on Manager listener.
1758071889479 Sync.AddonsReconciler DEBUG Adding change listener.
1758071889480 Sync.Engine.History.Tracker INFO Adding Places observer.
1758071889480 Sync.Service INFO Starting sync at 2025-09-17 03:18:09 in browser session P9bPW2GK0q7x
1758071889480 Sync.Service DEBUG In sync: should login.
1758071889480 Sync.Service INFO User logged in successfully - verifying login.
1758071889481 FirefoxAccounts DEBUG FxAccountsProfileClient: Initialized
1758071889482 FirefoxAccounts DEBUG FxAccountsProfileClient: Requested profile
1758071889482 FirefoxAccounts DEBUG getOAuthToken enter
1758071889482 FirefoxAccounts TRACE getCachedToken returning cached token
1758071889482 FirefoxAccounts DEBUG getOAuthToken returning a cached token
1758071889482 Sync.SyncAuthManager DEBUG unlockAndVerifyAuthState already has (or can fetch) sync keys
1758071889482 Services.Common.RESTRequest DEBUG GET request to https://profile.accounts.firefox.com/v1/profile
1758071889483 Sync.Status DEBUG Status.login: success.login => success.status_ok
1758071889483 Sync.Status DEBUG Status.service: success.status_ok => error.login.failed
1758071889483 Sync.Service DEBUG Fetching unlocked auth state returned success.status_ok
1758071889483 Sync.SyncAuthManager INFO Getting sync key
1758071889483 FirefoxAccounts DEBUG getOAuthToken enter
1758071889483 FirefoxAccounts TRACE getCachedToken returning cached token
1758071889483 FirefoxAccounts DEBUG getOAuthToken returning a cached token
1758071889483 Sync.SyncAuthManager INFO Getting a sync token from: https://[SERVERNAME]/1.0/sync/1.5
1758071889483 Sync.SyncAuthManager DEBUG Getting a token using OAuth
1758071889483 Services.Common.TokenServerClient DEBUG Beginning OAuth token exchange: https://[SERVERNAME]/1.0/sync/1.5
1758071889484 Services.Common.RESTRequest DEBUG GET request to https://[SERVERNAME]/1.0/sync/1.5
1758071889558 FirefoxAccounts DEBUG FxAccountsWebChannel registered: account_updates with origin https://accounts.firefox.com
1758071889706 Services.Common.RESTRequest DEBUG GET https://profile.accounts.firefox.com/v1/profile 304
1758071889772 Services.Common.RESTRequest DEBUG GET https://[SERVERNAME]/1.0/sync/1.5 200
1758071889772 Services.Common.TokenServerClient DEBUG Got token response: 200
1758071889772 Services.Common.TokenServerClient DEBUG Successful token response
1758071889774 Sync.BulkKeyBundle INFO BulkKeyBundle being created for undefined
1758071889774 Sync.Status DEBUG Status.login: success.status_ok => success.login
1758071889774 Sync.Status DEBUG Status.service: error.login.failed => success.status_ok
1758071889775 Sync.SyncAuthManager DEBUG _findCluster returning https://[SERVERNAME]/1.5/4/
1758071889775 Sync.SyncAuthManager DEBUG Cluster value = https://[SERVERNAME]/1.5/4/
1758071889775 Sync.SyncAuthManager DEBUG Setting cluster to https://[SERVERNAME]/1.5/4/
1758071889775 Sync.Service DEBUG Caching URLs under storage user base: https://[SERVERNAME]/1.5/4/
1758071889776 FirefoxAccounts TRACE not checking freshness of profile as it remains recent
1758071889776 FirefoxAccounts TRACE not checking freshness of profile as it remains recent
1758071889778 FirefoxAccounts INFO fetching updated device list
1758071889804 Services.Common.RESTRequest DEBUG GET request to https://api.accounts.firefox.com/v1/account/attached_clients
1758071889807 Services.Common.RESTRequest DEBUG GET request to https://api.accounts.firefox.com/v1/account/devices?filterIdleDevicesTimestamp=1756257489779
1758071889832 Sync.Resource DEBUG GET success 200 https://[SERVERNAME]/1.5/4/info/collections
1758071889832 Sync.Service DEBUG Fetching server configuration: https://[SERVERNAME]/1.5/4/info/configuration
1758071889832 FirefoxAccounts TRACE not checking freshness of profile as it remains recent
1758071889844 Sync.Resource DEBUG GET success 200 https://[SERVERNAME]/1.5/4/info/configuration
1758071889844 Sync.Service DEBUG Fetching global metadata record
1758071889845 FirefoxAccounts TRACE not checking freshness of profile as it remains recent
1758071889850 Sync.Service DEBUG User-Agent: Firefox/142.0.1 (Linux x86_64) FxSync/1.144.0.20250827004350.desktop
1758071889850 Sync.Service INFO Starting sync at 2025-09-17 03:18:09 in browser session P9bPW2GK0q7x
1758071889850 Sync.Service DEBUG In sync: should login.
1758071889850 Sync.Service DEBUG Exception calling WrappedLock: LockException: Could not acquire lock. Label: "service.js: login".(resource://services-sync/util.sys.mjs:43:5) JS Stack trace: LockException@util.sys.mjs:43:5
throwLockException@util.sys.mjs:127:11
WrappedLock@util.sys.mjs:141:15
WrappedCatch@util.sys.mjs:112:27
login@service.sys.mjs:1062:66
sync/<@service.sys.mjs:1349:26
WrappedCatch@util.sys.mjs:112:27
sync@service.sys.mjs:1357:7
1758071889851 Sync.Service INFO Cannot start sync: already syncing?
1758071889851 Sync.Service DEBUG Not syncing: login returned false.
1758071889866 Sync.Resource DEBUG GET fail 500 https://[SERVERNAME]/1.5/4/storage/meta/global
1758071889866 Sync.Resource WARN GET request to https://[SERVERNAME]/1.5/4/storage/meta/global failed with status 500
1758071889866 Sync.Service DEBUG Weave Version: 1.144.0 Local Storage: 5 Remote Storage:
1758071889866 Sync.Service INFO One of: no meta, no meta storageVersion, or no meta syncID. Fresh start needed.
1758071889866 Sync.Status DEBUG Status.sync: success.sync => error.sync.reason.metarecord_download_fail
1758071889866 Sync.Status DEBUG Status.service: success.status_ok => error.sync.failed
1758071889866 Sync.Service WARN Unknown error while downloading metadata record. Aborting sync.
1758071889866 Sync.Service WARN Remote setup failed.
1758071889866 Sync.ErrorHandler ERROR Sync encountered a login error
1758071889866 Sync.SyncScheduler DEBUG Clearing sync triggers and the global score.
1758071889867 Sync.SyncScheduler DEBUG Next sync in 3600000 ms. (why=schedule)
1758071889867 Sync.Service DEBUG Exception calling WrappedLock: Error: Login failed: success.login(resource://services-sync/service.sys.mjs:1051:15) JS Stack trace: onNotify@service.sys.mjs:1051:15
1758071889867 Sync.Service DEBUG Not syncing: login returned false.
1758071889868 FirefoxAccounts TRACE not checking freshness of profile as it remains recent
1758071889869 FirefoxAccounts INFO Already fetching device list, return existing promise
1758071889878 Services.Common.RESTRequest DEBUG GET request to https://api.accounts.firefox.com/v1/account/attached_clients
1758071889900 FirefoxAccounts TRACE not checking freshness of profile as it remains recent
1758071889945 FirefoxAccounts TRACE not checking freshness of profile as it remains recent
1758071889947 FirefoxAccounts INFO Already fetching device list, return existing promise
1758071889963 Services.Common.RESTRequest DEBUG GET request to https://api.accounts.firefox.com/v1/account/attached_clients
1758071890034 Services.Common.RESTRequest DEBUG GET https://api.accounts.firefox.com/v1/account/devices?filterIdleDevicesTimestamp=1756257489779 200
1758071890034 Hawk DEBUG (Response) /account/devices?filterIdleDevicesTimestamp=1756257489779: code: 200 - Status text:
1758071890034 Hawk DEBUG Clock offset vs https://api.accounts.firefox.com/v1: -34
1758071890035 FirefoxAccounts INFO Got new device list: 2d5f56094413a31fc7a91a23c5e5ee12, 4158c839a5b6e7d5e7c086499e1a2789, 73cd90d6d2e90da706781002089c9790, 8b18f2f245b265f5504a470b123407ea, 9fbb591d821311352257801770c05871
1758071890040 FirefoxAccounts DEBUG FxAccountsPush loading service
1758071890045 FirefoxAccounts DEBUG FxAccountsPush initialized
1758071890047 Services.Common.RESTRequest DEBUG GET https://api.accounts.firefox.com/v1/account/attached_clients 200
1758071890047 Hawk DEBUG (Response) /account/attached_clients: code: 200 - Status text:
1758071890047 Hawk DEBUG Clock offset vs https://api.accounts.firefox.com/v1: -47
1758071890071 FirefoxAccounts TRACE Command queue observer created
1758071890072 FirefoxAccounts TRACE Getting command keys: https://identity.mozilla.com/cmd/open-uri
1758071890072 FirefoxAccounts TRACE Getting command keys: https://identity.mozilla.com/cmd/close-uri/v1
1758071890072 FirefoxAccounts TRACE Our push subscription looks OK
1758071890072 FirefoxAccounts INFO updating the cache
1758071890082 Services.Common.RESTRequest DEBUG GET https://api.accounts.firefox.com/v1/account/attached_clients 200
1758071890082 Hawk DEBUG (Response) /account/attached_clients: code: 200 - Status text:
1758071890082 Hawk DEBUG Clock offset vs https://api.accounts.firefox.com/v1: -82
1758071890135 Services.Common.RESTRequest DEBUG GET https://api.accounts.firefox.com/v1/account/attached_clients 200
1758071890136 Hawk DEBUG (Response) /account/attached_clients: code: 200 - Status text:
1758071890136 Hawk DEBUG Clock offset vs https://api.accounts.firefox.com/v1: -136
sorry for pasting raw log, its from about:sync-log and link txt files isn’t allowed
orhtej2
September 17, 2025, 8:08pm
9
Are you running 0.21.0~ynh2?
Could you post logs from the server? Should be under webadmin->tools->services->syncserver
i do!
here ya go
more info that might matter: have 3 devices using that sync tool, a windows pc (using nightly branch of firefox), a linux laptop and an android phone.
orhtej2
September 18, 2025, 2:08pm
11
OK, so I screwed up 0.21.0~ynh2 (it was working for me because I built it manually and thought I’m releasing the same thing).
I’ve released 0.21.0~ynh3 with actual fix and fixed upgrade script for (semi-)unrelated issue.
okey, no worries, lets try that.
EDIT: It works! Thank you for looking and fixing it!