Closed
Bug 1759795
Opened 3 years ago
Closed 3 years ago
Intermittent [tier 2] TEST-UNEXPECTED-TIMEOUT | services/sync/tests/unit/test_clients_engine.js | Test timed out
Categories
(Firefox :: Sync, defect, P5)
Firefox
Sync
Tracking
()
RESOLVED
DUPLICATE
of bug 1781458
People
(Reporter: intermittent-bug-filer, Unassigned)
References
Details
(Keywords: intermittent-failure)
Filed by: mlaza [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=371190316&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/HpScuXrOQqOp-5wsTCVhiA/runs/0/artifacts/public/logs/live_backing.log
[task 2022-03-16T01:46:15.827Z] 01:46:15 INFO - TEST-START | services/sync/tests/unit/test_clients_engine.js
[task 2022-03-16T01:51:15.830Z] 01:51:15 WARNING - TEST-UNEXPECTED-TIMEOUT | services/sync/tests/unit/test_clients_engine.js | Test timed out
[task 2022-03-16T01:51:15.831Z] 01:51:15 INFO - TEST-INFO took 300003ms
[task 2022-03-16T01:51:15.831Z] 01:51:15 INFO - >>>>>>>
[task 2022-03-16T01:51:15.831Z] 01:51:15 INFO - (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2022-03-16T01:51:15.831Z] 01:51:15 INFO - (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2022-03-16T01:51:15.832Z] 01:51:15 INFO - (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2022-03-16T01:51:15.832Z] 01:51:15 INFO - running event loop
[task 2022-03-16T01:51:15.832Z] 01:51:15 INFO - services/sync/tests/unit/test_clients_engine.js | Starting head_setup
[task 2022-03-16T01:51:15.832Z] 01:51:15 INFO - (xpcshell/head.js) | test head_setup pending (2)
[task 2022-03-16T01:51:15.833Z] 01:51:15 INFO - (xpcshell/head.js) | test run_next_test 0 finished (2)
[task 2022-03-16T01:51:15.833Z] 01:51:15 INFO - PID 2952 | 1647395176409 Sync.Engine.Addons DEBUG SyncEngine initialized: addons
[task 2022-03-16T01:51:15.834Z] 01:51:15 INFO - PID 2952 | 1647395176409 Sync.AddonsReconciler TRACE Loading json from disk: C:\Users\task_164739241714886\AppData\Local\Temp\xpc-profile-g4n_fagk\weave\addonsreconciler.json
[task 2022-03-16T01:51:15.834Z] 01:51:15 INFO - PID 2952 | 1647395176410 Sync.AddonsReconciler DEBUG No data seen in loaded file: addonsreconciler
[task 2022-03-16T01:51:15.834Z] 01:51:15 INFO - PID 2952 | 1647395176415 Sync.Engine.Bookmarks DEBUG Engine constructed
[task 2022-03-16T01:51:15.834Z] 01:51:15 INFO - PID 2952 | 1647395176417 Sync.Engine.Bookmarks DEBUG SyncEngine initialized: bookmarks
[task 2022-03-16T01:51:15.835Z] 01:51:15 INFO - PID 2952 | 1647395176420 Sync.Engine.Forms DEBUG Engine constructed
[task 2022-03-16T01:51:15.835Z] 01:51:15 INFO - PID 2952 | 1647395176421 Sync.Engine.Forms DEBUG SyncEngine initialized: forms
[task 2022-03-16T01:51:15.835Z] 01:51:15 INFO - PID 2952 | 1647395176424 Sync.Engine.History DEBUG Engine constructed
[task 2022-03-16T01:51:15.835Z] 01:51:15 INFO - PID 2952 | 1647395176426 Sync.Engine.History DEBUG SyncEngine initialized: history
[task 2022-03-16T01:51:15.836Z] 01:51:15 INFO - PID 2952 | 1647395176429 Sync.Engine.Passwords DEBUG Engine constructed
[task 2022-03-16T01:51:15.836Z] 01:51:15 INFO - PID 2952 | 1647395176431 Sync.Engine.Passwords DEBUG SyncEngine initialized: passwords
[task 2022-03-16T01:51:15.836Z] 01:51:15 INFO - PID 2952 | 1647395176433 Sync.Engine.Prefs DEBUG Engine constructed
[task 2022-03-16T01:51:15.837Z] 01:51:15 INFO - PID 2952 | 1647395176435 Sync.Engine.Prefs DEBUG SyncEngine initialized: prefs
[task 2022-03-16T01:51:15.837Z] 01:51:15 INFO - PID 2952 | 1647395176439 Sync.Engine.Tabs DEBUG Engine constructed
[task 2022-03-16T01:51:15.837Z] 01:51:15 INFO - PID 2952 | 1647395176441 Sync.Engine.Tabs DEBUG SyncEngine initialized: tabs
[task 2022-03-16T01:51:15.838Z] 01:51:15 INFO - PID 2952 | 1647395176441 Sync.Engine.Tabs DEBUG Resetting tabs last sync time
[task 2022-03-16T01:51:15.838Z] 01:51:15 INFO - PID 2952 | 1647395176444 Sync.Engine.CreditCards DEBUG Engine constructed
[task 2022-03-16T01:51:15.838Z] 01:51:15 INFO - PID 2952 | 1647395176446 Sync.Engine.CreditCards DEBUG SyncEngine initialized: creditcards
[task 2022-03-16T01:51:15.839Z] 01:51:15 INFO - PID 2952 | 1647395176452 Sync.Engine.Extension-Storage DEBUG Engine constructed
[task 2022-03-16T01:51:15.839Z] 01:51:15 INFO - PID 2952 | 1647395176454 Sync.Engine.Extension-Storage DEBUG SyncEngine initialized: extension-storage
[task 2022-03-16T01:51:15.839Z] 01:51:15 INFO - PID 2952 | 1647395176463 Sync.Service INFO Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:100.0) Gecko/20100101 XPCShell/1
[task 2022-03-16T01:51:15.839Z] 01:51:15 INFO - PID 2952 | 1647395176949 Sync.Status DEBUG Status.login: error.login.reason.no_username => error.login.reason.no_username
[task 2022-03-16T01:51:15.840Z] 01:51:15 INFO - PID 2952 | 1647395176949 Sync.Status DEBUG Status.service: service.client_not_configured => service.client_not_configured
[task 2022-03-16T01:51:15.840Z] 01:51:15 INFO - PID 2952 | 1647395176949 Sync.Status DEBUG Status.service: service.client_not_configured => service.client_not_configured
[task 2022-03-16T01:51:15.840Z] 01:51:15 INFO - (xpcshell/head.js) | test run_next_test 1 pending (2)
[task 2022-03-16T01:51:15.841Z] 01:51:15 INFO - (xpcshell/head.js) | test head_setup finished (2)
[task 2022-03-16T01:51:15.841Z] 01:51:15 INFO - PID 2952 | 1647395176953 Sync.Telemetry TRACE observed weave:service:ready null
[task 2022-03-16T01:51:15.841Z] 01:51:15 INFO - PID 2952 | 1647395176955 Sync.Telemetry TRACE Not sending telemetry ping for self-hosted Sync user
[task 2022-03-16T01:51:15.841Z] 01:51:15 INFO - services/sync/tests/unit/test_clients_engine.js | Starting setup
[task 2022-03-16T01:51:15.842Z] 01:51:15 INFO - (xpcshell/head.js) | test setup pending (2)
[task 2022-03-16T01:51:15.842Z] 01:51:15 INFO - (xpcshell/head.js) | test run_next_test 1 finished (2)
[task 2022-03-16T01:51:15.842Z] 01:51:15 INFO - (xpcshell/head.js) | test run_next_test 2 pending (2)
[task 2022-03-16T01:51:15.842Z] 01:51:15 INFO - (xpcshell/head.js) | test setup finished (2)
[task 2022-03-16T01:51:15.843Z] 01:51:15 INFO - services/sync/tests/unit/test_clients_engine.js | Starting test_bad_hmac
[task 2022-03-16T01:51:15.843Z] 01:51:15 INFO - (xpcshell/head.js) | test test_bad_hmac pending (2)
[task 2022-03-16T01:51:15.843Z] 01:51:15 INFO - PID 2952 | Ensure that Clients engine deletes corrupt records.
[task 2022-03-16T01:51:15.843Z] 01:51:15 INFO - PID 2952 | 1647395176957 Sync.BulkKeyBundle INFO BulkKeyBundle being created for [default]
[task 2022-03-16T01:51:15.844Z] 01:51:15 INFO - (xpcshell/head.js) | test run_next_test 2 finished (2)
[task 2022-03-16T01:51:15.844Z] 01:51:15 INFO - PID 2952 | 1647395176960 Sync.CollectionKeyManager INFO Setting collection keys contents. Our last modified: 0, input modified: 1647395176.96.
[task 2022-03-16T01:51:15.844Z] 01:51:15 INFO - PID 2952 | 1647395176960 Sync.BulkKeyBundle INFO BulkKeyBundle being created for [default]
[task 2022-03-16T01:51:15.844Z] 01:51:15 INFO - PID 2952 | 1647395176960 Sync.CollectionKeyManager INFO Processing downloaded per-collection keys.[task 2022-03-16T01:51:15.845Z] 01:51:15 INFO - PID 2952 | 1647395176960 Sync.CollectionKeyManager INFO Clearing collection keys...
[task 2022-03-16T01:51:15.845Z] 01:51:15 INFO - PID 2952 | 1647395176960 Sync.CollectionKeyManager INFO Saving downloaded keys.
[task 2022-03-16T01:51:15.845Z] 01:51:15 INFO - PID 2952 | 1647395176960 Sync.CollectionKeyManager INFO Bumping last modified to 1647395176.96
[task 2022-03-16T01:51:15.846Z] 01:51:15 INFO - PID 2952 | 1647395176961 Sync.Engine.Clients DEBUG Engine syncIDs: 7pz91HCRLqhL,
[task 2022-03-16T01:51:15.846Z] 01:51:15 INFO - PID 2952 | 1647395176961 Sync.Engine.Clients DEBUG Engine syncIDs: 6nHfcJjTboLo,7pz91HCRLqhL
[task 2022-03-16T01:51:15.846Z] 01:51:15 INFO - PID 2952 | 1647395176965 Sync.SyncAuthManager INFO Getting sync key
[task 2022-03-16T01:51:15.846Z] 01:51:15 INFO - PID 2952 | 1647395176965 Sync.SyncAuthManager INFO Getting a sync token from: http://token-server
[task 2022-03-16T01:51:15.847Z] 01:51:15 INFO - PID 2952 | 1647395176965 Sync.SyncAuthManager DEBUG Getting a token using OAuth
[task 2022-03-16T01:51:15.847Z] 01:51:15 INFO - TEST-PASS | services/sync/tests/unit/test_clients_engine.js | test_bad_hmac - [test_bad_hmac : 264] "http://token-server" == "http://token-server"
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•3 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
|
Reporter | |
Comment 3•3 years ago
|
||
| treeherder | ||
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=383193832&repo=mozilla-central
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
| Comment hidden (Intermittent Failures Robot) |
|
||
Updated•3 years ago
|
Status: REOPENED → RESOLVED
Closed: 3 years ago → 3 years ago
Resolution: --- → DUPLICATE
You need to log in
before you can comment on or make changes to this bug.
Description
•