Trace logging for ci debugging #12755
Annotations
4 errors
Annotate Failures:
topologytest/peer_test.go#L310
peer_test.go:310: TopologyTest: created peer cbs1 (bucket:sg_int_rosmar_ce81f93b646c6b795274a20b8ac7b303,sourceid:nkvcSMf0NP+V1Z6bykxsTg)
peer_test.go:310: TopologyTest: created peer cbs2 (bucket:sg_int_rosmar_2adc30daa86e562fae24d615b084cf39,sourceid:tAWlCU4RzkRCuqWJWCbTtQ)
2025-01-17T15:45:42.301Z [TRC] t:TestMultiActorDelete/2x_CBL<->SG<->CBS_XDCR_only_1.3 Did not detect a cgroup for a memory limit -- rest.getTotalMemory() at server_context.go:2167
2025-01-17T15:45:42.301Z [INF] t:TestMultiActorDelete/2x_CBL<->SG<->CBS_XDCR_only_1.3 Logging stats with frequency: &{1m0s}
2025-01-17T15:45:42.301Z [INF] t:TestMultiActorDelete/2x_CBL<->SG<->CBS_XDCR_only_1.3 Initializing bootstrap connection..
2025-01-17T15:45:42.301Z [DBG] Walrus+: Opened collection B#57c0 on sg_int_rosmar_2adc30daa86e562fae24d615b084cf39._default._default
2025-01-17T15:45:42.301Z [DBG] Walrus+: UNregisterBucket B#57 sg_int_rosmar_2adc30daa86e562fae24d615b084cf39 at file:/?mode=memory
2025-01-17T15:45:42.301Z [INF] Config: t:TestMultiActorDelete/2x_CBL<->SG<->CBS_XDCR_only_1.3 Unable to retrieve 3.0 config during config migration for bucket: sg_int_rosmar_2adc30daa86e562fae24d615b084cf39, groupID: f0790754-bd1a-4b09-893b-a5e8189db36a: key "_sync:dbconfig:f0790754-bd1a-4b09-893b-a5e8189db36a" missing
2025-01-17T15:45:42.301Z [DBG] Walrus+: Opened collection B#58c0 on sg_int_rosmar_ce81f93b646c6b795274a20b8ac7b303._default._default
2025-01-17T15:45:42.301Z [DBG] Walrus+: UNregisterBucket B#58 sg_int_rosmar_ce81f93b646c6b795274a20b8ac7b303 at file:/?mode=memory
2025-01-17T15:45:42.301Z [INF] Config: t:TestMultiActorDelete/2x_CBL<->SG<->CBS_XDCR_only_1.3 Unable to retrieve 3.0 config during config migration for bucket: sg_int_rosmar_ce81f93b646c6b795274a20b8ac7b303, groupID: f0790754-bd1a-4b09-893b-a5e8189db36a: key "_sync:dbconfig:f0790754-bd1a-4b09-893b-a5e8189db36a" missing
2025-01-17T15:45:42.301Z [TRC] Config+: t:TestMultiActorDelete/2x_CBL<->SG<->CBS_XDCR_only_1.3 b:sg_int_rosmar_2adc30daa86e562fae24d615b084cf39 Checking for configs for group "f0790754-bd1a-4b09-893b-a5e8189db36a" -- rest.(*ServerContext).FetchConfigs() at config.go:1940
2025-01-17T15:45:42.301Z [DBG] Config+: t:TestMultiActorDelete/2x_CBL<->SG<->CBS_XDCR_only_1.3 b:sg_int_rosmar_2adc30daa86e562fae24d615b084cf39 Checking for database config (attempt 1/5)
2025-01-17T15:45:42.301Z [DBG] Walrus+: Opened collection B#57c0 on sg_int_rosmar_2adc30daa86e562fae24d615b084cf39._default._default
2025-01-17T15:45:42.301Z [DBG] Walrus+: UNregisterBucket B#57 sg_int_rosmar_2adc30daa86e562fae24d615b084cf39 at file:/?mode=memory
2025-01-17T15:45:42.301Z [DBG] Walrus+: Opened collection B#57c0 on sg_int_rosmar_2adc30daa86e562fae24d615b084cf39._default._default
2025-01-17T15:45:42.301Z [DBG] Walrus+: UNregisterBucket B#57 sg_int_rosmar_2adc30daa86e562fae24d615b084cf39 at file:/?mode=memory
2025-01-17T15:45:42.301Z [DBG] Config+: t:TestMultiActorDelete/2x_CBL<->SG<->CBS_XDCR_only_1.3 b:sg_int_rosmar_2adc30daa86e562fae24d615b084cf39 Bucket "sg_int_rosmar_2adc30daa86e562fae24d615b084cf39" did not contain any configs for group "f0790754-bd1a-4b09-893b-a5e8189db36a"
2025-01-17T15:45:42.301Z [TRC] Config+: t:TestMultiActorDelete/2x_CBL<->SG<->CBS_XDCR_only_1.3 b:sg_int_rosmar_ce81f93b646c6b795274a20b8ac7b303 Checking for configs for group "f0790754-bd1a-4b09-893b-a5e8189db36a" -- rest.(*ServerContext).FetchConfigs() at config.go:1940
2025-01-17T15:45:42.301Z [DBG] Config+: t:TestMultiActorDelete/2x_CBL<->SG<->CBS_XDCR_only_1.3 b:sg_int_rosmar_ce81f93b646c6b795274a20b8ac7b303 Checking for database config (attempt 1/5)
2025-01-17T15:45:42.301Z [DBG] Walrus+: Opened collection B#58c0 on sg_int_rosmar_ce81f93b646c6b795274a20b8ac7b303._default._default
2025-01-17T15:45:42.301Z [DBG] Walrus+: UNregisterBucket B#58 sg_int_rosmar_ce81f93b646c6b795274a20b8ac7b303 at file:/?mode=memory
2025-01-17T15:45:42.301Z [DBG] Walrus+: Opened collection B#58c0 on sg_int_rosmar_ce81f93b646c6b795274a20b8ac7b303._default._default
2025-01-17T15:45:42.301Z [DBG] Walrus+: UNregisterBucket B#58 sg_int_rosmar_ce81f93b646c6b795274
|
Annotate Failures:
topologytest/peer_test.go#L310
peer_test.go:310: TopologyTest: created peer sg1 (bucket:sg_int_rosmar_b3bac6fa97a275c89bc281855f3159f9,sourceid:4b6ty3XeBrMx8lfMc/UbLw)
peer_test.go:310: TopologyTest: created peer cbs1 (bucket:sg_int_rosmar_b3bac6fa97a275c89bc281855f3159f9,sourceid:4b6ty3XeBrMx8lfMc/UbLw)
peer_test.go:310: TopologyTest: created peer cbs2 (bucket:sg_int_rosmar_06632fde7332e87bbe4af6ac41975f8d,sourceid:OlUhb6OA1d92WM6yhzsbDg)
peer_test.go:310: TopologyTest: created peer cbl1 (sourceid:cbl1)
2025/01/17 15:45:47 Creating user: {"name":"user","collection_access":{"sg_test_0":{"sg_test_0":{"admin_channels":["*"]}}},"password":"letmein"}
2025-01-17T15:45:47.276Z [INF] HTTP: c:#124 db:sg1 POST http://localhost/sg1/_user/ (as ADMIN)
2025-01-17T15:45:47.276Z [DBG] Walrus+: ViewQuery("sync_gateway_2.1", "access", map[key:user stale:false])
2025-01-17T15:45:47.276Z [DBG] Walrus+: Updating view B#69c1/sync_gateway_2.1/access index to cas 1737128747270602752 (from 0)
2025-01-17T15:45:47.283Z [DBG] Walrus+: Queried view B#69c1/sync_gateway_2.1/access --> 0 rows
2025/01/17 15:45:47 SG-Bucket: ... view returned 0 rows
2025-01-17T15:45:47.283Z [DBG] Walrus+: View --> 0 rows
2025-01-17T15:45:47.283Z [INF] Access: c:#124 db:sg1 Recomputed channels for "<ud>user</ud>" (sg_test_0.sg_test_0): <ud>!</ud>:1
2025-01-17T15:45:47.283Z [DBG] Walrus+: ViewQuery("sync_gateway_2.1", "role_access", map[key:user stale:false])
2025-01-17T15:45:47.283Z [DBG] Walrus+: Updating view B#69c1/sync_gateway_2.1/role_access index to cas 1737128747270602752 (from 0)
2025-01-17T15:45:47.295Z [DBG] Walrus+: Queried view B#69c1/sync_gateway_2.1/role_access --> 0 rows
2025/01/17 15:45:47 SG-Bucket: ... view returned 0 rows
2025-01-17T15:45:47.295Z [DBG] Walrus+: View --> 0 rows
2025-01-17T15:45:47.295Z [INF] Access: c:#124 db:sg1 Computed roles for "<ud>user</ud>":
2025-01-17T15:45:47.296Z [DBG] Walrus+: INCR: result=0, err=key "_sync:m_sg1:seq" missing
2025-01-17T15:45:47.296Z [DBG] Walrus+: DCP: B#69c0 cas 0x181b856457ba0000: "_sync:m_sg1:seq" = `1` ---- xattrs ``
2025-01-17T15:45:47.296Z [DBG] Walrus+: DCP: B#69c0 cas 0x181b856457ba0001: "_sync:user:sg1:user" = `{"name":"user","all_channels":null,"sequence":1,"c` ---- xattrs ``
2025-01-17T15:45:47.296Z [INF] Auth: c:#124 db:sg1 Saved principal w/ name:<ud>user</ud>, seq: #1
2025-01-17T15:45:47.296Z [INF] HTTP+: c:#124 db:sg1 #124: --> 201 Created (20.5 ms)
2025-01-17T15:45:47.296Z [DBG] Walrus+: Feed(B#69c0 SG) lastCas = 0x181b856457ba0000
2025-01-17T15:45:47.296Z [INF] Changes: db:sg1 Received #1 ("<ud>_user/user</ud>")
2025-01-17T15:45:47.296Z [DBG] Changes+: Notifying that "sg_int_rosmar_b3bac6fa97a275c89bc281855f3159f9" changed (key="<ud>_sync:user:sg1:user</ud>") count=2
2025-01-17T15:45:47.296Z [DBG] Walrus+: Feed(B#69c0 SG) lastCas = 0x181b856457ba0001
2025-01-17T15:45:47.299Z [DBG] Walrus+: ViewQuery("sync_gateway_2.1", "access", map[key:user stale:false])
2025-01-17T15:45:47.299Z [DBG] Walrus+: Queried view B#69c1/sync_gateway_2.1/access --> 0 rows
2025/01/17 15:45:47 SG-Bucket: ... view returned 0 rows
2025-01-17T15:45:47.299Z [DBG] Walrus+: View --> 0 rows
2025-01-17T15:45:47.299Z [INF] Access: c:#125 db:sg1 Recomputed channels for "<ud>user</ud>" (sg_test_0.sg_test_0): <ud>!</ud>:1,<ud>*</ud>:1
2025-01-17T15:45:47.300Z [DBG] Walrus+: DCP: B#69c0 cas 0x181b856457e50000: "_sync:user:sg1:user" = `{"name":"user","all_channels":null,"sequence":1,"c` ---- xattrs ``
2025-01-17T15:45:47.300Z [INF] Changes: db:sg1 Received #1 ("<ud>_user/user</ud>")
2025-01-17T15:45:47.300Z [DBG] Cache+: db:sg1 Ignoring duplicate of #1
2025-01-17T15:45:47.300Z [DBG] Changes+: Notifying that "sg_int_rosmar_b3bac6fa97a275c89bc281855f3159f9" changed (key="<ud>_sync:user:sg1:user</ud>") count=3
2025-01-17T15:45:47.300Z [DBG] Walrus+: Feed(B#69c0 SG) lastCas = 0x181b856457e50000
2025-01-17T15:45:47.303Z [INF] HTTP: c:#125 db:sg1 GET /sg1/_blipsync (as <ud>user</ud>)
2025-01-17T15:45:47.304Z [TRC] WSFrame+: t:TestMultiActorConflictUpdate/CBL<->SG<->CBS1_CBS1<->CBS2_1.2 Sender starting -- db.NewSGBlipContextWithProtocols.
|
Annotate Failures:
topologytest/hlv_test.go#L102
hlv_test.go:102: Global doc "doc_MultiActorConflictUpdate_CBL<->SG<->CBS1_CBS1<->CBS2_1.2" state for all peers:
====
peer(sg1)
----
DocMetadata{
DocID: "doc_MultiActorConflictUpdate_CBL<->SG<->CBS1_CBS1<->CBS2_1.2",
RevTreeID:"2-524b23860762bbf14f2bcae3252eb92b",
HLV:&{CurrentVersionCAS:1737128747316477954 SourceID:OlUhb6OA1d92WM6yhzsbDg Version:1737128747316477954 MergeVersions:map[] PreviousVersions:map[]},
Mou:<nil>,
Cas:1737128747328405504,
ImplicitHLV:<nil>,
}
body:map[action:create activePeer:cbs2 topology:CBL<->SG<->CBS1 CBS1<->CBS2 1.2]
====
peer(cbs1)
----
DocMetadata{
DocID: "doc_MultiActorConflictUpdate_CBL<->SG<->CBS1_CBS1<->CBS2_1.2",
RevTreeID:"2-524b23860762bbf14f2bcae3252eb92b",
HLV:&{CurrentVersionCAS:1737128747316477954 SourceID:OlUhb6OA1d92WM6yhzsbDg Version:1737128747316477954 MergeVersions:map[] PreviousVersions:map[]},
Mou:{CAS:1737128747328405504 PreviousCAS:1737128747316477954 PreviousRevSeqNo:0},
Cas:1737128747328405504,
ImplicitHLV:<nil>,
}
body:map[action:create activePeer:cbs2 topology:CBL<->SG<->CBS1 CBS1<->CBS2 1.2]
====
peer(cbs2)
----
DocMetadata{
DocID: "doc_MultiActorConflictUpdate_CBL<->SG<->CBS1_CBS1<->CBS2_1.2",
RevTreeID:"",
HLV:<nil>,
Mou:<nil>,
Cas:1737128747316477954,
ImplicitHLV:&{CurrentVersionCAS:0 SourceID:OlUhb6OA1d92WM6yhzsbDg Version:1737128747316477954 MergeVersions:map[] PreviousVersions:map[]},
}
body:map[action:create activePeer:cbs2 topology:CBL<->SG<->CBS1 CBS1<->CBS2 1.2]
====
peer(cbl1)
----
DocMetadata{
DocID: "doc_MultiActorConflictUpdate_CBL<->SG<->CBS1_CBS1<->CBS2_1.2",
RevTreeID:"",
HLV:&{CurrentVersionCAS:0 SourceID:btc-1637909658 Version:1737128747332999800 MergeVersions:map[] PreviousVersions:map[OlUhb6OA1d92WM6yhzsbDg:1737128747316477954]},
Mou:<nil>,
Cas:0,
ImplicitHLV:&{CurrentVersionCAS:0 SourceID:btc-1637909658 Version:1737128747332999800 MergeVersions:map[] PreviousVersions:map[OlUhb6OA1d92WM6yhzsbDg:1737128747316477954]},
}
body:map[action:create activePeer:cbl1 topology:CBL<->SG<->CBS1 CBS1<->CBS2 1.2]
hlv_test.go:90:
Error Trace: D:/a/sync_gateway/sync_gateway/topologytest/hlv_test.go:90
D:/a/sync_gateway/sync_gateway/topologytest/multi_actor_conflict_test.go:51
Error: Peers did not converge on version
Test: TestMultiActorConflictUpdate/CBL<->SG<->CBS1_CBS1<->CBS2_1.2
|
Run Tests
Process completed with exit code 1.
|
Loading