1723588813573	FirefoxAccounts	TRACE	initializing new storage manager
1723588813573	FirefoxAccounts	TRACE	starting fetch of json user data
1723588813596	FirefoxAccounts	TRACE	initializing of new storage manager done
1723588814174	FirefoxAccounts	DEBUG	FxAccountsWebChannel registered: account_updates with origin https://accounts.firefox.com
1723588855233	Sync.RemoteTabs	DEBUG	Sync isn't yet ready; assuming tab engine is enabled
1723588855256	Sync.Status	INFO	Resetting Status.
1723588855256	Sync.Status	DEBUG	Status.service: undefined => success.status_ok
1723588855256	Sync.SyncScheduler	TRACE	Setting SyncScheduler policy values to defaults.
1723588855256	Sync.SyncScheduler	DEBUG	Clearing sync triggers and the global score.
1723588855257	Sync.Status	DEBUG	Status.login: success.login => error.login.reason.no_username
1723588855257	Sync.Status	DEBUG	Status.service: success.status_ok => service.client_not_configured
1723588855257	Sync.Status	DEBUG	Status.service: service.client_not_configured => service.client_not_configured
1723588855257	Sync.Service	INFO	Loading Weave 1.131.0
1723588855257	Sync.Engine.Clients	DEBUG	Engine constructed
1723588855257	Sync.Engine.Clients	DEBUG	Resetting clients last sync time
1723588855258	Sync.Status	DEBUG	Status.login: error.login.reason.no_username => error.login.reason.no_username
1723588855258	Sync.Status	DEBUG	Status.service: service.client_not_configured => service.client_not_configured
1723588855258	Sync.Status	DEBUG	Status.service: service.client_not_configured => service.client_not_configured
1723588855258	Sync.RemoteTabs	INFO	Sync client is not configured, so not attempting a tab sync
1723588855258	Sync.RemoteTabs	INFO	Generating tab list with filter
1723588855258	Sync.RemoteTabs	DEBUG	Sync isn't yet ready, so returning an empty tab list
1723588855262	Sync.Engine.Addons	DEBUG	Engine constructed
1723588855309	Sync.Engine.Addons	DEBUG	SyncEngine initialized: addons
1723588855310	Sync.AddonsReconciler	DEBUG	No data seen in loaded file: addonsreconciler
1723588855312	Sync.Engine.Passwords	DEBUG	Engine constructed
1723588855315	Sync.Engine.Passwords	DEBUG	SyncEngine initialized: passwords
1723588855317	Sync.Engine.Prefs	DEBUG	Engine constructed
1723588855323	Sync.Engine.Prefs	DEBUG	SyncEngine initialized: prefs
1723588855325	Sync.Engine.Bookmarks	DEBUG	Engine constructed
1723588855325	Sync.Engine.Bookmarks	DEBUG	SyncEngine initialized: bookmarks
1723588855327	Sync.Engine.Forms	DEBUG	Engine constructed
1723588855327	Sync.Engine.Forms	DEBUG	SyncEngine initialized: forms
1723588855329	Sync.Engine.History	DEBUG	Engine constructed
1723588855331	Sync.Engine.History	DEBUG	SyncEngine initialized: history
1723588855337	Sync.Engine.Tabs	DEBUG	Engine constructed
1723588855341	Sync.Engine.Tabs	DEBUG	SyncEngine initialized: tabs
1723588855347	Sync.Engine.Tabs	INFO	Got a bridged engine!
1723588855351	Sync.Engine.Addresses	DEBUG	Engine constructed
1723588855356	Sync.Engine.Addresses	DEBUG	SyncEngine initialized: addresses
1723588855356	Sync.Engine.CreditCards	DEBUG	Engine constructed
1723588855357	Sync.Engine.CreditCards	DEBUG	SyncEngine initialized: creditcards
1723588855359	Sync.Engine.Extension-Storage	DEBUG	Engine constructed
1723588855360	Sync.Engine.Extension-Storage	DEBUG	SyncEngine initialized: extension-storage
1723588855360	Sync.Service	INFO	Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:129.0) Gecko/20100101 Firefox/129.0
1723588855361	Sync.Status	DEBUG	Status.login: error.login.reason.no_username => error.login.reason.no_username
1723588855361	Sync.Status	DEBUG	Status.service: service.client_not_configured => service.client_not_configured
1723588855361	Sync.Status	DEBUG	Status.service: service.client_not_configured => service.client_not_configured
1723588861572	FirefoxAccounts	DEBUG	FxAccountsWebChannel message received: fxaccounts:fxa_status
1723588861572	FirefoxAccounts	DEBUG	fxa_status received
1723588861572	FirefoxAccounts	DEBUG	service: sync
1723588861572	FirefoxAccounts	DEBUG	is private browsing: false
1723588862057	FirefoxAccounts	DEBUG	FxAccountsWebChannel message received: fxaccounts:loaded
1723588862057	FirefoxAccounts	WARN	Unrecognized FxAccountsWebChannel command: fxaccounts:loaded
1723588870948	FirefoxAccounts	DEBUG	FxAccountsWebChannel message received: fxaccounts:can_link_account
1723588870948	FirefoxAccounts	DEBUG	FxAccountsWebChannel response: {"command":"fxaccounts:can_link_account","messageId":"17235888709472","data":{"ok":true}}
1723588873286	FirefoxAccounts	DEBUG	FxAccountsWebChannel message received: fxaccounts:fxa_status
1723588873286	FirefoxAccounts	DEBUG	fxa_status received
1723588873286	FirefoxAccounts	DEBUG	service
1723588873287	FirefoxAccounts	DEBUG	is private browsing: false
1723588873334	FirefoxAccounts	DEBUG	FxAccountsWebChannel message received: fxaccounts:fxa_status
1723588873334	FirefoxAccounts	DEBUG	fxa_status received
1723588873334	FirefoxAccounts	DEBUG	service: sync
1723588873334	FirefoxAccounts	DEBUG	is private browsing: false
1723588873334	FirefoxAccounts	DEBUG	FxAccountsWebChannel message received: fxaccounts:fxa_status
1723588873334	FirefoxAccounts	DEBUG	fxa_status received
1723588873334	FirefoxAccounts	DEBUG	service: sync
1723588873334	FirefoxAccounts	DEBUG	is private browsing: false
1723588873410	FirefoxAccounts	DEBUG	FxAccountsWebChannel message received: fxaccounts:fxa_status
1723588873411	FirefoxAccounts	DEBUG	fxa_status received
1723588873411	FirefoxAccounts	DEBUG	service: sync
1723588873411	FirefoxAccounts	DEBUG	is private browsing: false
1723588906501	FirefoxAccounts	DEBUG	FxAccountsWebChannel message received: fxaccounts:fxa_status
1723588906501	FirefoxAccounts	DEBUG	fxa_status received
1723588906502	FirefoxAccounts	DEBUG	service: sync
1723588906502	FirefoxAccounts	DEBUG	is private browsing: false
1723588907725	FirefoxAccounts	DEBUG	FxAccountsWebChannel message received: fxaccounts:fxa_status
1723588907726	FirefoxAccounts	DEBUG	fxa_status received
1723588907726	FirefoxAccounts	DEBUG	service: sync
1723588907726	FirefoxAccounts	DEBUG	is private browsing: false
1723588907726	FirefoxAccounts	DEBUG	FxAccountsWebChannel message received: fxaccounts:login
1723588907726	FirefoxAccounts	DEBUG	Webchannel is logging a user in.
1723588907727	FirefoxAccounts	DEBUG	setSignedInUser - aborting any existing flows
1723588907727	FirefoxAccounts	DEBUG	removing account data
1723588907727	FirefoxAccounts	TRACE	starting write of json user data: null
1723588907729	FirefoxAccounts	TRACE	finished write of json user data - took: 2
1723588907729	FirefoxAccounts	TRACE	storage set finished clearing account data
1723588907729	FirefoxAccounts	DEBUG	account data reset
1723588907729	FirefoxAccounts	TRACE	StorageManager finalizing
1723588907729	FirefoxAccounts	TRACE	StorageManager finalized
1723588907730	FirefoxAccounts	TRACE	initializing new storage manager
1723588907730	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified"]
1723588907730	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified"]
1723588907730	FirefoxAccounts	TRACE	finished write of json user data - took: 0
1723588907731	FirefoxAccounts	DEBUG	writing secure storage: ["keyFetchToken","unwrapBKey"]
1723588907731	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588907735	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588907735	FirefoxAccounts	TRACE	initializing of new storage manager done
1723588907735	FirefoxAccounts	DEBUG	startVerifiedCheck: false
1723588907735	FirefoxAccounts	DEBUG	whenVerified promise starts polling for verified email
1723588907735	FirefoxAccounts	DEBUG	entering startPollEmailStatus: start
1723588907735	FirefoxAccounts	DEBUG	entering pollEmailStatus: start
1723588907742	FirefoxAccounts	DEBUG	Notifying observers of fxaccounts:onlogin
1723588907742	Sync.SyncAuthManager	DEBUG	observed fxaccounts:onlogin
1723588907742	Sync.SyncAuthManager	INFO	Sync is not configured, so ignoring the notification
1723588907742	FirefoxAccounts	DEBUG	startVerifiedCheck: false
1723588907744	FirefoxAccounts	DEBUG	FxAccountsProfileClient: Initialized
1723588907744	FirefoxAccounts	DEBUG	FxAccountsPush loading service
1723588907744	FirefoxAccounts	DEBUG	FxAccountsPush initialized
1723588907744	FirefoxAccounts	TRACE	FxAccountsPush registerPushEndpoint
1723588907744	FirefoxAccounts	DEBUG	FxAccountsProfileClient: Requested profile
1723588907744	FirefoxAccounts	DEBUG	getOAuthToken enter
1723588907745	FirefoxAccounts	ERROR	FxA rejecting with error UNVERIFIED_ACCOUNT, details: undefined
1723588907745	FirefoxAccounts	ERROR	Background refresh of initial profile failed: Error: UNVERIFIED_ACCOUNT(resource://gre/modules/FxAccounts.sys.mjs:1596:18) JS Stack trace: _error@FxAccounts.sys.mjs:1596:18
withSessionToken@FxAccounts.sys.mjs:817:18
1723588907746	FirefoxAccounts	DEBUG	startVerifiedCheck: false
1723588907746	FirefoxAccounts	DEBUG	FxAccountsProfileClient: Requested profile
1723588907746	FirefoxAccounts	DEBUG	getOAuthToken enter
1723588907746	FirefoxAccounts	ERROR	FxA rejecting with error UNVERIFIED_ACCOUNT, details: undefined
1723588907746	FirefoxAccounts	ERROR	Background refresh of initial profile failed: Error: UNVERIFIED_ACCOUNT(resource://gre/modules/FxAccounts.sys.mjs:1596:18) JS Stack trace: _error@FxAccounts.sys.mjs:1596:18
withSessionToken@FxAccounts.sys.mjs:817:18
1723588907768	FirefoxAccounts	DEBUG	FxAccountsWebChannel message received: fxaccounts:fxa_status
1723588907768	FirefoxAccounts	DEBUG	fxa_status received
1723588907768	FirefoxAccounts	DEBUG	service: sync
1723588907769	FirefoxAccounts	DEBUG	is private browsing: false
1723588907778	Services.Common.RESTRequest	DEBUG	GET request to https://api.accounts.firefox.com/v1/recovery_email/status?reason=start
1723588907918	FirefoxAccounts	DEBUG	FxAccountsPush got subscription
1723588907923	FirefoxAccounts	TRACE	Command queue observer created
1723588907923	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/open-uri
1723588907923	FirefoxAccounts	INFO	Generating and persisting encrypted key (false, false)
1723588907923	FirefoxAccounts	INFO	Can't get keys; user is not verified
1723588907923	FirefoxAccounts	INFO	Can't fetch keys, so unable to determine command keys
1723588907923	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/close-uri/v1
1723588907923	FirefoxAccounts	INFO	Generating and persisting encrypted key (false, false)
1723588907923	FirefoxAccounts	INFO	Can't get keys; user is not verified
1723588907923	FirefoxAccounts	INFO	Can't fetch keys, so unable to determine command keys
1723588907923	FirefoxAccounts	INFO	registering with available commands: []
1723588907923	FirefoxAccounts	DEBUG	registering new device details
1723588907924	Services.Common.RESTRequest	DEBUG	POST request to https://api.accounts.firefox.com/v1/account/device
1723588907924	Services.Common.RESTRequest	DEBUG	POST Length: 433
1723588908232	Services.Common.RESTRequest	DEBUG	POST https://api.accounts.firefox.com/v1/account/device 200
1723588908232	Hawk	DEBUG	(Response) /account/device: code: 200 - Status text: OK
1723588908232	Hawk	DEBUG	Clock offset vs https://api.accounts.firefox.com/v1: 768
1723588908233	FirefoxAccounts	DEBUG	_updateAccountData with items: ["device"]
1723588908233	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified","device"]
1723588908233	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified","device"]
1723588908233	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/open-uri
1723588908233	FirefoxAccounts	DEBUG	Received declined engines: ["bookmarks","tabs","addresses","history","passwords","addons","prefs","creditcards"]
1723588908237	FirefoxAccounts	DEBUG	Webchannel is enabling sync
1723588908237	FirefoxAccounts	DEBUG	startVerifiedCheck: false
1723588908237	FirefoxAccounts	INFO	Generating and persisting encrypted key (false, false)
1723588908237	FirefoxAccounts	INFO	Can't get keys; user is not verified
1723588908237	Sync.Service	INFO	Configuring sync with current FxA user
1723588908239	FirefoxAccounts	INFO	Can't fetch keys, so unable to determine command keys
1723588908239	FirefoxAccounts	DEBUG	FxAccountsProfileClient: Requested profile
1723588908239	FirefoxAccounts	DEBUG	getOAuthToken enter
1723588908240	Sync.SyncAuthManager	DEBUG	observed weave:connected
1723588908240	Sync.SyncAuthManager	INFO	Sync has been connected to a logged in user
1723588908240	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/close-uri/v1
1723588908240	FirefoxAccounts	DEBUG	startVerifiedCheck: false
1723588908241	FirefoxAccounts	DEBUG	startVerifiedCheck: false
1723588908241	FirefoxAccounts	ERROR	FxA rejecting with error UNVERIFIED_ACCOUNT, details: undefined
1723588908241	FirefoxAccounts	ERROR	Background refresh of initial profile failed: Error: UNVERIFIED_ACCOUNT(resource://gre/modules/FxAccounts.sys.mjs:1596:18) JS Stack trace: _error@FxAccounts.sys.mjs:1596:18
withSessionToken@FxAccounts.sys.mjs:817:18
1723588908241	FirefoxAccounts	INFO	Generating and persisting encrypted key (false, false)
1723588908241	FirefoxAccounts	DEBUG	FxAccountsProfileClient: Requested profile
1723588908241	FirefoxAccounts	DEBUG	getOAuthToken enter
1723588908241	Sync.SyncAuthManager	INFO	The user is not verified
1723588908242	FirefoxAccounts	INFO	Can't get keys; user is not verified
1723588908242	FirefoxAccounts	ERROR	FxA rejecting with error UNVERIFIED_ACCOUNT, details: undefined
1723588908242	FirefoxAccounts	INFO	Can't fetch keys, so unable to determine command keys
1723588908243	FirefoxAccounts	ERROR	Background refresh of initial profile failed: Error: UNVERIFIED_ACCOUNT(resource://gre/modules/FxAccounts.sys.mjs:1596:18) JS Stack trace: _error@FxAccounts.sys.mjs:1596:18
withSessionToken@FxAccounts.sys.mjs:817:18
1723588908243	FirefoxAccounts	ERROR	Background refresh of initial profile failed: Error: UNVERIFIED_ACCOUNT(resource://gre/modules/FxAccounts.sys.mjs:1596:18) JS Stack trace: _error@FxAccounts.sys.mjs:1596:18
withSessionToken@FxAccounts.sys.mjs:817:18
1723588908264	FirefoxAccounts	TRACE	finished write of json user data - took: 31
1723588908264	FirefoxAccounts	DEBUG	writing secure storage: ["keyFetchToken","unwrapBKey"]
1723588908264	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588908274	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588908276	Services.Common.RESTRequest	DEBUG	GET https://api.accounts.firefox.com/v1/recovery_email/status?reason=start 200
1723588908276	Hawk	DEBUG	(Response) /recovery_email/status?reason=start: code: 200 - Status text: OK
1723588908276	Hawk	DEBUG	Clock offset vs https://api.accounts.firefox.com/v1: 724
1723588908276	FirefoxAccounts	DEBUG	checkEmailStatus -> {"email":"kairou.watoshimi@yahoo.com","verified":false,"sessionVerified":false,"emailVerified":false}
1723588908276	FirefoxAccounts	DEBUG	polling with timeout = 60000
1723588929121	FirefoxAccounts	TRACE	observed topic=push-message, data=chrome://fxa-device-update, subject=[xpconnect wrapped nsISupports]
1723588929121	FirefoxAccounts	TRACE	FxAccountsPushService _onPushMessage
1723588929121	FirefoxAccounts	DEBUG	empty push message - checking account status
1723588929122	FirefoxAccounts	TRACE	checkVerificationStatus
1723588929122	FirefoxAccounts	TRACE	checkVerificationStatus - forcing verification status check
1723588929122	FirefoxAccounts	DEBUG	entering startPollEmailStatus: push
1723588929122	FirefoxAccounts	DEBUG	startPollEmailStatus starting while existing timer is running
1723588929122	FirefoxAccounts	DEBUG	entering pollEmailStatus: push
1723588929122	Services.Common.RESTRequest	DEBUG	GET request to https://api.accounts.firefox.com/v1/recovery_email/status?reason=push
1723588929265	Services.Common.RESTRequest	DEBUG	GET https://api.accounts.firefox.com/v1/recovery_email/status?reason=push 200
1723588929265	Hawk	DEBUG	(Response) /recovery_email/status?reason=push: code: 200 - Status text: OK
1723588929265	Hawk	DEBUG	Clock offset vs https://api.accounts.firefox.com/v1: 735
1723588929265	FirefoxAccounts	DEBUG	checkEmailStatus -> {"email":"kairou.watoshimi@yahoo.com","verified":true,"sessionVerified":true,"emailVerified":true}
1723588929265	FirefoxAccounts	DEBUG	_updateAccountData with items: ["verified"]
1723588929265	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified","device"]
1723588929265	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified","device"]
1723588929266	FirefoxAccounts	INFO	the user became verified
1723588929266	FirefoxAccounts	DEBUG	Notifying observers of fxaccounts:onverified
1723588929278	Sync.SyncAuthManager	DEBUG	observed fxaccounts:onverified
1723588929278	Sync.SyncAuthManager	INFO	The user became verified
1723588929278	Sync.Status	DEBUG	Status.login: error.login.reason.no_username => success.login
1723588929278	Sync.Status	DEBUG	Status.service: service.client_not_configured => success.status_ok
1723588929278	Sync.SyncAuthManager	INFO	Doing initial sync actions
1723588929280	Sync.Service	DEBUG	User-Agent: Firefox/129.0.1 (Windows NT 10.0; Win64; x64) FxSync/1.131.0.20240812083845.desktop
1723588929280	Sync.Service	INFO	Starting sync at 2024-08-13 18:42:09 in browser session IbalKJtHBQ9P
1723588929280	Sync.Service	DEBUG	In sync: should login.
1723588929281	Sync.Service	INFO	User logged in successfully - verifying login.
1723588929281	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/open-uri
1723588929281	FirefoxAccounts	INFO	Generating and persisting encrypted key (false, false)
1723588929281	FirefoxAccounts	DEBUG	FxAccountsProfileClient: Requested profile
1723588929281	FirefoxAccounts	DEBUG	getOAuthToken enter
1723588929281	Sync.SyncAuthManager	DEBUG	unlockAndVerifyAuthState already has (or can fetch) sync keys
1723588929282	FirefoxAccounts	INFO	fetching updated device list
1723588929283	Sync.Status	DEBUG	Status.login: success.login => success.status_ok
1723588929283	Sync.Status	DEBUG	Status.service: success.status_ok => error.login.failed
1723588929283	Sync.Service	DEBUG	Fetching unlocked auth state returned success.status_ok
1723588929283	FirefoxAccounts	INFO	Could not find command keys, generating them
1723588929284	Sync.SyncAuthManager	INFO	Getting sync key
1723588929287	FirefoxAccounts	TRACE	finished write of json user data - took: 22
1723588929287	FirefoxAccounts	DEBUG	writing secure storage: ["keyFetchToken","unwrapBKey"]
1723588929287	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588929295	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588929296	FirefoxAccounts	TRACE	writing to sendTabKeys for command https://identity.mozilla.com/cmd/open-uri
1723588929296	FirefoxAccounts	DEBUG	_updateAccountData with items: ["device"]
1723588929296	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified","device"]
1723588929296	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified","device"]
1723588929297	Services.Common.RESTRequest	DEBUG	GET request to https://api.accounts.firefox.com/v1/account/devices?filterIdleDevicesTimestamp=1721774529283
1723588929298	Services.Common.RESTRequest	DEBUG	POST request to https://api.accounts.firefox.com/v1/oauth/token
1723588929298	Services.Common.RESTRequest	DEBUG	POST Length: 81
1723588929298	Services.Common.RESTRequest	DEBUG	POST request to https://api.accounts.firefox.com/v1/account/scoped-key-data
1723588929298	Services.Common.RESTRequest	DEBUG	POST Length: 84
1723588929299	FirefoxAccounts	TRACE	finished write of json user data - took: 2
1723588929299	FirefoxAccounts	DEBUG	writing secure storage: ["keyFetchToken","unwrapBKey"]
1723588929299	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588929306	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588929435	Services.Common.RESTRequest	DEBUG	GET https://api.accounts.firefox.com/v1/account/devices?filterIdleDevicesTimestamp=1721774529283 200
1723588929435	Hawk	DEBUG	(Response) /account/devices?filterIdleDevicesTimestamp=1721774529283: code: 200 - Status text: OK
1723588929435	Hawk	DEBUG	Clock offset vs https://api.accounts.firefox.com/v1: 1565
1723588929435	FirefoxAccounts	INFO	Got new device list: c67c8c21247f36cfa8e8f95b25e09fdf
1723588929436	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/open-uri
1723588929436	FirefoxAccounts	INFO	Generating and persisting encrypted key (false, true)
1723588929554	Services.Common.RESTRequest	DEBUG	POST https://api.accounts.firefox.com/v1/account/scoped-key-data 200
1723588929554	Hawk	DEBUG	(Response) /account/scoped-key-data: code: 200 - Status text: OK
1723588929554	Hawk	DEBUG	Clock offset vs https://api.accounts.firefox.com/v1: 1446
1723588929554	FirefoxAccounts	DEBUG	Fetching keys with token true from https://api.accounts.firefox.com/v1
1723588929555	Services.Common.RESTRequest	DEBUG	GET request to https://api.accounts.firefox.com/v1/account/keys
1723588929693	Services.Common.RESTRequest	DEBUG	GET https://api.accounts.firefox.com/v1/account/keys 200
1723588929693	Hawk	DEBUG	(Response) /account/keys: code: 200 - Status text: OK
1723588929693	Hawk	DEBUG	Clock offset vs https://api.accounts.firefox.com/v1: 1307
1723588929695	FirefoxAccounts	DEBUG	Keys Obtained: https://identity.mozilla.com/apps/oldsync
1723588929695	FirefoxAccounts	DEBUG	_updateAccountData with items: ["scopedKeys","keyFetchToken","unwrapBKey"]
1723588929695	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified","device"]
1723588929696	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified","device"]
1723588929696	FirefoxAccounts	DEBUG	getOAuthToken enter
1723588929697	Sync.BulkKeyBundle	INFO	BulkKeyBundle being created for undefined
1723588929697	Sync.BulkKeyBundle	INFO	BulkKeyBundle being created for undefined
1723588929699	FirefoxAccounts	DEBUG	_updateAccountData with items: ["encryptedSendTabKeys"]
1723588929700	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/close-uri/v1
1723588929700	FirefoxAccounts	INFO	Generating and persisting encrypted key (false, false)
1723588929700	FirefoxAccounts	INFO	Could not find command keys, generating them
1723588929700	FirefoxAccounts	DEBUG	_updateAccountData with items: ["encryptedSendTabKeys"]
1723588929700	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/close-uri/v1
1723588929700	FirefoxAccounts	INFO	Generating and persisting encrypted key (false, false)
1723588929700	FirefoxAccounts	INFO	Could not find command keys, generating them
1723588929701	FirefoxAccounts	TRACE	finished write of json user data - took: 5
1723588929701	FirefoxAccounts	DEBUG	writing secure storage: ["scopedKeys"]
1723588929701	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588929707	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588929707	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys"]
1723588929707	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys"]
1723588929708	Services.Common.RESTRequest	DEBUG	POST request to https://api.accounts.firefox.com/v1/oauth/token
1723588929708	Services.Common.RESTRequest	DEBUG	POST Length: 127
1723588929709	FirefoxAccounts	TRACE	writing to closeTabKeys for command https://identity.mozilla.com/cmd/close-uri/v1
1723588929710	FirefoxAccounts	DEBUG	_updateAccountData with items: ["device"]
1723588929710	Sync.BulkKeyBundle	INFO	BulkKeyBundle being created for undefined
1723588929710	FirefoxAccounts	TRACE	writing to closeTabKeys for command https://identity.mozilla.com/cmd/close-uri/v1
1723588929710	FirefoxAccounts	DEBUG	_updateAccountData with items: ["device"]
1723588929711	Sync.BulkKeyBundle	INFO	BulkKeyBundle being created for undefined
1723588929711	FirefoxAccounts	TRACE	finished write of json user data - took: 4
1723588929711	FirefoxAccounts	DEBUG	writing secure storage: ["scopedKeys"]
1723588929711	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588929719	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588929719	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys"]
1723588929719	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys"]
1723588929720	FirefoxAccounts	DEBUG	_updateAccountData with items: ["encryptedCloseTabKeys"]
1723588929720	FirefoxAccounts	WARN	Our commands need to be updated on the server
1723588929720	FirefoxAccounts	TRACE	FxAccountsPush registerPushEndpoint
1723588929721	FirefoxAccounts	DEBUG	_updateAccountData with items: ["encryptedCloseTabKeys"]
1723588929721	FirefoxAccounts	TRACE	FxAccountsPush registerPushEndpoint
1723588929721	FirefoxAccounts	TRACE	finished write of json user data - took: 2
1723588929721	FirefoxAccounts	DEBUG	writing secure storage: ["scopedKeys"]
1723588929721	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588929731	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588929731	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys"]
1723588929731	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys"]
1723588929732	FirefoxAccounts	DEBUG	FxAccountsPush got subscription
1723588929732	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/open-uri
1723588929732	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/close-uri/v1
1723588929732	FirefoxAccounts	INFO	registering with available commands: ["https://identity.mozilla.com/cmd/close-uri/v1","https://identity.mozilla.com/cmd/open-uri"]
1723588929732	FirefoxAccounts	DEBUG	updating existing device details
1723588929732	FirefoxAccounts	DEBUG	FxAccountsPush got subscription
1723588929733	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/open-uri
1723588929733	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/close-uri/v1
1723588929733	FirefoxAccounts	INFO	registering with available commands: ["https://identity.mozilla.com/cmd/close-uri/v1","https://identity.mozilla.com/cmd/open-uri"]
1723588929733	FirefoxAccounts	DEBUG	updating existing device details
1723588929733	FirefoxAccounts	TRACE	finished write of json user data - took: 2
1723588929733	FirefoxAccounts	DEBUG	writing secure storage: ["scopedKeys"]
1723588929733	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588929738	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588929738	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys"]
1723588929738	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys"]
1723588929740	Services.Common.RESTRequest	DEBUG	POST request to https://api.accounts.firefox.com/v1/account/device
1723588929741	Services.Common.RESTRequest	DEBUG	POST Length: 1297
1723588929741	Services.Common.RESTRequest	DEBUG	POST request to https://api.accounts.firefox.com/v1/account/device
1723588929741	Services.Common.RESTRequest	DEBUG	POST Length: 1297
1723588929742	FirefoxAccounts	TRACE	finished write of json user data - took: 3
1723588929742	FirefoxAccounts	DEBUG	writing secure storage: ["scopedKeys"]
1723588929742	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588929751	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588929751	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys"]
1723588929751	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys"]
1723588929753	FirefoxAccounts	TRACE	finished write of json user data - took: 2
1723588929753	FirefoxAccounts	DEBUG	writing secure storage: ["scopedKeys"]
1723588929753	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588929764	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588929764	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys"]
1723588929764	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys"]
1723588929765	FirefoxAccounts	TRACE	finished write of json user data - took: 1
1723588929765	FirefoxAccounts	DEBUG	writing secure storage: ["scopedKeys"]
1723588929765	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588929770	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588929905	Services.Common.RESTRequest	DEBUG	POST https://api.accounts.firefox.com/v1/account/device 200
1723588929905	Hawk	DEBUG	(Response) /account/device: code: 200 - Status text: OK
1723588929906	Hawk	DEBUG	Clock offset vs https://api.accounts.firefox.com/v1: 1094
1723588929906	FirefoxAccounts	DEBUG	_updateAccountData with items: ["device"]
1723588929906	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys"]
1723588929906	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys"]
1723588929910	FirefoxAccounts	TRACE	finished write of json user data - took: 4
1723588929910	FirefoxAccounts	DEBUG	writing secure storage: ["scopedKeys"]
1723588929910	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588929920	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588929921	Services.Common.RESTRequest	DEBUG	POST https://api.accounts.firefox.com/v1/account/device 200
1723588929921	Hawk	DEBUG	(Response) /account/device: code: 200 - Status text: OK
1723588929921	Hawk	DEBUG	Clock offset vs https://api.accounts.firefox.com/v1: 1079
1723588929922	FirefoxAccounts	DEBUG	_updateAccountData with items: ["device"]
1723588929922	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys"]
1723588929922	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys"]
1723588929922	FirefoxAccounts	INFO	updating the cache
1723588929923	FirefoxAccounts	TRACE	finished write of json user data - took: 1
1723588929923	FirefoxAccounts	DEBUG	writing secure storage: ["scopedKeys"]
1723588929923	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588929935	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588929936	Services.Common.RESTRequest	DEBUG	POST https://api.accounts.firefox.com/v1/oauth/token 200
1723588929936	Hawk	DEBUG	(Response) /oauth/token: code: 200 - Status text: OK
1723588929936	Hawk	DEBUG	Clock offset vs https://api.accounts.firefox.com/v1: 1064
1723588929936	FirefoxAccounts	DEBUG	_updateAccountData with items: ["oauthTokens"]
1723588929936	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys","oauthTokens"]
1723588929936	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys","oauthTokens"]
1723588929937	Services.Common.RESTRequest	DEBUG	GET request to https://profile.accounts.firefox.com/v1/profile
1723588929942	FirefoxAccounts	TRACE	finished write of json user data - took: 6
1723588929942	FirefoxAccounts	DEBUG	writing secure storage: ["scopedKeys"]
1723588929942	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588929955	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588929958	Services.Common.RESTRequest	DEBUG	POST https://api.accounts.firefox.com/v1/oauth/token 200
1723588929958	Hawk	DEBUG	(Response) /oauth/token: code: 200 - Status text: OK
1723588929958	Hawk	DEBUG	Clock offset vs https://api.accounts.firefox.com/v1: 1042
1723588929958	FirefoxAccounts	DEBUG	_updateAccountData with items: ["oauthTokens"]
1723588929959	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys","oauthTokens"]
1723588929959	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys","oauthTokens"]
1723588929959	Sync.SyncAuthManager	INFO	Getting a sync token from: https://token.services.mozilla.com/1.0/sync/1.5
1723588929959	Sync.SyncAuthManager	DEBUG	Getting a token using OAuth
1723588929959	Services.Common.TokenServerClient	DEBUG	Beginning OAuth token exchange: https://token.services.mozilla.com/1.0/sync/1.5
1723588929960	Services.Common.RESTRequest	DEBUG	GET request to https://token.services.mozilla.com/1.0/sync/1.5
1723588929965	FirefoxAccounts	TRACE	finished write of json user data - took: 6
1723588929965	FirefoxAccounts	DEBUG	writing secure storage: ["scopedKeys"]
1723588929965	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588929982	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588930201	FirefoxAccounts	DEBUG	FxAccountsWebChannel message received: fxaccounts:fxa_status
1723588930201	FirefoxAccounts	DEBUG	fxa_status received
1723588930201	FirefoxAccounts	DEBUG	service: sync
1723588930201	FirefoxAccounts	DEBUG	is private browsing: false
1723588930396	FirefoxAccounts	DEBUG	FxAccountsWebChannel message received: fxaccounts:loaded
1723588930396	FirefoxAccounts	WARN	Unrecognized FxAccountsWebChannel command: fxaccounts:loaded
1723588930624	Services.Common.RESTRequest	DEBUG	GET https://token.services.mozilla.com/1.0/sync/1.5 200
1723588930625	Services.Common.TokenServerClient	DEBUG	Got token response: 200
1723588930625	Services.Common.TokenServerClient	DEBUG	Successful token response
1723588930626	Sync.BulkKeyBundle	INFO	BulkKeyBundle being created for undefined
1723588930626	Sync.Status	DEBUG	Status.login: success.status_ok => success.login
1723588930626	Sync.Status	DEBUG	Status.service: error.login.failed => success.status_ok
1723588930626	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/open-uri
1723588930627	Sync.SyncAuthManager	DEBUG	_findCluster returning https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/
1723588930627	Sync.SyncAuthManager	DEBUG	Cluster value = https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/
1723588930627	Sync.SyncAuthManager	DEBUG	Setting cluster to https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/
1723588930627	Sync.Service	DEBUG	Caching URLs under storage user base: https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/
1723588930627	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/close-uri/v1
1723588930703	Services.Common.RESTRequest	DEBUG	GET https://profile.accounts.firefox.com/v1/profile 200
1723588930703	FirefoxAccounts	DEBUG	_updateAccountData with items: ["profileCache"]
1723588930703	FirefoxAccounts	DEBUG	writing plain storage: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys","oauthTokens","profileCache"]
1723588930703	FirefoxAccounts	TRACE	starting write of json user data: ["email","sessionToken","uid","verified","device","encryptedSendTabKeys","encryptedCloseTabKeys","oauthTokens","profileCache"]
1723588930703	FirefoxAccounts	DEBUG	notifying profile changed for user 57a5f96f972a4a2e9b8931df84da3261
1723588930704	FirefoxAccounts	TRACE	not checking freshness of profile as it remains recent
1723588930706	FirefoxAccounts	TRACE	finished write of json user data - took: 3
1723588930707	FirefoxAccounts	DEBUG	writing secure storage: ["scopedKeys"]
1723588930707	FirefoxAccounts	TRACE	starting write of user data to the login manager
1723588930715	FirefoxAccounts	TRACE	finished write of user data to the login manager
1723588931084	Sync.Resource	DEBUG	GET success 200 https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/info/collections
1723588931084	Sync.Service	DEBUG	Fetching server configuration: https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/info/configuration
1723588931084	FirefoxAccounts	TRACE	not checking freshness of profile as it remains recent
1723588931194	Sync.Resource	DEBUG	GET success 200 https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/info/configuration
1723588931194	Sync.Service	DEBUG	Fetching global metadata record
1723588931194	FirefoxAccounts	TRACE	not checking freshness of profile as it remains recent
1723588931320	Sync.Resource	DEBUG	GET fail 404 https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/storage/meta/global
1723588931320	Sync.Resource	WARN	GET request to https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/storage/meta/global failed with status 404
1723588931320	Sync.Service	DEBUG	Weave Version: 1.131.0 Local Storage: 5 Remote Storage: 
1723588931320	Sync.Service	INFO	One of: no meta, no meta storageVersion, or no meta syncID. Fresh start needed.
1723588931320	Sync.Service	INFO	No metadata record, server wipe needed
1723588931320	Sync.Service	INFO	Wiping server data
1723588931320	Sync.Service	INFO	Fresh start. Resetting client.
1723588931320	Sync.Service	INFO	Service reset.
1723588931320	Sync.Engine.Clients	DEBUG	Resetting clients last sync time
1723588931321	Sync.Engine.Addons	DEBUG	Resetting addons last sync time
1723588931322	Sync.Engine.Passwords	DEBUG	Resetting passwords last sync time
1723588931322	Sync.Engine.Prefs	DEBUG	Resetting prefs last sync time
1723588931323	Sync.Engine.Bookmarks	DEBUG	Resetting bookmarks last sync time
1723588931369	Sync.Engine.Forms	DEBUG	Resetting forms last sync time
1723588931370	Sync.Engine.History	DEBUG	Resetting history last sync time
1723588931370	Sync.Engine.Tabs	DEBUG	Resetting tabs last sync time
1723588931382	Sync.Engine.Addresses	DEBUG	Resetting addresses last sync time
1723588931382	Sync.Engine.CreditCards	DEBUG	Resetting creditcards last sync time
1723588931383	Sync.Engine.Extension-Storage	DEBUG	Resetting extension-storage last sync time
1723588931394	Sync.CollectionKeyManager	INFO	Clearing collection keys...
1723588931394	FirefoxAccounts	TRACE	not checking freshness of profile as it remains recent
1723588931528	Sync.Resource	DEBUG	DELETE success 200 https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/storage
1723588931528	Sync.Service	DEBUG	Uploading meta/global: {"payload":"{\"syncID\":\"Mxp2hPQKQIFa\",\"storageVersion\":5,\"declined\":[\"bookmarks\",\"tabs\",\"addresses\",\"history\",\"passwords\",\"addons\",\"prefs\",\"creditcards\"]}","id":"global","modified":0}
1723588931529	FirefoxAccounts	TRACE	not checking freshness of profile as it remains recent
1723588931529	Sync.Resource	DEBUG	PUT Length: 206
1723588931718	Sync.Resource	DEBUG	PUT success 200 https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/storage/meta/global
1723588931718	Sync.Service	INFO	Generating new keys WBO...
1723588931718	Sync.BulkKeyBundle	INFO	BulkKeyBundle being created for [default]
1723588931718	Sync.Service	INFO	Encrypting new key bundle.
1723588931718	Sync.Service	DEBUG	Uploading crypto/keys (lastModified: 0)
1723588931719	FirefoxAccounts	TRACE	not checking freshness of profile as it remains recent
1723588931719	Sync.Resource	DEBUG	PUT Length: 377
1723588931902	Sync.Resource	DEBUG	PUT success 200 https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/storage/crypto/keys
1723588931902	Sync.Service	INFO	Got status 200 uploading keys.
1723588931902	Sync.Service	DEBUG	Server reports crypto modified: 1723588933.57
1723588931902	Sync.Service	DEBUG	Verifying server collection records.
1723588931902	FirefoxAccounts	TRACE	not checking freshness of profile as it remains recent
1723588932026	Sync.Resource	DEBUG	GET success 200 https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/info/collections
1723588932026	Sync.Service	DEBUG	info/collections is: {"crypto":1723588933.57,"meta":1723588933.38}
1723588932026	FirefoxAccounts	TRACE	not checking freshness of profile as it remains recent
1723588932158	Sync.Resource	DEBUG	GET success 200 https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/storage/crypto/keys
1723588932158	Sync.CollectionKeyManager	INFO	Updating collection keys...
1723588932158	Sync.CollectionKeyManager	INFO	Setting collection keys contents. Our last modified: 0, input modified: 1723588933.57.
1723588932158	Sync.BulkKeyBundle	INFO	BulkKeyBundle being created for [default]
1723588932158	Sync.CollectionKeyManager	INFO	Processing downloaded per-collection keys.
1723588932158	Sync.CollectionKeyManager	INFO	Clearing collection keys...
1723588932158	Sync.CollectionKeyManager	INFO	Saving downloaded keys.
1723588932158	Sync.CollectionKeyManager	INFO	Bumping last modified to 1723588933.57
1723588932158	Sync.CollectionKeyManager	INFO	Collection keys updated.
1723588932158	Sync.Service	INFO	Metadata record not found, server was wiped to ensure consistency.
1723588932158	Sync.Status	DEBUG	Status.login: success.login => success.login
1723588932158	Sync.Status	DEBUG	Status.service: success.status_ok => success.status_ok
1723588932159	Sync.Service	DEBUG	Caching URLs under storage user base: https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/
1723588932159	Sync.SyncScheduler	DEBUG	Clearing sync triggers and the global score.
1723588932159	Sync.Status	INFO	Resetting Status.
1723588932160	Sync.Status	DEBUG	Status.service: success.status_ok => success.status_ok
1723588932160	FirefoxAccounts	TRACE	not checking freshness of profile as it remains recent
1723588932282	Sync.Resource	DEBUG	GET success 200 https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/info/collections?v=1.131.0
1723588932282	Sync.Service	DEBUG	Fetching server configuration: https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/info/configuration
1723588932282	FirefoxAccounts	TRACE	not checking freshness of profile as it remains recent
1723588932396	Sync.Resource	DEBUG	GET success 200 https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/info/configuration
1723588932396	Sync.Service	DEBUG	Fetching global metadata record
1723588932396	Sync.Service	DEBUG	Weave Version: 1.131.0 Local Storage: 5 Remote Storage: 5
1723588932396	Sync.Service	DEBUG	Fetching and verifying -- or generating -- symmetric keys.
1723588932396	Sync.Service	INFO	Testing info/collections: {"crypto":1723588933.57,"meta":1723588933.38}
1723588932396	Sync.CollectionKeyManager	INFO	Testing for updateNeeded. Last modified: 1723588933.57
1723588932396	Sync.Synchronizer	DEBUG	Refreshing client list.
1723588932397	Sync.Engine.Clients	DEBUG	Old engine data: ,1
1723588932397	Sync.Engine.Clients	DEBUG	Engine syncIDs differ (old="", new="oqliCd3YWAl0") - resetting the engine
1723588932397	Sync.Engine.Clients	DEBUG	Resetting clients last sync time
1723588932398	FirefoxAccounts	TRACE	not checking freshness of profile as it remains recent
1723588932554	Sync.Resource	DEBUG	DELETE success 200 https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/storage/clients
1723588932554	Sync.Engine.Clients	DEBUG	Resetting clients last sync time
1723588932555	Sync.Engine.Clients	DEBUG	First sync, uploading all items
1723588932555	Sync.Engine.Clients	DEBUG	Resetting clients last sync time
1723588932555	Sync.Engine.Clients	INFO	Records: 0 applied, 0 successfully, 0 failed to apply, 0 newly failed to apply, 0 reconciled.
1723588932556	FirefoxAccounts	INFO	Device list cache is fresh, re-using it
1723588932556	Sync.Engine.Clients	DEBUG	Refreshing the known stale clients list
1723588932556	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/open-uri
1723588932556	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/close-uri/v1
1723588932557	Sync.Engine.Clients	INFO	Uploading 1 outgoing records
1723588932558	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/open-uri
1723588932558	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/close-uri/v1
1723588932558	Sync.Engine.Clients	INFO	Posting 1 records of 550 bytes with batch=true
1723588932559	FirefoxAccounts	TRACE	not checking freshness of profile as it remains recent
1723588932559	Sync.Collection	DEBUG	POST Length: 550
1723588932733	Sync.Collection	DEBUG	POST success 200 https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/storage/clients?batch=true&commit=true
1723588932733	Sync.Engine.Clients	INFO	Uploaded our client record for the first time, notifying other clients.
1723588932733	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/open-uri
1723588932733	FirefoxAccounts	TRACE	Getting command keys: https://identity.mozilla.com/cmd/close-uri/v1
1723588932734	Sync.SyncScheduler	DEBUG	Client count: 0 -> 1
1723588932735	Sync.Synchronizer	INFO	Updating enabled engines: 1 clients.
1723588932735	Sync.Synchronizer	DEBUG	meta/global isn't new, or is missing engines. Not updating enabled state.
1723588932735	Sync.Synchronizer	INFO	Syncing all enabled engines.
1723588932735	Sync.Synchronizer	INFO	meta/global changed locally: reuploading.
1723588932735	Sync.Service	DEBUG	Uploading meta/global: {"payload":"{\"syncID\":\"Mxp2hPQKQIFa\",\"storageVersion\":5,\"declined\":[\"bookmarks\",\"tabs\",\"addresses\",\"history\",\"passwords\",\"addons\",\"prefs\",\"creditcards\"],\"engines\":{\"clients\":{\"version\":1,\"syncID\":\"oqliCd3YWAl0\"}}}","id":"global","modified":1723588933.38}
1723588932735	FirefoxAccounts	TRACE	not checking freshness of profile as it remains recent
1723588932735	Sync.Resource	DEBUG	PUT Length: 288
1723588932736	Services.Common.RESTRequest	DEBUG	POST request to https://api.accounts.firefox.com/v1/account/devices/notify
1723588932736	Services.Common.RESTRequest	DEBUG	POST Length: 184
1723588932869	Services.Common.RESTRequest	DEBUG	POST https://api.accounts.firefox.com/v1/account/devices/notify 200
1723588932869	Hawk	DEBUG	(Response) /account/devices/notify: code: 200 - Status text: OK
1723588932869	Hawk	DEBUG	Clock offset vs https://api.accounts.firefox.com/v1: 1131
1723588932898	Sync.Resource	DEBUG	PUT success 200 https://sync-1-us-west1-g.sync.services.mozilla.com/1.5/262146391/storage/meta/global
1723588932903	Sync.Doctor	INFO	Skipping validation: no engines qualify
1723588932903	Sync.Status	DEBUG	Status.sync: success.sync => success.sync
1723588932903	Sync.Status	DEBUG	Status.service: success.status_ok => success.status_ok
1723588932904	Sync.Synchronizer	INFO	Sync completed at 2024-08-13 18:42:12 after 0.74 secs.
1723588932904	Sync.Declined	DEBUG	Handling remote declined: ["bookmarks","tabs","addresses","history","passwords","addons","prefs","creditcards"]
1723588932904	Sync.Declined	DEBUG	Handling local declined: ["bookmarks","tabs","addresses","history","passwords","addons","prefs","creditcards"]
1723588932904	Sync.Declined	DEBUG	Declined changed? false
1723588932904	Sync.Service	INFO	No change to declined engines. Not reuploading meta/global.
1723588932905	Sync.SyncScheduler	DEBUG	Next sync in 3600000 ms. (why=schedule)