Hello everyone,
I want to set up my sync server. I’ve tried it for many hours and have reached the point now where the internet does not help any further.
The problem seems to be during authentification.
Here is my FireFox error log file:
1557065031868 Sync.LogManager DEBUG Flushing file log
1557065031868 FirefoxAccounts DEBUG FxAccountsProfileClient: Requested profile
1557065031868 FirefoxAccounts DEBUG getOAuthToken enter
1557065031870 FirefoxAccounts TRACE getCachedToken returning cached token
1557065031870 FirefoxAccounts DEBUG getOAuthToken returning a cached token
1557065031870 Services.Common.RESTRequest DEBUG GET request to https://profile.accounts.firefox.com/v1/profile
1557065031870 Services.Common.RESTRequest TRACE HTTP Header authorization: ***** (suppressed)
1557065031870 Services.Common.RESTRequest TRACE HTTP Header accept: application/json
1557065031870 Services.Common.RESTRequest TRACE HTTP Header if-none-match: "194fc23c7410ff004616a5649eeebd8c56279217-gzip"
1557065031878 Sync.LogManager DEBUG Log cleanup threshold time: 1556201031878
1557065031908 Sync.LogManager DEBUG Done deleting files.
1557065032519 Services.Common.RESTRequest TRACE onStartRequest: GET https://profile.accounts.firefox.com/v1/profile
1557065032520 Services.Common.RESTRequest TRACE Channel for GET https://profile.accounts.firefox.com/v1/profile returned status code 0
1557065032520 Services.Common.RESTRequest DEBUG GET https://profile.accounts.firefox.com/v1/profile 304
1557065144861 FirefoxAccounts INFO Consuming missed commands.
1557065144861 Sync.Service DEBUG User-Agent: Firefox/66.0.3 (Linux x86_64) FxSync/1.68.0.20190410203753.desktop
1557065144861 Sync.Service INFO Starting sync at 2019-05-05 16:05:44 in browser session yDJFrG13gXJo
1557065144861 Sync.Service DEBUG In sync: should login.
1557065144863 Sync.Service INFO User logged in successfully - verifying login.
1557065144865 Sync.BrowserIDManager DEBUG unlockAndVerifyAuthState already has (or can fetch) sync keys
1557065144865 Sync.Status DEBUG Status.login: error.login.reason.network => success.status_ok
1557065144865 Sync.Status DEBUG Status.service: error.login.failed => error.login.failed
1557065144865 Sync.Service DEBUG Fetching unlocked auth state returned success.status_ok
1557065144866 Sync.BrowserIDManager INFO Getting keys
1557065144866 Sync.BrowserIDManager INFO Getting an assertion from: https://ffsync.askarus.de:5000/token/1.0/sync/1.5
1557065144866 FirefoxAccounts DEBUG enter getAssertion()
1557065144866 FirefoxAccounts DEBUG getKeypairAndCertificate: already have keyPair and certificate
1557065144867 FirefoxAccounts DEBUG getAssertionFromCert
1557065144867 Services.Common.RESTRequest TRACE local time, offset: 1557065144867, -261
1557065144867 FirefoxAccounts DEBUG getAssertionFromCert returning signed: true
1557065144868 Sync.BrowserIDManager DEBUG Getting a token
1557065144868 Services.Common.TokenServerClient DEBUG Beginning BID assertion exchange: https://ffsync.askarus.de:5000/token/1.0/sync/1.5
1557065144868 Services.Common.RESTRequest DEBUG GET request to https://ffsync.askarus.de:5000/token/1.0/sync/1.5
1557065144868 Services.Common.RESTRequest TRACE HTTP Header accept: application/json
1557065144868 Services.Common.RESTRequest TRACE HTTP Header authorization: ***** (suppressed)
1557065144868 Services.Common.RESTRequest TRACE HTTP Header x-client-state: ***** (suppressed)
1557065144872 Services.Common.RESTRequest DEBUG GET request to https://api.accounts.firefox.com/v1/account/device/commands?index=0
1557065144872 Services.Common.RESTRequest TRACE HTTP Header authorization: ***** (suppressed)
1557065144872 Services.Common.RESTRequest TRACE HTTP Header content-type: text/plain
1557065144872 Services.Common.RESTRequest TRACE HTTP Header accept-language: en-US, en
1557065145530 Services.Common.RESTRequest TRACE onStartRequest: GET https://api.accounts.firefox.com/v1/account/device/commands?index=0
1557065145531 Services.Common.RESTRequest TRACE Channel for GET https://api.accounts.firefox.com/v1/account/device/commands?index=0 returned status code 0
1557065145531 Services.Common.RESTRequest DEBUG GET https://api.accounts.firefox.com/v1/account/device/commands?index=0 200
1557065145531 Hawk DEBUG (Response) /account/device/commands?index=0: code: 200 - Status text: OK
1557065145531 Services.Common.RESTResponse TRACE Processing response headers.
1557065145531 Hawk DEBUG Clock offset vs https://api.accounts.firefox.com/v1: -531
1557065145532 FirefoxAccounts DEBUG _updateAccountData with items: ["device"]
1557065145532 FirefoxAccounts DEBUG writing plain storage: ["email","sessionToken","uid","verified","device","oauthTokens","profileCache"]
1557065145532 FirefoxAccounts TRACE starting write of json user data: ["email","sessionToken","uid","verified","device","oauthTokens","profileCache"]
1557065145534 FirefoxAccounts TRACE finished write of json user data - took: 2
1557065145535 FirefoxAccounts DEBUG writing secure storage: ["kSync","kXCS","kExtSync","kExtKbHash"]
1557065145535 FirefoxAccounts TRACE starting write of user data to the login manager
1557065145541 FirefoxAccounts TRACE finished write of user data to the login manager
1557065175505 Services.Common.RESTRequest TRACE onStartRequest: GET https://ffsync.askarus.de:5000/token/1.0/sync/1.5
1557065175505 Services.Common.RESTRequest TRACE Channel for GET https://ffsync.askarus.de:5000/token/1.0/sync/1.5 returned status code 2152398919
1557065175506 Services.Common.RESTRequest DEBUG GET https://ffsync.askarus.de:5000/token/1.0/sync/1.5 failed: 2152398919 - NS_ERROR_NET_INTERRUPT
1557065175506 Services.Common.RESTRequest TRACE GET body:
1557065175506 Sync.BrowserIDManager ERROR Non-authentication error in _fetchTokenForUser: TokenServerClientNetworkError({"error":{}})(resource://services-common/tokenserverclient.js:36:36) JS Stack trace: TokenServerClientNetworkError@tokenserverclient.js:59:16
getTokenFromBrowserIDAssertion@tokenserverclient.js:245:13
1557065175507 Sync.Status DEBUG Status.login: success.status_ok => error.login.reason.network
1557065175507 Sync.Status DEBUG Status.service: error.login.failed => error.login.failed
1557065175507 Sync.BrowserIDManager INFO Failed to fetch the cluster URL: TokenServerClientNetworkError({"error":{}})(resource://services-common/tokenserverclient.js:36:36) JS Stack trace: TokenServerClientNetworkError@tokenserverclient.js:59:16
getTokenFromBrowserIDAssertion@tokenserverclient.js:245:13
1557065175508 Sync.Service DEBUG verifyLogin failed: TokenServerClientNetworkError({"error":{}})(resource://services-common/tokenserverclient.js:36:36) JS Stack trace: TokenServerClientNetworkError@tokenserverclient.js:59:16
getTokenFromBrowserIDAssertion@tokenserverclient.js:245:13
1557065175508 Sync.Status DEBUG Status.login: error.login.reason.network => error.login.reason.network
1557065175508 Sync.Status DEBUG Status.service: error.login.failed => error.login.failed
1557065175508 Sync.ErrorHandler ERROR Sync encountered a login error
1557065175509 Sync.SyncScheduler DEBUG Clearing sync triggers and the global score.
1557065175510 Sync.SyncScheduler DEBUG Next sync in 3600000 ms. (why=schedule)
1557065175513 Sync.Service DEBUG Exception calling WrappedLock: Error: Login failed: error.login.reason.network(resource://services-sync/service.js:872:15) JS Stack trace: onNotify@service.js:872:15
1557065175514 Sync.Service DEBUG Not syncing: login returned false.
That do the following lines mean? Are they ok, or do they indicate an error?
|1557065144865|Sync.Status|DEBUG|Status.login: error.login.reason.network => success.status_ok|
|---|---|---|---|
|1557065144865|Sync.Status|DEBUG|Status.service: error.login.failed => error.login.failed|
And I don’t know what to do to repair the ERROR that occurs later.
Do you have any idea what I shall try next?
Thanks a lot in advance