Skip to content

Instantly share code, notes, and snippets.

@bbrks

bbrks/failing

Created January 6, 2020 20:58
Show Gist options
  • Save bbrks/6eb7f1572b928bdcd1c81ec4e6edb420 to your computer and use it in GitHub Desktop.
Save bbrks/6eb7f1572b928bdcd1c81ec4e6edb420 to your computer and use it in GitHub Desktop.
Download ZIP
CBG-656 logs
Raw
failing
=== RUN TestBlipPushRevisionInspectChanges
2019-12-31T20:37:06.777Z [INF] rest.TestBlipPushRevisionInspectChanges: Setup logging: level: debug - keys: *
2019-12-31T20:37:06.777Z [INF] Auth: Attempting credential authentication couchbase://127.0.0.1?http_idle_conn_timeout=90000&http_max_idle_conns=64000&http_max_idle_conns_per_host=256&kv_pool_size=2&n1ql_timeout=75000&operation_tracing=false
2019-12-31T20:37:06.779Z [INF] Successfully opened bucket test_data_bucket
2019-12-31T20:37:06.781Z [INF] Set query timeouts for bucket test_data_bucket to cluster:1m15s, bucket:1m15s
2019-12-31T20:37:06.781Z [INF] Flushing bucket test_data_bucket
2019-12-31T20:37:07.451Z [INF] GoCBCustomSGTranscoder Opening Couchbase database test_data_bucket on <couchbase://127.0.0.1> as user "test_data_bucket"
2019-12-31T20:37:07.451Z [INF] Auth: Attempting credential authentication couchbase://127.0.0.1?http_idle_conn_timeout=90000&http_max_idle_conns=64000&http_max_idle_conns_per_host=256&kv_pool_size=2&n1ql_timeout=75000&operation_tracing=false
2019-12-31T20:37:07.453Z [INF] Successfully opened bucket test_data_bucket
2019-12-31T20:37:07.457Z [INF] Set query timeouts for bucket test_data_bucket to cluster:1m15s, bucket:1m15s
2019-12-31T20:37:07.457Z [INF] Logging stats with frequency: 1m0s
2019-12-31T20:37:07.457Z [INF] Opening db /db as bucket "test_data_bucket", pool "default", server <couchbase://127.0.0.1>
2019-12-31T20:37:07.457Z [INF] GoCBCustomSGTranscoder Opening Couchbase database test_data_bucket on <couchbase://127.0.0.1> as user "test_data_bucket"
2019-12-31T20:37:07.457Z [INF] Auth: Attempting credential authentication couchbase://127.0.0.1?http_idle_conn_timeout=90000&http_max_idle_conns=64000&http_max_idle_conns_per_host=256&kv_pool_size=2&n1ql_timeout=75000&operation_tracing=false
2019-12-31T20:37:07.458Z [INF] Successfully opened bucket test_data_bucket
2019-12-31T20:37:07.460Z [INF] Set query timeouts for bucket test_data_bucket to cluster:1m15s, bucket:1m15s
2019-12-31T20:37:07.460Z [INF] Initializing indexes with numReplicas: 0...
2019-12-31T20:37:07.524Z [INF] Verifying index availability for bucket test_data_bucket...
2019-12-31T20:37:07.524Z [DBG] Query+: Verifying index availability for index sg_roleAccess_x1...
2019-12-31T20:37:07.524Z [DBG] Query+: Verifying index availability for index sg_channels_x1...
2019-12-31T20:37:07.524Z [DBG] Query+: Verifying index availability for index sg_access_x1...
2019-12-31T20:37:07.528Z [DBG] Query+: Index sg_access_x1 verified as ready
2019-12-31T20:37:07.528Z [DBG] Query+: Index sg_roleAccess_x1 verified as ready
2019-12-31T20:37:07.531Z [DBG] Query+: Index sg_channels_x1 verified as ready
2019-12-31T20:37:07.531Z [INF] Indexes ready for bucket test_data_bucket.
2019-12-31T20:37:07.531Z [INF] delta_sync enabled=false with rev_max_age_seconds=86400 for database db
2019-12-31T20:37:07.531Z [INF] Created background task: "CleanAgedItems" with interval 1m0s
2019-12-31T20:37:07.531Z [DBG] Cache+: Initialized channel cache with maxChannels:50000, HWM: 40000, LWM: 30000
2019-12-31T20:37:07.531Z [INF] Cache: Initializing changes cache for database db with options {ChannelCacheOptions:{ChannelCacheMinLength:50 ChannelCacheMaxLength:500 ChannelCacheAge:1m0s MaxNumChannels:50000 CompactHighWatermarkPercent:80 CompactLowWatermarkPercent:60} CachePendingSeqMaxWait:5s CachePendingSeqMaxNum:10000 CacheSkippedSeqMaxWait:1h0m0s}
2019-12-31T20:37:07.531Z [INF] Created background task: "InsertPendingEntries" with interval 2.5s
2019-12-31T20:37:07.531Z [INF] Created background task: "CleanSkippedSequenceQueue" with interval 30m0s
2019-12-31T20:37:07.531Z [INF] DCP: Attempting to start import DCP feed...
2019-12-31T20:37:07.531Z [INF] DCP: Registering PindexImplType for syncGateway-import-db
2019-12-31T20:37:07.531Z [INF] DCP: Starting DCP import feed for bucket: "test_data_bucket"
2019-12-31T20:37:07.531Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: nodeDefs-known, cas: 0
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T20:37:07.532Z [INF] DCP: manager: setting the nodeDefs implVersion to 5.5.0
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Set, key: nodeDefs-known, cas: 0
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: FireEvent, key: nodeDefs-known, cas 1577824627532234752
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: nodeDefs-wanted, cas: 0
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T20:37:07.532Z [INF] DCP: manager: setting the nodeDefs implVersion to 5.5.0
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Set, key: nodeDefs-wanted, cas: 0
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: FireEvent, key: nodeDefs-wanted, cas 1577824627532627968
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T20:37:07.532Z [INF] DCP: planner: awakes, op: kick, msg: start
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: indexDefs
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: planPIndexes
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: nodeDefs-wanted
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: curMetaKvPlanKey
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: indexDefs
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: planPIndexes
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: curMetaKvPlanKey
2019-12-31T20:37:07.532Z [INF] DCP: janitor: awakes, op: kick, msg: start
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: nodeDefs-wanted
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: nodeDefs-known
2019-12-31T20:37:07.532Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: nodeDefs-wanted
2019-12-31T20:37:07.532Z [INF] DCP: planner: once, reason: start
2019-12-31T20:37:07.533Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T20:37:07.533Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T20:37:07.533Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T20:37:07.533Z [INF] DCP: janitor: JanitorOnce, err: janitor: skipped on nil planPIndexes
2019-12-31T20:37:07.533Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T20:37:07.533Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Set, key: version, cas: 0
2019-12-31T20:37:07.533Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Set, key: indexDefs, cas: 0
2019-12-31T20:37:07.533Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: FireEvent, key: version, cas 1577824627533283328
2019-12-31T20:37:07.533Z [INF] DCP: version: CheckVersion, Cfg version updated 5.5.0
2019-12-31T20:37:07.533Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T20:37:07.533Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: FireEvent, key: indexDefs, cas 1577824627533414400
2019-12-31T20:37:07.533Z [INF] DCP: manager_api: index definition created, indexType: syncGateway-import-db, indexName: db_import, indexUUID: 6270e0db436ffd9b
2019-12-31T20:37:07.533Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T20:37:07.533Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T20:37:07.533Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T20:37:07.533Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: nodeDefs-wanted, cas: 0
2019-12-31T20:37:07.533Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T20:37:07.534Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T20:37:07.534Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T20:37:07.535Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Set, key: planPIndexes, cas: 0
2019-12-31T20:37:07.536Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: FireEvent, key: planPIndexes, cas 1577824627536101376
2019-12-31T20:37:07.536Z [INF] DCP: janitor: awakes, op: kick, msg: the plans have changed
2019-12-31T20:37:07.536Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T20:37:07.536Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T20:37:07.537Z [INF] DCP: janitor: pindexes to remove: 0
2019-12-31T20:37:07.537Z [INF] DCP: janitor: pindexes to add: 16
2019-12-31T20:37:07.537Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_103fc5fb UUID:728ecc08a42e0ef5 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:768,769,770,771,772,773,774,775,776,777,778,779,780,781,782,783,784,785,786,787,788,789,790,791,792,793,794,795,796,797,798,799,800,801,802,803,804,805,806,807,808,809,810,811,812,813,814,815,816,817,818,819,820,821,822,823,824,825,826,827,828,829,830,831 Nodes:map[3fd04174d93b1b77:0xc054ad12b0]}
2019-12-31T20:37:07.537Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_15a93994 UUID:6119f128e8e67564 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:640,641,642,643,644,645,646,647,648,649,650,651,652,653,654,655,656,657,658,659,660,661,662,663,664,665,666,667,668,669,670,671,672,673,674,675,676,677,678,679,680,681,682,683,684,685,686,687,688,689,690,691,692,693,694,695,696,697,698,699,700,701,702,703 Nodes:map[3fd04174d93b1b77:0xc054ad1700]}
2019-12-31T20:37:07.537Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_1d526e8f UUID:66d640110ee17fa8 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:960,961,962,963,964,965,966,967,968,969,970,971,972,973,974,975,976,977,978,979,980,981,982,983,984,985,986,987,988,989,990,991,992,993,994,995,996,997,998,999,1000,1001,1002,1003,1004,1005,1006,1007,1008,1009,1010,1011,1012,1013,1014,1015,1016,1017,1018,1019,1020,1021,1022,1023 Nodes:map[3fd04174d93b1b77:0xc054ad1870]}
2019-12-31T20:37:07.537Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_80d40edf UUID:3c4030364e9b7548 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:256,257,258,259,260,261,262,263,264,265,266,267,268,269,270,271,272,273,274,275,276,277,278,279,280,281,282,283,284,285,286,287,288,289,290,291,292,293,294,295,296,297,298,299,300,301,302,303,304,305,306,307,308,309,310,311,312,313,314,315,316,317,318,319 Nodes:map[3fd04174d93b1b77:0xc054b0c280]}
2019-12-31T20:37:07.538Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_acbbef99 UUID:4e7f698b30130b8e IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63 Nodes:map[3fd04174d93b1b77:0xc054b0c6d0]}
2019-12-31T20:37:07.538Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_5b084477 UUID:5228d1caf31798f3 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:704,705,706,707,708,709,710,711,712,713,714,715,716,717,718,719,720,721,722,723,724,725,726,727,728,729,730,731,732,733,734,735,736,737,738,739,740,741,742,743,744,745,746,747,748,749,750,751,752,753,754,755,756,757,758,759,760,761,762,763,764,765,766,767 Nodes:map[3fd04174d93b1b77:0xc054ad1cc0]}
2019-12-31T20:37:07.538Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_7dc1913f UUID:4f2776a456bcdaa6 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:512,513,514,515,516,517,518,519,520,521,522,523,524,525,526,527,528,529,530,531,532,533,534,535,536,537,538,539,540,541,542,543,544,545,546,547,548,549,550,551,552,553,554,555,556,557,558,559,560,561,562,563,564,565,566,567,568,569,570,571,572,573,574,575 Nodes:map[3fd04174d93b1b77:0xc054b0c110]}
2019-12-31T20:37:07.538Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_120a6de6 UUID:3604c8ff337a17a7 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:64,65,66,67,68,69,70,71,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,120,121,122,123,124,125,126,127 Nodes:map[3fd04174d93b1b77:0xc054ad1590]}
2019-12-31T20:37:07.538Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_56a5d570 UUID:1a45955ca42189f0 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:896,897,898,899,900,901,902,903,904,905,906,907,908,909,910,911,912,913,914,915,916,917,918,919,920,921,922,923,924,925,926,927,928,929,930,931,932,933,934,935,936,937,938,939,940,941,942,943,944,945,946,947,948,949,950,951,952,953,954,955,956,957,958,959 Nodes:map[3fd04174d93b1b77:0xc054ad1b50]}
2019-12-31T20:37:07.538Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_627da171 UUID:49e161a060e117d4 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:832,833,834,835,836,837,838,839,840,841,842,843,844,845,846,847,848,849,850,851,852,853,854,855,856,857,858,859,860,861,862,863,864,865,866,867,868,869,870,871,872,873,874,875,876,877,878,879,880,881,882,883,884,885,886,887,888,889,890,891,892,893,894,895 Nodes:map[3fd04174d93b1b77:0xc054ad1e30]}
2019-12-31T20:37:07.538Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_84003db0 UUID:27688668a6f6dba7 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:448,449,450,451,452,453,454,455,456,457,458,459,460,461,462,463,464,465,466,467,468,469,470,471,472,473,474,475,476,477,478,479,480,481,482,483,484,485,486,487,488,489,490,491,492,493,494,495,496,497,498,499,500,501,502,503,504,505,506,507,508,509,510,511 Nodes:map[3fd04174d93b1b77:0xc054b0c3f0]}
2019-12-31T20:37:07.538Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_1076212c UUID:430ba7e5f513d93f IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:384,385,386,387,388,389,390,391,392,393,394,395,396,397,398,399,400,401,402,403,404,405,406,407,408,409,410,411,412,413,414,415,416,417,418,419,420,421,422,423,424,425,426,427,428,429,430,431,432,433,434,435,436,437,438,439,440,441,442,443,444,445,446,447 Nodes:map[3fd04174d93b1b77:0xc054ad1420]}
2019-12-31T20:37:07.538Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_244a4eff UUID:6e74a36263c9e2e8 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:576,577,578,579,580,581,582,583,584,585,586,587,588,589,590,591,592,593,594,595,596,597,598,599,600,601,602,603,604,605,606,607,608,609,610,611,612,613,614,615,616,617,618,619,620,621,622,623,624,625,626,627,628,629,630,631,632,633,634,635,636,637,638,639 Nodes:map[3fd04174d93b1b77:0xc054ad19e0]}
2019-12-31T20:37:07.538Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_7332d0c7 UUID:709a54a856493807 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191 Nodes:map[3fd04174d93b1b77:0xc054ad1fa0]}
2019-12-31T20:37:07.538Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_96da5535 UUID:2071130da87526f2 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:320,321,322,323,324,325,326,327,328,329,330,331,332,333,334,335,336,337,338,339,340,341,342,343,344,345,346,347,348,349,350,351,352,353,354,355,356,357,358,359,360,361,362,363,364,365,366,367,368,369,370,371,372,373,374,375,376,377,378,379,380,381,382,383 Nodes:map[3fd04174d93b1b77:0xc054b0c560]}
2019-12-31T20:37:07.538Z [INF] DCP: &{Name:db_import_6270e0db436ffd9b_f47365c5 UUID:71a716083200f001 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:6270e0db436ffd9b IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:fdd16d0dd1ba1d96dee9ad84234095b9 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:192,193,194,195,196,197,198,199,200,201,202,203,204,205,206,207,208,209,210,211,212,213,214,215,216,217,218,219,220,221,222,223,224,225,226,227,228,229,230,231,232,233,234,235,236,237,238,239,240,241,242,243,244,245,246,247,248,249,250,251,252,253,254,255 Nodes:map[3fd04174d93b1b77:0xc054b0c840]}
2019-12-31T20:37:07.538Z [INF] DCP: janitor: pindexes to restart: 0
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:1
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:2
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:4
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:5
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:6
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:7
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:9
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:10
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:11
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:12
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:14
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:15
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:13
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:16
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:8
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:3
2019-12-31T20:37:07.538Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T20:37:07.538Z [INF] DCP: janitor: feeds to remove: 0
2019-12-31T20:37:07.538Z [INF] DCP: janitor: feeds to add: 16
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_1d526e8f
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_5b084477
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_7dc1913f
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_96da5535
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_80d40edf
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_1076212c
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_f47365c5
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_7332d0c7
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_103fc5fb
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_627da171
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_acbbef99
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_84003db0
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_56a5d570
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_120a6de6
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_15a93994
2019-12-31T20:37:07.538Z [INF] DCP: db_import_6270e0db436ffd9b_244a4eff
2019-12-31T20:37:07.538Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_1d526e8f, indexName: db_import
2019-12-31T20:37:07.538Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_1d526e8f
2019-12-31T20:37:07.539Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_1d526e8f registered for tls config updates
2019-12-31T20:37:07.539Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_5b084477, indexName: db_import
2019-12-31T20:37:07.539Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_5b084477
2019-12-31T20:37:07.539Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_5b084477 registered for tls config updates
2019-12-31T20:37:07.539Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_7dc1913f, indexName: db_import
2019-12-31T20:37:07.539Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_7dc1913f
2019-12-31T20:37:07.539Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_7dc1913f registered for tls config updates
2019-12-31T20:37:07.539Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_96da5535, indexName: db_import
2019-12-31T20:37:07.539Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_96da5535
2019-12-31T20:37:07.539Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_96da5535 registered for tls config updates
2019-12-31T20:37:07.539Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_80d40edf, indexName: db_import
2019-12-31T20:37:07.539Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_80d40edf
2019-12-31T20:37:07.539Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_80d40edf registered for tls config updates
2019-12-31T20:37:07.539Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_1076212c, indexName: db_import
2019-12-31T20:37:07.540Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_1076212c
2019-12-31T20:37:07.540Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_1076212c registered for tls config updates
2019-12-31T20:37:07.540Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_f47365c5, indexName: db_import
2019-12-31T20:37:07.540Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_f47365c5
2019-12-31T20:37:07.540Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_f47365c5 registered for tls config updates
2019-12-31T20:37:07.540Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_7332d0c7, indexName: db_import
2019-12-31T20:37:07.540Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_7332d0c7
2019-12-31T20:37:07.540Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_7332d0c7 registered for tls config updates
2019-12-31T20:37:07.540Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_103fc5fb, indexName: db_import
2019-12-31T20:37:07.540Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_103fc5fb
2019-12-31T20:37:07.541Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_103fc5fb registered for tls config updates
2019-12-31T20:37:07.541Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_627da171, indexName: db_import
2019-12-31T20:37:07.541Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_627da171
2019-12-31T20:37:07.541Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_627da171 registered for tls config updates
2019-12-31T20:37:07.541Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_acbbef99, indexName: db_import
2019-12-31T20:37:07.541Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_acbbef99
2019-12-31T20:37:07.541Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_acbbef99 registered for tls config updates
2019-12-31T20:37:07.541Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_84003db0, indexName: db_import
2019-12-31T20:37:07.541Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_84003db0
2019-12-31T20:37:07.541Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_84003db0 registered for tls config updates
2019-12-31T20:37:07.541Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_56a5d570, indexName: db_import
2019-12-31T20:37:07.541Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_56a5d570
2019-12-31T20:37:07.541Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_56a5d570 registered for tls config updates
2019-12-31T20:37:07.541Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_120a6de6, indexName: db_import
2019-12-31T20:37:07.541Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_120a6de6
2019-12-31T20:37:07.541Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_120a6de6 registered for tls config updates
2019-12-31T20:37:07.542Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_15a93994, indexName: db_import
2019-12-31T20:37:07.542Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_15a93994
2019-12-31T20:37:07.542Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_15a93994 registered for tls config updates
2019-12-31T20:37:07.542Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_6270e0db436ffd9b_244a4eff, indexName: db_import
2019-12-31T20:37:07.542Z [INF] DCP: feed_dcp: start, name: db_import_6270e0db436ffd9b_244a4eff
2019-12-31T20:37:07.542Z [INF] DCP: cbauth: key: DCPFeed_db_import_6270e0db436ffd9b_244a4eff registered for tls config updates
2019-12-31T20:37:07.542Z [INF] DCP: janitor: awakes, op: kick, msg: cfg changed, key: planPIndexes
2019-12-31T20:37:07.542Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T20:37:07.542Z [INF] DCP: planner: awakes, op: kick, msg: cfg changed, key: indexDefs
2019-12-31T20:37:07.542Z [INF] DCP: planner: once, reason: cfg changed, key: indexDefs
2019-12-31T20:37:07.542Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T20:37:07.543Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T20:37:07.543Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: nodeDefs-wanted, cas: 0
2019-12-31T20:37:07.543Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T20:37:07.543Z [INF] DCP: janitor: pindexes to remove: 0
2019-12-31T20:37:07.543Z [INF] DCP: janitor: pindexes to add: 0
2019-12-31T20:37:07.543Z [INF] DCP: janitor: pindexes to restart: 0
2019-12-31T20:37:07.544Z [INF] DCP: janitor: feeds to remove: 0
2019-12-31T20:37:07.544Z [INF] DCP: janitor: feeds to add: 0
2019-12-31T20:37:07.544Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T20:37:07.544Z [INF] DCP: planner: awakes, op: kick, msg: api/CreateIndex, indexName: db_import
2019-12-31T20:37:07.544Z [INF] DCP: planner: once, reason: api/CreateIndex, indexName: db_import
2019-12-31T20:37:07.544Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T20:37:07.544Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T20:37:07.544Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: nodeDefs-wanted, cas: 0
2019-12-31T20:37:07.544Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T20:37:07.545Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T20:37:07.546Z [INF] DCP: planner: awakes, op: kick, msg: NewIndexesCreated
2019-12-31T20:37:07.546Z [INF] DCP: planner: once, reason: NewIndexesCreated
2019-12-31T20:37:07.546Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T20:37:07.546Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T20:37:07.546Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: nodeDefs-wanted, cas: 0
2019-12-31T20:37:07.546Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T20:37:07.548Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T20:37:07.548Z [INF] DCP: janitor: awakes, op: kick, msg: NewIndexesCreated
2019-12-31T20:37:07.548Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T20:37:07.549Z [INF] DCP: janitor: pindexes to remove: 0
2019-12-31T20:37:07.549Z [INF] DCP: janitor: pindexes to add: 0
2019-12-31T20:37:07.549Z [INF] DCP: janitor: pindexes to restart: 0
2019-12-31T20:37:07.549Z [INF] DCP: janitor: feeds to remove: 0
2019-12-31T20:37:07.549Z [INF] DCP: janitor: feeds to add: 0
2019-12-31T20:37:07.549Z [INF] DCP: Initialized sharded DCP feed db_import with 16 partitions.
2019-12-31T20:37:07.549Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: nodeDefs-known, cas: 0
2019-12-31T20:37:07.549Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: nodeDefs-known
2019-12-31T20:37:07.549Z [DBG] DCP+: Sending CBGT node heartbeats at interval: 1s
2019-12-31T20:37:07.550Z [DBG] DCP+: Checking heartbeats for nodes: [3fd04174d93b1b77]
2019-12-31T20:37:07.550Z [DBG] DCP+: Checking CBGT node heartbeats with stale threshold: 10000 ms
2019-12-31T20:37:07.550Z [INF] DCP: Starting mutation feed on bucket test_data_bucket due to either channel cache mode or doc tracking (auto-import)
2019-12-31T20:37:07.550Z [INF] DCP: Using DCP feed for bucket: "test_data_bucket" (based on feed_type specified in config file)
2019-12-31T20:37:07.550Z [INF] DCP: c:test_data_bucket-SG Using DCP Logging Receiver
2019-12-31T20:37:07.563Z [DBG] DCP+: Initializing DCP with no backfill - seeding seqnos: map[39:1 272:1 314:1 507:1 633:1 925:1]
2019-12-31T20:37:07.563Z [INF] DCP: c:test_data_bucket-SG DCP feed starting with name SG-v-2.8-commit--uuid-4ff14884-2c0d-11ea-974d-80e650054dfa
2019-12-31T20:37:07.563Z [DBG] DCP+: c:test_data_bucket-SG Connecting to new bucket datasource. URLs:[ http://127.0.0.1:8091 ], pool:default, bucket:test_data_bucket
2019-12-31T20:37:07.580Z [INF] Using metadata purge interval of 3.00 days for tombstone compaction.
2019-12-31T20:37:07.580Z [INF] Created background task: "Compact" with interval 24h0m0s
2019-12-31T20:37:07.582Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.582Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_5b084477-38aa1199, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.582Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_5b084477-38aa1199, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.583Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_5b084477-38aa1199, capacity: 20
2019-12-31T20:37:07.593Z [INF] Using default sync function 'channel(doc.channels)' for database "db"
2019-12-31T20:37:07.594Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_5b084477-38aa1199, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 704-767
2019-12-31T20:37:07.594Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_5b084477-38aa1199, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 704-767
2019-12-31T20:37:07.594Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_5b084477-38aa1199, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 704-767
2019-12-31T20:37:07.594Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_5b084477-38aa1199, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 704-767
2019-12-31T20:37:07.594Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_5b084477-38aa1199, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 704-767
2019-12-31T20:37:07.597Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.597Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_1d526e8f-b8efee2, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.597Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_1d526e8f-b8efee2, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.597Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_1d526e8f-b8efee2, capacity: 20
2019-12-31T20:37:07.599Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.599Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.599Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_96da5535-5d2c629e, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.599Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_96da5535-5d2c629e, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.599Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_96da5535-5d2c629e, capacity: 20
2019-12-31T20:37:07.599Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7dc1913f-79fb78d4, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.599Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7dc1913f-79fb78d4, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.599Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_7dc1913f-79fb78d4, capacity: 20
2019-12-31T20:37:07.599Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.600Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_1076212c-2a83ff13, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.600Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_1076212c-2a83ff13, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.600Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_1076212c-2a83ff13, capacity: 20
2019-12-31T20:37:07.609Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.609Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_627da171-3313076e, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.609Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_627da171-3313076e, capacity: 20
2019-12-31T20:37:07.609Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_627da171-3313076e, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.609Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.609Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_56a5d570-3379e232, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.609Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_56a5d570-3379e232, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.609Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_56a5d570-3379e232, capacity: 20
2019-12-31T20:37:07.610Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_1d526e8f-b8efee2, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 960-1023
2019-12-31T20:37:07.610Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_1d526e8f-b8efee2, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 960-1023
2019-12-31T20:37:07.610Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_1d526e8f-b8efee2, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 960-1023
2019-12-31T20:37:07.610Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_1d526e8f-b8efee2, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 960-1023
2019-12-31T20:37:07.610Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_1d526e8f-b8efee2, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 960-1023
2019-12-31T20:37:07.611Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7dc1913f-79fb78d4, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 512-575
2019-12-31T20:37:07.611Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7dc1913f-79fb78d4, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 512-575
2019-12-31T20:37:07.611Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7dc1913f-79fb78d4, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 512-575
2019-12-31T20:37:07.611Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7dc1913f-79fb78d4, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 512-575
2019-12-31T20:37:07.611Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7dc1913f-79fb78d4, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 512-575
2019-12-31T20:37:07.612Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_1076212c-2a83ff13, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 384-447
2019-12-31T20:37:07.612Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_1076212c-2a83ff13, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 384-447
2019-12-31T20:37:07.612Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_1076212c-2a83ff13, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 384-447
2019-12-31T20:37:07.612Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_1076212c-2a83ff13, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 384-447
2019-12-31T20:37:07.612Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_1076212c-2a83ff13, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 384-447
2019-12-31T20:37:07.612Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_96da5535-5d2c629e, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 320-383
2019-12-31T20:37:07.612Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_96da5535-5d2c629e, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 320-383
2019-12-31T20:37:07.612Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_96da5535-5d2c629e, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 320-383
2019-12-31T20:37:07.612Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_96da5535-5d2c629e, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 320-383
2019-12-31T20:37:07.612Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_96da5535-5d2c629e, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 320-383
2019-12-31T20:37:07.614Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.615Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.615Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.615Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_80d40edf-f94c671, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.615Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_80d40edf-f94c671, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.615Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_80d40edf-f94c671, capacity: 20
2019-12-31T20:37:07.615Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_244a4eff-3cd07adc, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.615Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_244a4eff-3cd07adc, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.615Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_244a4eff-3cd07adc, capacity: 20
2019-12-31T20:37:07.615Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_f47365c5-701cc3d4, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.615Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_f47365c5-701cc3d4, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.615Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_f47365c5-701cc3d4, capacity: 20
2019-12-31T20:37:07.617Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.617Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.617Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.617Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.617Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.617Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.617Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T20:37:07.617Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_acbbef99-604eeff, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.617Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_acbbef99-604eeff, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.617Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_acbbef99-604eeff, capacity: 20
2019-12-31T20:37:07.618Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-4ff14884-2c0d-11ea-974d-80e650054dfa, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.618Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-4ff14884-2c0d-11ea-974d-80e650054dfa, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.618Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: SG-v-2.8-commit--uuid-4ff14884-2c0d-11ea-974d-80e650054dfa, capacity: 200
2019-12-31T20:37:07.618Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_84003db0-1137bbe8, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.618Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_84003db0-1137bbe8, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.618Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_84003db0-1137bbe8, capacity: 20
2019-12-31T20:37:07.618Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_120a6de6-3bb1198d, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.618Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_120a6de6-3bb1198d, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.618Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_120a6de6-3bb1198d, capacity: 20
2019-12-31T20:37:07.618Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_103fc5fb-15be8d9d, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.618Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_103fc5fb-15be8d9d, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.618Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_103fc5fb-15be8d9d, capacity: 20
2019-12-31T20:37:07.618Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7332d0c7-57f4b743, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.618Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7332d0c7-57f4b743, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.618Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_7332d0c7-57f4b743, capacity: 20
2019-12-31T20:37:07.619Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_15a93994-4048c5d6, worker, looping beg, vbucketStates empty
2019-12-31T20:37:07.619Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_15a93994-4048c5d6, refreshWorker-prior, vbucketStates empty
2019-12-31T20:37:07.619Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_15a93994-4048c5d6, capacity: 20
2019-12-31T20:37:07.620Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_627da171-3313076e, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 832-895
2019-12-31T20:37:07.620Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_627da171-3313076e, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 832-895
2019-12-31T20:37:07.620Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_627da171-3313076e, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 832-895
2019-12-31T20:37:07.620Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_627da171-3313076e, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 832-895
2019-12-31T20:37:07.620Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_627da171-3313076e, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 832-895
2019-12-31T20:37:07.622Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_56a5d570-3379e232, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 896-959
2019-12-31T20:37:07.622Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_56a5d570-3379e232, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 896-959
2019-12-31T20:37:07.622Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_56a5d570-3379e232, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 896-959
2019-12-31T20:37:07.622Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_56a5d570-3379e232, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 896-959
2019-12-31T20:37:07.622Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_56a5d570-3379e232, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 896-959
2019-12-31T20:37:07.626Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-4ff14884-2c0d-11ea-974d-80e650054dfa, refreshWorker-after, vbucketState: "requested" (has 1024 vbuckets), 0-1023
2019-12-31T20:37:07.626Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-4ff14884-2c0d-11ea-974d-80e650054dfa, worker, looping beg, vbucketState: "requested" (has 1024 vbuckets), 0-1023
2019-12-31T20:37:07.627Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-4ff14884-2c0d-11ea-974d-80e650054dfa, refreshWorker-prior, vbucketState: "requested" (has 1024 vbuckets), 0-1023
2019-12-31T20:37:07.627Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-4ff14884-2c0d-11ea-974d-80e650054dfa, refreshWorker-after, vbucketState: "requested" (has 1024 vbuckets), 0-1023
2019-12-31T20:37:07.627Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-4ff14884-2c0d-11ea-974d-80e650054dfa, worker, looping beg, vbucketState: "requested" (has 1024 vbuckets), 0-1023
2019-12-31T20:37:07.634Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_f47365c5-701cc3d4, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 192-255
2019-12-31T20:37:07.634Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_f47365c5-701cc3d4, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 192-255
2019-12-31T20:37:07.634Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_f47365c5-701cc3d4, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 192-255
2019-12-31T20:37:07.634Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_f47365c5-701cc3d4, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 192-255
2019-12-31T20:37:07.634Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_f47365c5-701cc3d4, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 192-255
2019-12-31T20:37:07.636Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_244a4eff-3cd07adc, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 576-639
2019-12-31T20:37:07.636Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_244a4eff-3cd07adc, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 576-639
2019-12-31T20:37:07.636Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_244a4eff-3cd07adc, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 576-639
2019-12-31T20:37:07.636Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_244a4eff-3cd07adc, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 576-639
2019-12-31T20:37:07.636Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_244a4eff-3cd07adc, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 576-639
2019-12-31T20:37:07.636Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_80d40edf-f94c671, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 256-319
2019-12-31T20:37:07.636Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_80d40edf-f94c671, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 256-319
2019-12-31T20:37:07.636Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_80d40edf-f94c671, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 256-319
2019-12-31T20:37:07.636Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_80d40edf-f94c671, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 256-319
2019-12-31T20:37:07.636Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_80d40edf-f94c671, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 256-319
2019-12-31T20:37:07.639Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_acbbef99-604eeff, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 0-63
2019-12-31T20:37:07.639Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_acbbef99-604eeff, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 0-63
2019-12-31T20:37:07.639Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_acbbef99-604eeff, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 0-63
2019-12-31T20:37:07.639Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_acbbef99-604eeff, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 0-63
2019-12-31T20:37:07.639Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_acbbef99-604eeff, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 0-63
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_103fc5fb-15be8d9d, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 768-831
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_103fc5fb-15be8d9d, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 768-831
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_103fc5fb-15be8d9d, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 768-831
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_103fc5fb-15be8d9d, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 768-831
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_103fc5fb-15be8d9d, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 768-831
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_15a93994-4048c5d6, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 640-703
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_15a93994-4048c5d6, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 640-703
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_15a93994-4048c5d6, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 640-703
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_15a93994-4048c5d6, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 640-703
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_15a93994-4048c5d6, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 640-703
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_84003db0-1137bbe8, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 448-511
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_84003db0-1137bbe8, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 448-511
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7332d0c7-57f4b743, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 128-191
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_84003db0-1137bbe8, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 448-511
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7332d0c7-57f4b743, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 128-191
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7332d0c7-57f4b743, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 128-191
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_84003db0-1137bbe8, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 448-511
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_84003db0-1137bbe8, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 448-511
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7332d0c7-57f4b743, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 128-191
2019-12-31T20:37:07.640Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7332d0c7-57f4b743, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 128-191
2019-12-31T20:37:07.641Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_120a6de6-3bb1198d, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 64-127
2019-12-31T20:37:07.641Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_120a6de6-3bb1198d, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 64-127
2019-12-31T20:37:07.641Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_120a6de6-3bb1198d, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 64-127
2019-12-31T20:37:07.641Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_120a6de6-3bb1198d, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 64-127
2019-12-31T20:37:07.641Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_120a6de6-3bb1198d, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 64-127
2019-12-31T20:37:08.994Z [INF] WaitForIndexEmpty found 0 results. GSI index appears to be empty.
2019-12-31T20:37:08.994Z [INF] Auth: Saved principal w/ name:, seq: #0
2019-12-31T20:37:08.994Z [DBG] Changes+: Notifying that "test_data_bucket" changed (keys="{_sync:user:}") count=2
2019-12-31T20:37:08.996Z [INF] HTTP: #4091: GET /db/_blipsync
2019-12-31T20:37:08.996Z [WRN] QueryAccess called with empty username - returning empty result iterator -- db.(*DatabaseContext).QueryAccess() at query.go:257
2019-12-31T20:37:08.996Z [INF] Access: Recomputed channels for "": !:1,*:1
2019-12-31T20:37:08.996Z [WRN] QueryRoleAccess called with empty username -- db.(*DatabaseContext).QueryRoleAccess() at query.go:288
2019-12-31T20:37:08.996Z [INF] Access: Computed roles for "":
2019-12-31T20:37:08.996Z [INF] HTTP+: #4091: --> 101 [c60e77b] Upgraded to BLIP+WebSocket protocol (as GUEST) (0.0 ms)
2019-12-31T20:37:08.996Z [INF] WS: c:[c60e77b] Start BLIP/Websocket handler
2019-12-31T20:37:08.996Z [DBG] WS+: c:[c60e77b] Sender starting
2019-12-31T20:37:08.996Z [DBG] WSFrame+: c:[1fa682f0] Queued MSG#1
2019-12-31T20:37:08.996Z [DBG] Changes+: Notifying that "test_data_bucket" changed (keys="{_sync:user:}") count=3
2019-12-31T20:37:08.996Z [DBG] WS+: c:[1fa682f0] Push MSG#1
2019-12-31T20:37:08.996Z [DBG] WS+: c:[1fa682f0] Sender starting
2019-12-31T20:37:08.996Z [DBG] WS+: c:[1fa682f0] Sending frame: MSG#1 (flags= 0, size= 47)
2019-12-31T20:37:08.997Z [DBG] WS+: c:[c60e77b] Received frame: MSG#1 (flags= 0, length=47)
2019-12-31T20:37:08.997Z [DBG] WSFrame+: c:[c60e77b] Incoming BLIP Request: MSG#1
2019-12-31T20:37:08.997Z [INF] SyncMsg: c:[c60e77b] #1: Type:changes #Changes:1
2019-12-31T20:37:08.997Z [DBG] CRUD+: No document found for key=foo
2019-12-31T20:37:08.997Z [DBG] SyncMsg+: c:[c60e77b] #1: Type:changes --> OK Time:261.001µs
2019-12-31T20:37:08.997Z [DBG] WS+: c:[c60e77b] Push RPY#1~
2019-12-31T20:37:08.997Z [DBG] WS+: c:[c60e77b] Sending frame: RPY#1~ (flags= 1001, size= 5)
2019-12-31T20:37:08.997Z [DBG] WS+: c:[1fa682f0] Received frame: RPY#1~ (flags= 1001, length=7)
2019-12-31T20:37:08.997Z [DBG] WSFrame+: c:[1fa682f0] Queued MSG#2~
2019-12-31T20:37:08.997Z [DBG] WS+: c:[1fa682f0] Push MSG#2~
2019-12-31T20:37:08.997Z [DBG] WS+: c:[1fa682f0] Sending frame: MSG#2~ (flags= 1000, size= 58)
2019-12-31T20:37:08.997Z [DBG] WS+: c:[c60e77b] Received frame: MSG#2~ (flags= 1000, length=57)
2019-12-31T20:37:08.997Z [DBG] WSFrame+: c:[c60e77b] Incoming BLIP Request: MSG#2~
2019-12-31T20:37:08.997Z [DBG] SyncMsg+: c:[c60e77b] #2: Type:rev Id:foo Rev:1-abc Deleted:false
2019-12-31T20:37:08.998Z [DBG] CRUD+: c:[c60e77b] Invoking sync on doc "foo" rev 1-abc
2019-12-31T20:37:08.998Z [DBG] CRUD+: Backed up revision body "foo"/"" (0 bytes, ttl:300)
2019-12-31T20:37:08.998Z [DBG] CRUD+: c:[c60e77b] Saving doc (seq: #1, id: foo rev: 1-abc)
2019-12-31T20:37:08.998Z [DBG] CRUD+: c:[c60e77b] Stored doc "foo" / "1-abc" as #1
2019-12-31T20:37:08.998Z [DBG] SyncMsg+: c:[c60e77b] #2: Type:rev --> OK Time:838.037µs
2019-12-31T20:37:08.998Z [DBG] WS+: c:[c60e77b] Push RPY#2
2019-12-31T20:37:08.998Z [DBG] WS+: c:[c60e77b] Sending frame: RPY#2 (flags= 1, size= 1)
2019-12-31T20:37:08.998Z [DBG] WS+: c:[1fa682f0] Received frame: RPY#2 (flags= 1, length=1)
2019-12-31T20:37:08.998Z [DBG] WSFrame+: c:[1fa682f0] Queued MSG#3
2019-12-31T20:37:08.998Z [DBG] WS+: c:[1fa682f0] Push MSG#3
2019-12-31T20:37:08.999Z [DBG] WS+: c:[1fa682f0] Sending frame: MSG#3 (flags= 0, size= 47)
2019-12-31T20:37:08.999Z [DBG] DCP+: Received #1 after 0ms ("foo" / "1-abc")
2019-12-31T20:37:08.999Z [DBG] DCP+: #1 ==> channels [ * ]
2019-12-31T20:37:08.999Z [DBG] Changes+: Notifying that "test_data_bucket" changed (keys="{*}") count=4
2019-12-31T20:37:08.999Z [DBG] WS+: c:[c60e77b] Received frame: MSG#3 (flags= 0, length=47)
2019-12-31T20:37:08.999Z [DBG] WSFrame+: c:[c60e77b] Incoming BLIP Request: MSG#3
2019-12-31T20:37:08.999Z [INF] SyncMsg: c:[c60e77b] #3: Type:changes #Changes:1
2019-12-31T20:37:08.999Z [DBG] SyncMsg+: c:[c60e77b] #3: Type:changes --> OK Time:211.21µs
2019-12-31T20:37:08.999Z [DBG] WS+: c:[c60e77b] Push RPY#3~
2019-12-31T20:37:08.999Z [DBG] WS+: c:[c60e77b] Sending frame: RPY#3~ (flags= 1001, size= 13)
2019-12-31T20:37:08.999Z [DBG] WS+: c:[1fa682f0] Received frame: RPY#3~ (flags= 1001, length=15)
2019-12-31T20:37:08.999Z [DBG] WSFrame+: c:[1fa682f0] Queued MSG#4
2019-12-31T20:37:08.999Z [DBG] WS+: c:[1fa682f0] Push MSG#4
2019-12-31T20:37:08.999Z [DBG] WS+: c:[1fa682f0] Sending frame: MSG#4 (flags= 0, size= 36)
2019-12-31T20:37:08.999Z [DBG] WS+: c:[c60e77b] Received frame: MSG#4 (flags= 0, length=36)
2019-12-31T20:37:08.999Z [DBG] WSFrame+: c:[c60e77b] Incoming BLIP Request: MSG#4
2019-12-31T20:37:08.999Z [INF] SyncMsg: c:[c60e77b] #4: Type:subChanges Since:0 Continuous:true
2019-12-31T20:37:08.999Z [DBG] WS+: c:[c60e77b] Push RPY#4
2019-12-31T20:37:08.999Z [DBG] WS+: c:[c60e77b] Sending frame: RPY#4 (flags= 1, size= 1)
2019-12-31T20:37:08.999Z [INF] Sync: c:[c60e77b] Sending changes since 0
2019-12-31T20:37:08.999Z [DBG] Changes+: c:[c60e77b] Int sequence multi changes feed...
2019-12-31T20:37:08.999Z [DBG] WS+: c:[1fa682f0] Received frame: RPY#4 (flags= 1, length=1)
2019-12-31T20:37:08.999Z [INF] Changes: c:[c60e77b] MultiChangesFeed(channels: {*}, options: {Since: 0, Limit: 0, Conflicts: false, IncludeDocs: false, Wait: true, Continuous: true, HeartbeatMs: 0, TimeoutMs: 0, ActiveOnly: false}) ...
2019-12-31T20:37:09.000Z [DBG] Changes+: c:[c60e77b] MultiChangesFeed: channels expand to "!:1,*:1" ...
2019-12-31T20:37:09.000Z [DBG] Cache+: Initialized cache for channel "!" with min:50 max:500 age:1m0s, validFrom: 2
2019-12-31T20:37:09.000Z [DBG] Cache+: c:[c60e77b] GetCachedChanges("!", 0) --> nothing cached
2019-12-31T20:37:09.000Z [INF] Cache: Querying 'channels' for "!" (start=#1, end=#2, limit=0)
2019-12-31T20:37:14.000Z [DBG] WS+: c:[1fa682f0] Sender stopped
2019-12-31T20:37:14.000Z [DBG] WS+: c:[c60e77b] receiveLoop stopped
2019-12-31T20:37:14.000Z [INF] WS: c:[1fa682f0] Error: receiveLoop exiting with WebSocket error: read tcp 127.0.0.1:39426->127.0.0.1:36771: use of closed network connection
2019-12-31T20:37:14.000Z [INF] WS: c:[1fa682f0] BLIP/Websocket receiveLoop exited: read tcp 127.0.0.1:39426->127.0.0.1:36771: use of closed network connection
2019-12-31T20:37:14.000Z [DBG] WS+: c:[1fa682f0] parseLoop stopped
2019-12-31T20:37:14.000Z [DBG] WS+: c:[c60e77b] parseLoop stopped
2019-12-31T20:37:14.000Z [DBG] Changes+: changeListener.Stop() called
2019-12-31T20:37:14.000Z [INF] HTTP: c:[c60e77b] #4091: --> BLIP+WebSocket connection closed
2019-12-31T20:37:14.000Z [DBG] Changes+: Notifying to check for _changes feed termination
2019-12-31T20:37:14.000Z [DBG] Terminating background task: "InsertPendingEntries"
2019-12-31T20:37:14.000Z [DBG] SyncMsg+: c:[c60e77b] #4: Type:subChanges --> Time:5.000596562s
2019-12-31T20:37:14.000Z [DBG] Terminating background task: "Compact"
2019-12-31T20:37:14.000Z [DBG] Terminating background task: "CleanAgedItems"
2019-12-31T20:37:14.000Z [DBG] Terminating background task: "CleanSkippedSequenceQueue"
2019-12-31T20:37:14.000Z [DBG] WS+: c:[c60e77b] Sender stopped
2019-12-31T20:37:14.001Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-4ff14884-2c0d-11ea-974d-80e650054dfa, refreshWorker-prior, vbucketState: "running" (has 1024 vbuckets), 0-1023
2019-12-31T20:37:14.002Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-4ff14884-2c0d-11ea-974d-80e650054dfa, refreshWorker-after, vbucketState: "running" (has 1024 vbuckets), 0-1023
2019-12-31T20:37:14.002Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-4ff14884-2c0d-11ea-974d-80e650054dfa, worker, looping beg, vbucketState: "running" (has 1024 vbuckets), 0-1023
2019-12-31T20:37:14.002Z [WRN] c:test_data_bucket-SG Error processing DCP stream - will attempt to restart/reconnect if appropriate: pkt.Receive, err: read tcp 127.0.0.1:48258->127.0.0.1:11210: use of closed network connection. -- base.(*DCPReceiver).OnError() at dcp_receiver.go:61
2019-12-31T20:37:14.002Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: receiver closed, server: 127.0.0.1:11210, name: SG-v-2.8-commit--uuid-4ff14884-2c0d-11ea-974d-80e650054dfa, traces: vb: 0 => 94 (3x), 83 (1024x); vb: 84 => 86, md; vb: 115 => 86, md; vb: 225 => 86, md; vb: 520 => 86, md; vb: 608 => 86, md; vb: 704 => 86, md, 86, md; vb: 925 => 86, md, 86, md, 86, md, 86, md, 86, md, 86, md;
2019-12-31T20:37:14.010Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.011Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_120a6de6
2019-12-31T20:37:14.011Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_120a6de6: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48260->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.011Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_120a6de6-3bb1198d, traces: vb: 0 => 94 (3x), 83 (64x); vb: 84 => 86, md; vb: 115 => 86, md;
2019-12-31T20:37:14.020Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:15
2019-12-31T20:37:14.020Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.020Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.020Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_7dc1913f
2019-12-31T20:37:14.021Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7dc1913f-79fb78d4, refreshWorker-prior, vbucketState: "running" (has 64 vbuckets), 512-575
2019-12-31T20:37:14.021Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7dc1913f-79fb78d4, refreshWorker-after, vbucketState: "running" (has 64 vbuckets), 512-575
2019-12-31T20:37:14.021Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7dc1913f-79fb78d4, worker, looping beg, vbucketState: "running" (has 64 vbuckets), 512-575
2019-12-31T20:37:14.021Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7dc1913f-79fb78d4, refreshWorker-prior, vbucketState: "running" (has 64 vbuckets), 512-575
2019-12-31T20:37:14.021Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7dc1913f-79fb78d4, refreshWorker-after, vbucketState: "running" (has 64 vbuckets), 512-575
2019-12-31T20:37:14.021Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_7dc1913f-79fb78d4, worker, looping beg, vbucketState: "running" (has 64 vbuckets), 512-575
2019-12-31T20:37:14.021Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_7dc1913f: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48236->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.021Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_7dc1913f-79fb78d4, traces: vb: 0 => 94 (3x), 83 (64x); vb: 520 => 86, md;
2019-12-31T20:37:14.027Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:14
2019-12-31T20:37:14.027Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.027Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.028Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_103fc5fb
2019-12-31T20:37:14.028Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_103fc5fb: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48254->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.028Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_103fc5fb-15be8d9d, traces: vb: 0 => 94 (3x), 83 (64x);
2019-12-31T20:37:14.032Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:13
2019-12-31T20:37:14.032Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.032Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.032Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_627da171
2019-12-31T20:37:14.033Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_627da171: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48240->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.033Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_627da171-3313076e, traces: vb: 0 => 94 (3x), 83 (64x);
2019-12-31T20:37:14.037Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:12
2019-12-31T20:37:14.037Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.037Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.037Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_244a4eff
2019-12-31T20:37:14.037Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_244a4eff: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48246->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.037Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_244a4eff-3cd07adc, traces: vb: 0 => 94 (3x), 83 (64x); vb: 608 => 86, md; vb: 633 => 86, md;
2019-12-31T20:37:14.041Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:11
2019-12-31T20:37:14.041Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.042Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.042Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_96da5535
2019-12-31T20:37:14.042Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_96da5535: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48234->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.042Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_96da5535-5d2c629e, traces: vb: 0 => 94 (3x), 83 (64x);
2019-12-31T20:37:14.046Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:10
2019-12-31T20:37:14.046Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.046Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.046Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_15a93994
2019-12-31T20:37:14.046Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_15a93994: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48262->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.046Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_15a93994-4048c5d6, traces: vb: 0 => 94 (3x), 83 (64x);
2019-12-31T20:37:14.051Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:9
2019-12-31T20:37:14.051Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.051Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.051Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_1d526e8f
2019-12-31T20:37:14.051Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_1d526e8f: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48232->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.051Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_1d526e8f-b8efee2, traces: vb: 0 => 94 (3x), 83 (64x);
2019-12-31T20:37:14.055Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:8
2019-12-31T20:37:14.055Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.055Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.055Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_1076212c
2019-12-31T20:37:14.055Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_1076212c: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48238->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.055Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_1076212c-2a83ff13, traces: vb: 0 => 94 (3x), 83 (64x);
2019-12-31T20:37:14.059Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:7
2019-12-31T20:37:14.059Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.059Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.060Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_80d40edf
2019-12-31T20:37:14.060Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_80d40edf-f94c671, refreshWorker-prior, vbucketState: "running" (has 64 vbuckets), 256-319
2019-12-31T20:37:14.060Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_80d40edf-f94c671, refreshWorker-after, vbucketState: "running" (has 64 vbuckets), 256-319
2019-12-31T20:37:14.060Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_80d40edf-f94c671, worker, looping beg, vbucketState: "running" (has 64 vbuckets), 256-319
2019-12-31T20:37:14.060Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_80d40edf: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48244->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.060Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_80d40edf-f94c671, traces: vb: 0 => 94 (3x), 83 (64x); vb: 272 => 86, md; vb: 314 => 86, md;
2019-12-31T20:37:14.064Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:6
2019-12-31T20:37:14.064Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.064Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.064Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_acbbef99
2019-12-31T20:37:14.064Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_acbbef99: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48252->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.064Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_acbbef99-604eeff, traces: vb: 0 => 94 (3x), 83 (64x); vb: 39 => 86, md;
2019-12-31T20:37:14.069Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:5
2019-12-31T20:37:14.069Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.069Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.069Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_84003db0
2019-12-31T20:37:14.069Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_84003db0-1137bbe8, refreshWorker-prior, vbucketState: "running" (has 64 vbuckets), 448-511
2019-12-31T20:37:14.069Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_84003db0-1137bbe8, refreshWorker-after, vbucketState: "running" (has 64 vbuckets), 448-511
2019-12-31T20:37:14.069Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_6270e0db436ffd9b_84003db0-1137bbe8, worker, looping beg, vbucketState: "running" (has 64 vbuckets), 448-511
2019-12-31T20:37:14.069Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_84003db0: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48250->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.069Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_84003db0-1137bbe8, traces: vb: 0 => 94 (3x), 83 (64x); vb: 507 => 86, md;
2019-12-31T20:37:14.074Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:4
2019-12-31T20:37:14.074Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.074Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.074Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_7332d0c7
2019-12-31T20:37:14.074Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_7332d0c7: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48256->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.074Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_7332d0c7-57f4b743, traces: vb: 0 => 94 (3x), 83 (64x);
2019-12-31T20:37:14.078Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:3
2019-12-31T20:37:14.078Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.078Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.078Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_56a5d570
2019-12-31T20:37:14.078Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_56a5d570: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48242->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.078Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_56a5d570-3379e232, traces: vb: 0 => 94 (3x), 83 (64x); vb: 925 => 86, md, 86, md, 86, md, 86, md, 86, md, 86, md, 86, md;
2019-12-31T20:37:14.083Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:2
2019-12-31T20:37:14.083Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.083Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.083Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_f47365c5
2019-12-31T20:37:14.083Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_f47365c5: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48248->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.083Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_f47365c5-701cc3d4, traces: vb: 0 => 94 (3x), 83 (64x); vb: 225 => 86, md;
2019-12-31T20:37:14.088Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:1
2019-12-31T20:37:14.088Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.088Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T20:37:14.088Z [INF] DCP: feed_dcp: close, name: db_import_6270e0db436ffd9b_5b084477
2019-12-31T20:37:14.088Z [INF] DCP: feed_dcp: OnError, name: db_import_6270e0db436ffd9b_5b084477: bucketName: test_data_bucket, bucketUUID: fdd16d0dd1ba1d96dee9ad84234095b9, err: pkt.Receive, err: read tcp 127.0.0.1:48230->127.0.0.1:11210: use of closed network connection
2019-12-31T20:37:14.088Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_6270e0db436ffd9b_5b084477-38aa1199, traces: vb: 0 => 94 (3x), 83 (64x); vb: 704 => 86, md, 86, md;
2019-12-31T20:37:14.093Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:0
2019-12-31T20:37:14.093Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T20:37:14.093Z [INF] rest.TestBlipPushRevisionInspectChanges: Reset logging
--- FAIL: TestBlipPushRevisionInspectChanges (7.32s)
blip_api_test.go:145:
Error Trace: blip_api_test.go:145
Error: Received unexpected error:
Timed out waiting after 5s
Test: TestBlipPushRevisionInspectChanges
Messages: Timed out waiting
Raw
passing
=== RUN TestBlipPushRevisionInspectChanges
2019-12-31T19:27:49.372Z [INF] rest.TestBlipPushRevisionInspectChanges: Setup logging: level: debug - keys: *
2019-12-31T19:27:49.372Z [INF] Auth: Attempting credential authentication couchbase://127.0.0.1?http_idle_conn_timeout=90000&http_max_idle_conns=64000&http_max_idle_conns_per_host=256&kv_pool_size=2&n1ql_timeout=75000&operation_tracing=false
2019-12-31T19:27:49.374Z [INF] Successfully opened bucket test_data_bucket
2019-12-31T19:27:49.379Z [INF] Set query timeouts for bucket test_data_bucket to cluster:1m15s, bucket:1m15s
2019-12-31T19:27:49.379Z [INF] Flushing bucket test_data_bucket
2019-12-31T19:27:49.851Z [INF] GoCBCustomSGTranscoder Opening Couchbase database test_data_bucket on <couchbase://127.0.0.1> as user "test_data_bucket"
2019-12-31T19:27:49.852Z [INF] Auth: Attempting credential authentication couchbase://127.0.0.1?http_idle_conn_timeout=90000&http_max_idle_conns=64000&http_max_idle_conns_per_host=256&kv_pool_size=2&n1ql_timeout=75000&operation_tracing=false
2019-12-31T19:27:49.853Z [INF] Successfully opened bucket test_data_bucket
2019-12-31T19:27:49.857Z [INF] Set query timeouts for bucket test_data_bucket to cluster:1m15s, bucket:1m15s
2019-12-31T19:27:49.857Z [INF] Logging stats with frequency: 1m0s
2019-12-31T19:27:49.857Z [INF] Opening db /db as bucket "test_data_bucket", pool "default", server <couchbase://127.0.0.1>
2019-12-31T19:27:49.857Z [INF] GoCBCustomSGTranscoder Opening Couchbase database test_data_bucket on <couchbase://127.0.0.1> as user "test_data_bucket"
2019-12-31T19:27:49.857Z [INF] Auth: Attempting credential authentication couchbase://127.0.0.1?http_idle_conn_timeout=90000&http_max_idle_conns=64000&http_max_idle_conns_per_host=256&kv_pool_size=2&n1ql_timeout=75000&operation_tracing=false
2019-12-31T19:27:49.858Z [INF] Successfully opened bucket test_data_bucket
2019-12-31T19:27:49.860Z [INF] Set query timeouts for bucket test_data_bucket to cluster:1m15s, bucket:1m15s
2019-12-31T19:27:49.860Z [INF] Initializing indexes with numReplicas: 0...
2019-12-31T19:27:49.883Z [INF] Query: Index sg_access_x1 doesn't exist, creating...
2019-12-31T19:27:49.883Z [DBG] Query+: Attempting to create index using statement: [CREATE INDEX `sg_access_x1` ON `test_data_bucket`(ALL (ARRAY (op.name) FOR op IN OBJECT_PAIRS(meta().xattrs._sync.access) END)) with {"retain_deleted_xattr":true,"defer_build":true}]
2019-12-31T19:27:50.037Z [INF] Query: Index sg_access_x1 created successfully
2019-12-31T19:27:50.050Z [INF] Query: Index sg_roleAccess_x1 doesn't exist, creating...
2019-12-31T19:27:50.050Z [DBG] Query+: Attempting to create index using statement: [CREATE INDEX `sg_roleAccess_x1` ON `test_data_bucket`(ALL (ARRAY (op.name) FOR op IN OBJECT_PAIRS(meta().xattrs._sync.role_access) END)) with {"retain_deleted_xattr":true,"defer_build":true}]
2019-12-31T19:27:50.212Z [INF] Query: Index sg_roleAccess_x1 created successfully
2019-12-31T19:27:50.222Z [INF] Query: Index sg_channels_x1 doesn't exist, creating...
2019-12-31T19:27:50.222Z [DBG] Query+: Attempting to create index using statement: [CREATE INDEX `sg_channels_x1` ON `test_data_bucket`(ALL (ARRAY [op.name, LEAST(meta().xattrs._sync.sequence,op.val.seq), IFMISSING(op.val.rev,null), IFMISSING(op.val.del,null)] FOR op IN OBJECT_PAIRS(meta().xattrs._sync.channels) END), meta().xattrs._sync.rev, meta().xattrs._sync.sequence, meta().xattrs._sync.flags) with {"retain_deleted_xattr":true,"defer_build":true}]
2019-12-31T19:27:50.396Z [INF] Query: Index sg_channels_x1 created successfully
2019-12-31T19:27:50.410Z [INF] Query: Index sg_allDocs_x1 doesn't exist, creating...
2019-12-31T19:27:50.410Z [DBG] Query+: Attempting to create index using statement: [CREATE INDEX `sg_allDocs_x1` ON `test_data_bucket`(meta().xattrs._sync.sequence, meta().xattrs._sync.rev, meta().xattrs._sync.flags, meta().xattrs._sync.deleted) WHERE META().id NOT LIKE '\\_sync:%' with {"retain_deleted_xattr":true,"defer_build":true}]
2019-12-31T19:27:50.568Z [INF] Query: Index sg_allDocs_x1 created successfully
2019-12-31T19:27:50.582Z [INF] Query: Index sg_tombstones_x1 doesn't exist, creating...
2019-12-31T19:27:50.582Z [DBG] Query+: Attempting to create index using statement: [CREATE INDEX `sg_tombstones_x1` ON `test_data_bucket`(meta().xattrs._sync.tombstoned_at) with {"retain_deleted_xattr":true,"defer_build":true}]
2019-12-31T19:27:50.768Z [INF] Query: Index sg_tombstones_x1 created successfully
2019-12-31T19:27:50.782Z [INF] Query: Index sg_syncDocs_x1 doesn't exist, creating...
2019-12-31T19:27:50.782Z [DBG] Query+: Attempting to create index using statement: [CREATE INDEX `sg_syncDocs_x1` ON `test_data_bucket`(META().id) WHERE META().id LIKE '\\_sync:%' with {"defer_build":true}]
2019-12-31T19:27:50.962Z [INF] Query: Index sg_syncDocs_x1 created successfully
2019-12-31T19:27:50.984Z [INF] Query: Building deferred indexes: [sg_allDocs_x1 sg_tombstones_x1 sg_access_x1 sg_roleAccess_x1 sg_syncDocs_x1 sg_channels_x1]
2019-12-31T19:27:51.102Z [DBG] RetryLoop retrying WaitForIndexOnline after 100 ms.
2019-12-31T19:27:51.217Z [DBG] RetryLoop retrying WaitForIndexOnline after 200 ms.
2019-12-31T19:27:51.434Z [DBG] RetryLoop retrying WaitForIndexOnline after 400 ms.
2019-12-31T19:27:51.860Z [DBG] RetryLoop retrying WaitForIndexOnline after 800 ms.
2019-12-31T19:27:52.745Z [INF] Verifying index availability for bucket test_data_bucket...
2019-12-31T19:27:52.745Z [DBG] Query+: Verifying index availability for index sg_channels_x1...
2019-12-31T19:27:52.745Z [DBG] Query+: Verifying index availability for index sg_access_x1...
2019-12-31T19:27:52.745Z [DBG] Query+: Verifying index availability for index sg_roleAccess_x1...
2019-12-31T19:27:52.748Z [DBG] Query+: Index sg_roleAccess_x1 verified as ready
2019-12-31T19:27:52.749Z [DBG] Query+: Index sg_access_x1 verified as ready
2019-12-31T19:27:52.751Z [DBG] Query+: Index sg_channels_x1 verified as ready
2019-12-31T19:27:52.751Z [INF] Indexes ready for bucket test_data_bucket.
2019-12-31T19:27:52.751Z [INF] delta_sync enabled=false with rev_max_age_seconds=86400 for database db
2019-12-31T19:27:52.751Z [INF] Created background task: "CleanAgedItems" with interval 1m0s
2019-12-31T19:27:52.751Z [DBG] Cache+: Initialized channel cache with maxChannels:50000, HWM: 40000, LWM: 30000
2019-12-31T19:27:52.751Z [INF] Cache: Initializing changes cache for database db with options {ChannelCacheOptions:{ChannelCacheMinLength:50 ChannelCacheMaxLength:500 ChannelCacheAge:1m0s MaxNumChannels:50000 CompactHighWatermarkPercent:80 CompactLowWatermarkPercent:60} CachePendingSeqMaxWait:5s CachePendingSeqMaxNum:10000 CacheSkippedSeqMaxWait:1h0m0s}
2019-12-31T19:27:52.752Z [INF] Created background task: "InsertPendingEntries" with interval 2.5s
2019-12-31T19:27:52.752Z [INF] Created background task: "CleanSkippedSequenceQueue" with interval 30m0s
2019-12-31T19:27:52.752Z [INF] DCP: Attempting to start import DCP feed...
2019-12-31T19:27:52.752Z [INF] DCP: Registering PindexImplType for syncGateway-import-db
2019-12-31T19:27:52.752Z [INF] DCP: Starting DCP import feed for bucket: "test_data_bucket"
2019-12-31T19:27:52.752Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: nodeDefs-known, cas: 0
2019-12-31T19:27:52.752Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T19:27:52.752Z [INF] DCP: manager: setting the nodeDefs implVersion to 5.5.0
2019-12-31T19:27:52.752Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Set, key: nodeDefs-known, cas: 0
2019-12-31T19:27:52.752Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: FireEvent, key: nodeDefs-known, cas 1577820472752406528
2019-12-31T19:27:52.752Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: nodeDefs-wanted, cas: 0
2019-12-31T19:27:52.752Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T19:27:52.752Z [INF] DCP: manager: setting the nodeDefs implVersion to 5.5.0
2019-12-31T19:27:52.752Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Set, key: nodeDefs-wanted, cas: 0
2019-12-31T19:27:52.752Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: FireEvent, key: nodeDefs-wanted, cas 1577820472752799744
2019-12-31T19:27:52.752Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: planPIndexes
2019-12-31T19:27:52.752Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: indexDefs
2019-12-31T19:27:52.752Z [INF] DCP: planner: awakes, op: kick, msg: start
2019-12-31T19:27:52.753Z [INF] DCP: planner: once, reason: start
2019-12-31T19:27:52.752Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: planPIndexes
2019-12-31T19:27:52.753Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T19:27:52.753Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: nodeDefs-known
2019-12-31T19:27:52.752Z [INF] DCP: janitor: awakes, op: kick, msg: start
2019-12-31T19:27:52.753Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T19:27:52.753Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: curMetaKvPlanKey
2019-12-31T19:27:52.752Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: curMetaKvPlanKey
2019-12-31T19:27:52.753Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: nodeDefs-wanted
2019-12-31T19:27:52.753Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T19:27:52.753Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Set, key: version, cas: 0
2019-12-31T19:27:52.753Z [INF] DCP: janitor: JanitorOnce, err: janitor: skipped on nil planPIndexes
2019-12-31T19:27:52.753Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: nodeDefs-wanted
2019-12-31T19:27:52.752Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: indexDefs
2019-12-31T19:27:52.753Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: nodeDefs-wanted
2019-12-31T19:27:52.753Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: FireEvent, key: version, cas 1577820472753324032
2019-12-31T19:27:52.753Z [INF] DCP: version: CheckVersion, Cfg version updated 5.5.0
2019-12-31T19:27:52.753Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T19:27:52.753Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T19:27:52.753Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T19:27:52.754Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: nodeDefs-wanted, cas: 0
2019-12-31T19:27:52.754Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T19:27:52.754Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T19:27:52.754Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T19:27:52.765Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T19:27:52.765Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T19:27:52.766Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Set, key: indexDefs, cas: 0
2019-12-31T19:27:52.766Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: FireEvent, key: indexDefs, cas 1577820472766103552
2019-12-31T19:27:52.766Z [INF] DCP: manager_api: index definition created, indexType: syncGateway-import-db, indexName: db_import, indexUUID: 78f25425de4fc04d
2019-12-31T19:27:52.766Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T19:27:52.766Z [INF] DCP: planner: awakes, op: kick, msg: cfg changed, key: indexDefs
2019-12-31T19:27:52.766Z [INF] DCP: planner: once, reason: cfg changed, key: indexDefs
2019-12-31T19:27:52.766Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T19:27:52.766Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T19:27:52.766Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T19:27:52.766Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: nodeDefs-wanted, cas: 0
2019-12-31T19:27:52.767Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T19:27:52.767Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T19:27:52.767Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T19:27:52.768Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Set, key: planPIndexes, cas: 0
2019-12-31T19:27:52.769Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: FireEvent, key: planPIndexes, cas 1577820472768921600
2019-12-31T19:27:52.769Z [INF] DCP: janitor: awakes, op: kick, msg: the plans have changed
2019-12-31T19:27:52.769Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T19:27:52.769Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T19:27:52.770Z [INF] DCP: janitor: pindexes to remove: 0
2019-12-31T19:27:52.770Z [INF] DCP: janitor: pindexes to add: 16
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_5b084477 UUID:4511cfda61f4e0ed IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:704,705,706,707,708,709,710,711,712,713,714,715,716,717,718,719,720,721,722,723,724,725,726,727,728,729,730,731,732,733,734,735,736,737,738,739,740,741,742,743,744,745,746,747,748,749,750,751,752,753,754,755,756,757,758,759,760,761,762,763,764,765,766,767 Nodes:map[2856aecca42a4ac8:0xc000598960]}
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_7332d0c7 UUID:7ae0aa56186d7cd4 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191 Nodes:map[2856aecca42a4ac8:0xc000598c40]}
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_15a93994 UUID:51de27365a35be25 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:640,641,642,643,644,645,646,647,648,649,650,651,652,653,654,655,656,657,658,659,660,661,662,663,664,665,666,667,668,669,670,671,672,673,674,675,676,677,678,679,680,681,682,683,684,685,686,687,688,689,690,691,692,693,694,695,696,697,698,699,700,701,702,703 Nodes:map[2856aecca42a4ac8:0xc000598380]}
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_1d526e8f UUID:2fa3fa15930c000f IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:960,961,962,963,964,965,966,967,968,969,970,971,972,973,974,975,976,977,978,979,980,981,982,983,984,985,986,987,988,989,990,991,992,993,994,995,996,997,998,999,1000,1001,1002,1003,1004,1005,1006,1007,1008,1009,1010,1011,1012,1013,1014,1015,1016,1017,1018,1019,1020,1021,1022,1023 Nodes:map[2856aecca42a4ac8:0xc0005984f0]}
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_244a4eff UUID:5ff27330e6b3262f IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:576,577,578,579,580,581,582,583,584,585,586,587,588,589,590,591,592,593,594,595,596,597,598,599,600,601,602,603,604,605,606,607,608,609,610,611,612,613,614,615,616,617,618,619,620,621,622,623,624,625,626,627,628,629,630,631,632,633,634,635,636,637,638,639 Nodes:map[2856aecca42a4ac8:0xc000598660]}
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_56a5d570 UUID:19aec26750a777ce IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:896,897,898,899,900,901,902,903,904,905,906,907,908,909,910,911,912,913,914,915,916,917,918,919,920,921,922,923,924,925,926,927,928,929,930,931,932,933,934,935,936,937,938,939,940,941,942,943,944,945,946,947,948,949,950,951,952,953,954,955,956,957,958,959 Nodes:map[2856aecca42a4ac8:0xc0005987d0]}
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_acbbef99 UUID:4d1feadf315011f8 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63 Nodes:map[2856aecca42a4ac8:0xc000599370]}
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_f47365c5 UUID:7c6a1ee3619d79ec IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:192,193,194,195,196,197,198,199,200,201,202,203,204,205,206,207,208,209,210,211,212,213,214,215,216,217,218,219,220,221,222,223,224,225,226,227,228,229,230,231,232,233,234,235,236,237,238,239,240,241,242,243,244,245,246,247,248,249,250,251,252,253,254,255 Nodes:map[2856aecca42a4ac8:0xc0005994e0]}
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_1076212c UUID:79d32d9c12351a9c IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:384,385,386,387,388,389,390,391,392,393,394,395,396,397,398,399,400,401,402,403,404,405,406,407,408,409,410,411,412,413,414,415,416,417,418,419,420,421,422,423,424,425,426,427,428,429,430,431,432,433,434,435,436,437,438,439,440,441,442,443,444,445,446,447 Nodes:map[2856aecca42a4ac8:0xc0005980a0]}
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_120a6de6 UUID:393de0e2c3b02af8 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:64,65,66,67,68,69,70,71,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,120,121,122,123,124,125,126,127 Nodes:map[2856aecca42a4ac8:0xc000598210]}
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_84003db0 UUID:1e33930bde899a4d IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:448,449,450,451,452,453,454,455,456,457,458,459,460,461,462,463,464,465,466,467,468,469,470,471,472,473,474,475,476,477,478,479,480,481,482,483,484,485,486,487,488,489,490,491,492,493,494,495,496,497,498,499,500,501,502,503,504,505,506,507,508,509,510,511 Nodes:map[2856aecca42a4ac8:0xc000599090]}
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_96da5535 UUID:290862b399938a8a IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:320,321,322,323,324,325,326,327,328,329,330,331,332,333,334,335,336,337,338,339,340,341,342,343,344,345,346,347,348,349,350,351,352,353,354,355,356,357,358,359,360,361,362,363,364,365,366,367,368,369,370,371,372,373,374,375,376,377,378,379,380,381,382,383 Nodes:map[2856aecca42a4ac8:0xc000599200]}
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_627da171 UUID:2b3fb21f16145fc7 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:832,833,834,835,836,837,838,839,840,841,842,843,844,845,846,847,848,849,850,851,852,853,854,855,856,857,858,859,860,861,862,863,864,865,866,867,868,869,870,871,872,873,874,875,876,877,878,879,880,881,882,883,884,885,886,887,888,889,890,891,892,893,894,895 Nodes:map[2856aecca42a4ac8:0xc000598ad0]}
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_7dc1913f UUID:709b3a7e26426a68 IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:512,513,514,515,516,517,518,519,520,521,522,523,524,525,526,527,528,529,530,531,532,533,534,535,536,537,538,539,540,541,542,543,544,545,546,547,548,549,550,551,552,553,554,555,556,557,558,559,560,561,562,563,564,565,566,567,568,569,570,571,572,573,574,575 Nodes:map[2856aecca42a4ac8:0xc000598db0]}
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_103fc5fb UUID:259b68d231abefba IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:768,769,770,771,772,773,774,775,776,777,778,779,780,781,782,783,784,785,786,787,788,789,790,791,792,793,794,795,796,797,798,799,800,801,802,803,804,805,806,807,808,809,810,811,812,813,814,815,816,817,818,819,820,821,822,823,824,825,826,827,828,829,830,831 Nodes:map[2856aecca42a4ac8:0xc00043ff30]}
2019-12-31T19:27:52.770Z [INF] DCP: &{Name:db_import_78f25425de4fc04d_80d40edf UUID:3a6fa002edfc8cdd IndexType:syncGateway-import-db IndexName:db_import IndexUUID:78f25425de4fc04d IndexParams:{"name":"db"} SourceType:couchbase SourceName:test_data_bucket SourceUUID:680905b779497f22eb12727bbefcdaf6 SourceParams:{"authPassword":"password","authUser":"test_data_bucket","includeXAttrs":true} SourcePartitions:256,257,258,259,260,261,262,263,264,265,266,267,268,269,270,271,272,273,274,275,276,277,278,279,280,281,282,283,284,285,286,287,288,289,290,291,292,293,294,295,296,297,298,299,300,301,302,303,304,305,306,307,308,309,310,311,312,313,314,315,316,317,318,319 Nodes:map[2856aecca42a4ac8:0xc000598f20]}
2019-12-31T19:27:52.770Z [INF] DCP: janitor: pindexes to restart: 0
2019-12-31T19:27:52.770Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:1
2019-12-31T19:27:52.770Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:2
2019-12-31T19:27:52.770Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:3
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:5
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.770Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:6
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:4
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:9
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:11
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:12
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:8
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:13
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:14
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:15
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:16
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:10
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Starting sharded feed for SGI. Total partitions:7
2019-12-31T19:27:52.771Z [INF] DCP: c:test_data_bucket-SGI Using DCP Logging Receiver
2019-12-31T19:27:52.772Z [INF] DCP: janitor: feeds to remove: 0
2019-12-31T19:27:52.772Z [INF] DCP: janitor: feeds to add: 16
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_120a6de6
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_84003db0
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_5b084477
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_56a5d570
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_7332d0c7
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_1d526e8f
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_acbbef99
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_96da5535
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_103fc5fb
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_f47365c5
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_80d40edf
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_627da171
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_1076212c
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_7dc1913f
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_244a4eff
2019-12-31T19:27:52.772Z [INF] DCP: db_import_78f25425de4fc04d_15a93994
2019-12-31T19:27:52.772Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_120a6de6, indexName: db_import
2019-12-31T19:27:52.772Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_120a6de6
2019-12-31T19:27:52.772Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_120a6de6 registered for tls config updates
2019-12-31T19:27:52.772Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_84003db0, indexName: db_import
2019-12-31T19:27:52.772Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_84003db0
2019-12-31T19:27:52.772Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_84003db0 registered for tls config updates
2019-12-31T19:27:52.772Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_5b084477, indexName: db_import
2019-12-31T19:27:52.772Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_5b084477
2019-12-31T19:27:52.772Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_5b084477 registered for tls config updates
2019-12-31T19:27:52.772Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_56a5d570, indexName: db_import
2019-12-31T19:27:52.772Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_56a5d570
2019-12-31T19:27:52.772Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_56a5d570 registered for tls config updates
2019-12-31T19:27:52.772Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_7332d0c7, indexName: db_import
2019-12-31T19:27:52.772Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_7332d0c7
2019-12-31T19:27:52.772Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_7332d0c7 registered for tls config updates
2019-12-31T19:27:52.772Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_1d526e8f, indexName: db_import
2019-12-31T19:27:52.772Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_1d526e8f
2019-12-31T19:27:52.772Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_1d526e8f registered for tls config updates
2019-12-31T19:27:52.772Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_acbbef99, indexName: db_import
2019-12-31T19:27:52.773Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_acbbef99
2019-12-31T19:27:52.773Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_acbbef99 registered for tls config updates
2019-12-31T19:27:52.773Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_96da5535, indexName: db_import
2019-12-31T19:27:52.773Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_96da5535
2019-12-31T19:27:52.773Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_96da5535 registered for tls config updates
2019-12-31T19:27:52.773Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_103fc5fb, indexName: db_import
2019-12-31T19:27:52.773Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_103fc5fb
2019-12-31T19:27:52.773Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_103fc5fb registered for tls config updates
2019-12-31T19:27:52.775Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_f47365c5, indexName: db_import
2019-12-31T19:27:52.775Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_f47365c5
2019-12-31T19:27:52.775Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_f47365c5 registered for tls config updates
2019-12-31T19:27:52.776Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_80d40edf, indexName: db_import
2019-12-31T19:27:52.776Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_80d40edf
2019-12-31T19:27:52.776Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_80d40edf registered for tls config updates
2019-12-31T19:27:52.776Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_627da171, indexName: db_import
2019-12-31T19:27:52.776Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_627da171
2019-12-31T19:27:52.776Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_627da171 registered for tls config updates
2019-12-31T19:27:52.776Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_1076212c, indexName: db_import
2019-12-31T19:27:52.776Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_1076212c
2019-12-31T19:27:52.776Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_1076212c registered for tls config updates
2019-12-31T19:27:52.776Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_7dc1913f, indexName: db_import
2019-12-31T19:27:52.776Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_7dc1913f
2019-12-31T19:27:52.776Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_7dc1913f registered for tls config updates
2019-12-31T19:27:52.776Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_244a4eff, indexName: db_import
2019-12-31T19:27:52.776Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_244a4eff
2019-12-31T19:27:52.776Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_244a4eff registered for tls config updates
2019-12-31T19:27:52.776Z [INF] DCP: feed_dcp: NewDCPFeed, name: db_import_78f25425de4fc04d_15a93994, indexName: db_import
2019-12-31T19:27:52.776Z [INF] DCP: feed_dcp: start, name: db_import_78f25425de4fc04d_15a93994
2019-12-31T19:27:52.776Z [INF] DCP: cbauth: key: DCPFeed_db_import_78f25425de4fc04d_15a93994 registered for tls config updates
2019-12-31T19:27:52.776Z [INF] DCP: janitor: awakes, op: kick, msg: cfg changed, key: planPIndexes
2019-12-31T19:27:52.776Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T19:27:52.776Z [INF] DCP: planner: awakes, op: kick, msg: api/CreateIndex, indexName: db_import
2019-12-31T19:27:52.776Z [INF] DCP: planner: once, reason: api/CreateIndex, indexName: db_import
2019-12-31T19:27:52.776Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T19:27:52.776Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T19:27:52.777Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: nodeDefs-wanted, cas: 0
2019-12-31T19:27:52.777Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T19:27:52.777Z [INF] DCP: janitor: pindexes to remove: 0
2019-12-31T19:27:52.777Z [INF] DCP: janitor: pindexes to add: 0
2019-12-31T19:27:52.777Z [INF] DCP: janitor: pindexes to restart: 0
2019-12-31T19:27:52.777Z [INF] DCP: janitor: feeds to remove: 0
2019-12-31T19:27:52.777Z [INF] DCP: janitor: feeds to add: 0
2019-12-31T19:27:52.778Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T19:27:52.778Z [INF] DCP: planner: awakes, op: kick, msg: NewIndexesCreated
2019-12-31T19:27:52.779Z [INF] DCP: planner: once, reason: NewIndexesCreated
2019-12-31T19:27:52.779Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T19:27:52.779Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: indexDefs, cas: 0
2019-12-31T19:27:52.779Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: nodeDefs-wanted, cas: 0
2019-12-31T19:27:52.779Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T19:27:52.780Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: version, cas: 0
2019-12-31T19:27:52.780Z [INF] DCP: janitor: awakes, op: kick, msg: NewIndexesCreated
2019-12-31T19:27:52.780Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: planPIndexes, cas: 0
2019-12-31T19:27:52.782Z [INF] DCP: janitor: pindexes to remove: 0
2019-12-31T19:27:52.782Z [INF] DCP: janitor: pindexes to add: 0
2019-12-31T19:27:52.782Z [INF] DCP: janitor: pindexes to restart: 0
2019-12-31T19:27:52.782Z [INF] DCP: janitor: feeds to remove: 0
2019-12-31T19:27:52.782Z [INF] DCP: janitor: feeds to add: 0
2019-12-31T19:27:52.782Z [INF] DCP: Initialized sharded DCP feed db_import with 16 partitions.
2019-12-31T19:27:52.782Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Get, key: nodeDefs-known, cas: 0
2019-12-31T19:27:52.783Z [INF] DCP: c:test_data_bucket-SGI cfg_sg: Subscribe, key: nodeDefs-known
2019-12-31T19:27:52.783Z [DBG] DCP+: Sending CBGT node heartbeats at interval: 1s
2019-12-31T19:27:52.783Z [DBG] DCP+: Checking heartbeats for nodes: [2856aecca42a4ac8]
2019-12-31T19:27:52.783Z [DBG] DCP+: Checking CBGT node heartbeats with stale threshold: 10000 ms
2019-12-31T19:27:52.783Z [INF] DCP: Starting mutation feed on bucket test_data_bucket due to either channel cache mode or doc tracking (auto-import)
2019-12-31T19:27:52.783Z [INF] DCP: Using DCP feed for bucket: "test_data_bucket" (based on feed_type specified in config file)
2019-12-31T19:27:52.783Z [INF] DCP: c:test_data_bucket-SG Using DCP Logging Receiver
2019-12-31T19:27:52.802Z [DBG] DCP+: Initializing DCP with no backfill - seeding seqnos: map[39:1 182:1 272:1 314:1 507:1 633:1]
2019-12-31T19:27:52.802Z [INF] DCP: c:test_data_bucket-SG DCP feed starting with name SG-v-2.8-commit--uuid-a38317a4-2c03-11ea-bf53-80e650054dfa
2019-12-31T19:27:52.802Z [DBG] DCP+: c:test_data_bucket-SG Connecting to new bucket datasource. URLs:[ http://127.0.0.1:8091 ], pool:default, bucket:test_data_bucket
2019-12-31T19:27:52.827Z [INF] Using metadata purge interval of 3.00 days for tombstone compaction.
2019-12-31T19:27:52.827Z [INF] Created background task: "Compact" with interval 24h0m0s
2019-12-31T19:27:52.829Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.829Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_120a6de6-33aedf9a, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.830Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_120a6de6-33aedf9a, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.829Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_120a6de6-33aedf9a, capacity: 20
2019-12-31T19:27:52.834Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_120a6de6-33aedf9a, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 64-127
2019-12-31T19:27:52.834Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_120a6de6-33aedf9a, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 64-127
2019-12-31T19:27:52.834Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_120a6de6-33aedf9a, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 64-127
2019-12-31T19:27:52.834Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_120a6de6-33aedf9a, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 64-127
2019-12-31T19:27:52.834Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_120a6de6-33aedf9a, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 64-127
2019-12-31T19:27:52.838Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.838Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.838Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.838Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_1d526e8f-2ef521df, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.838Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_1d526e8f-2ef521df, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.838Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_244a4eff-1375c909, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.838Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_244a4eff-1375c909, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.838Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_1d526e8f-2ef521df, capacity: 20
2019-12-31T19:27:52.838Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_244a4eff-1375c909, capacity: 20
2019-12-31T19:27:52.838Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_56a5d570-61515b2f, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.838Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_56a5d570-61515b2f, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.838Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_56a5d570-61515b2f, capacity: 20
2019-12-31T19:27:52.846Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_244a4eff-1375c909, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 576-639
2019-12-31T19:27:52.846Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_244a4eff-1375c909, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 576-639
2019-12-31T19:27:52.846Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_244a4eff-1375c909, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 576-639
2019-12-31T19:27:52.846Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_56a5d570-61515b2f, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 896-959
2019-12-31T19:27:52.846Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_56a5d570-61515b2f, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 896-959
2019-12-31T19:27:52.846Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_56a5d570-61515b2f, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 896-959
2019-12-31T19:27:52.846Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_56a5d570-61515b2f, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 896-959
2019-12-31T19:27:52.846Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_244a4eff-1375c909, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 576-639
2019-12-31T19:27:52.846Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_56a5d570-61515b2f, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 896-959
2019-12-31T19:27:52.846Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_244a4eff-1375c909, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 576-639
2019-12-31T19:27:52.846Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_1d526e8f-2ef521df, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 960-1023
2019-12-31T19:27:52.846Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_1d526e8f-2ef521df, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 960-1023
2019-12-31T19:27:52.846Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_1d526e8f-2ef521df, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 960-1023
2019-12-31T19:27:52.846Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_1d526e8f-2ef521df, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 960-1023
2019-12-31T19:27:52.846Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_1d526e8f-2ef521df, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 960-1023
2019-12-31T19:27:52.853Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.853Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.853Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7dc1913f-df8918a, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.853Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7dc1913f-df8918a, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.853Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_7dc1913f-df8918a, capacity: 20
2019-12-31T19:27:52.853Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_103fc5fb-cb5c637, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.853Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_103fc5fb-cb5c637, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.853Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_103fc5fb-cb5c637, capacity: 20
2019-12-31T19:27:52.855Z [INF] Using default sync function 'channel(doc.channels)' for database "db"
2019-12-31T19:27:52.856Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.856Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_acbbef99-1f20dc6b, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.856Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_acbbef99-1f20dc6b, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.856Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_acbbef99-1f20dc6b, capacity: 20
2019-12-31T19:27:52.861Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.861Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.861Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7dc1913f-df8918a, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 512-575
2019-12-31T19:27:52.862Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7dc1913f-df8918a, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 512-575
2019-12-31T19:27:52.862Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7dc1913f-df8918a, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 512-575
2019-12-31T19:27:52.862Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7dc1913f-df8918a, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 512-575
2019-12-31T19:27:52.862Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7dc1913f-df8918a, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 512-575
2019-12-31T19:27:52.862Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_5b084477-5d9fa75a, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.862Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_5b084477-5d9fa75a, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.862Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_5b084477-5d9fa75a, capacity: 20
2019-12-31T19:27:52.862Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_96da5535-5a459da0, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.862Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_96da5535-5a459da0, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.862Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_96da5535-5a459da0, capacity: 20
2019-12-31T19:27:52.864Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_103fc5fb-cb5c637, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 768-831
2019-12-31T19:27:52.864Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_103fc5fb-cb5c637, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 768-831
2019-12-31T19:27:52.864Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_103fc5fb-cb5c637, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 768-831
2019-12-31T19:27:52.864Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_103fc5fb-cb5c637, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 768-831
2019-12-31T19:27:52.864Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_103fc5fb-cb5c637, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 768-831
2019-12-31T19:27:52.865Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.866Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.866Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.866Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.866Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_80d40edf-2b5091bd, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.866Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_80d40edf-2b5091bd, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.866Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_80d40edf-2b5091bd, capacity: 20
2019-12-31T19:27:52.866Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7332d0c7-6bf5f26c, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.866Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7332d0c7-6bf5f26c, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.866Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_7332d0c7-6bf5f26c, capacity: 20
2019-12-31T19:27:52.867Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_627da171-1d5eec3d, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.867Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_627da171-1d5eec3d, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.867Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_627da171-1d5eec3d, capacity: 20
2019-12-31T19:27:52.867Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_f47365c5-66ace35e, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.867Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_f47365c5-66ace35e, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.867Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.867Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_f47365c5-66ace35e, capacity: 20
2019-12-31T19:27:52.867Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_15a93994-9ac155e, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.867Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_15a93994-9ac155e, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.867Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_15a93994-9ac155e, capacity: 20
2019-12-31T19:27:52.868Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_acbbef99-1f20dc6b, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 0-63
2019-12-31T19:27:52.868Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_acbbef99-1f20dc6b, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 0-63
2019-12-31T19:27:52.868Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_acbbef99-1f20dc6b, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 0-63
2019-12-31T19:27:52.868Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_acbbef99-1f20dc6b, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 0-63
2019-12-31T19:27:52.868Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_acbbef99-1f20dc6b, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 0-63
2019-12-31T19:27:52.869Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.870Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.870Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_84003db0-7452e2d9, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.870Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_84003db0-7452e2d9, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.870Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_84003db0-7452e2d9, capacity: 20
2019-12-31T19:27:52.871Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_1076212c-74615bd0, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.871Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_1076212c-74615bd0, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.871Z [INF] DCP: cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_1076212c-74615bd0, capacity: 20
2019-12-31T19:27:52.875Z [INF] CBGoUtilsLogger: Using plain authentication for user <ud>test_data_bucket</ud>
2019-12-31T19:27:52.876Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-a38317a4-2c03-11ea-bf53-80e650054dfa, worker, looping beg, vbucketStates empty
2019-12-31T19:27:52.876Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: receiver tracing, server: 127.0.0.1:11210, name: SG-v-2.8-commit--uuid-a38317a4-2c03-11ea-bf53-80e650054dfa, capacity: 200
2019-12-31T19:27:52.876Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-a38317a4-2c03-11ea-bf53-80e650054dfa, refreshWorker-prior, vbucketStates empty
2019-12-31T19:27:52.878Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_96da5535-5a459da0, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 320-383
2019-12-31T19:27:52.878Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_96da5535-5a459da0, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 320-383
2019-12-31T19:27:52.878Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_96da5535-5a459da0, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 320-383
2019-12-31T19:27:52.878Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_96da5535-5a459da0, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 320-383
2019-12-31T19:27:52.878Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_96da5535-5a459da0, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 320-383
2019-12-31T19:27:52.879Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_5b084477-5d9fa75a, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 704-767
2019-12-31T19:27:52.879Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_5b084477-5d9fa75a, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 704-767
2019-12-31T19:27:52.879Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_5b084477-5d9fa75a, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 704-767
2019-12-31T19:27:52.879Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_5b084477-5d9fa75a, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 704-767
2019-12-31T19:27:52.879Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_5b084477-5d9fa75a, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 704-767
2019-12-31T19:27:52.881Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_80d40edf-2b5091bd, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 256-319
2019-12-31T19:27:52.881Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_80d40edf-2b5091bd, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 256-319
2019-12-31T19:27:52.881Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_80d40edf-2b5091bd, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 256-319
2019-12-31T19:27:52.881Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_80d40edf-2b5091bd, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 256-319
2019-12-31T19:27:52.881Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_80d40edf-2b5091bd, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 256-319
2019-12-31T19:27:52.882Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_15a93994-9ac155e, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 640-703
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_15a93994-9ac155e, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 640-703
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_15a93994-9ac155e, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 640-703
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_627da171-1d5eec3d, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 832-895
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_15a93994-9ac155e, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 640-703
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_15a93994-9ac155e, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 640-703
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_627da171-1d5eec3d, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 832-895
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_627da171-1d5eec3d, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 832-895
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_627da171-1d5eec3d, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 832-895
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_627da171-1d5eec3d, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 832-895
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7332d0c7-6bf5f26c, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 128-191
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7332d0c7-6bf5f26c, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 128-191
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7332d0c7-6bf5f26c, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 128-191
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7332d0c7-6bf5f26c, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 128-191
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7332d0c7-6bf5f26c, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 128-191
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_f47365c5-66ace35e, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 192-255
2019-12-31T19:27:52.883Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_f47365c5-66ace35e, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 192-255
2019-12-31T19:27:52.884Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-a38317a4-2c03-11ea-bf53-80e650054dfa, refreshWorker-after, vbucketState: "requested" (has 1024 vbuckets), 0-1023
2019-12-31T19:27:52.884Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_f47365c5-66ace35e, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 192-255
2019-12-31T19:27:52.884Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_f47365c5-66ace35e, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 192-255
2019-12-31T19:27:52.884Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_f47365c5-66ace35e, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 192-255
2019-12-31T19:27:52.884Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-a38317a4-2c03-11ea-bf53-80e650054dfa, worker, looping beg, vbucketState: "requested" (has 1024 vbuckets), 0-1023
2019-12-31T19:27:52.884Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-a38317a4-2c03-11ea-bf53-80e650054dfa, refreshWorker-prior, vbucketState: "requested" (has 1024 vbuckets), 0-1023
2019-12-31T19:27:52.884Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_84003db0-7452e2d9, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 448-511
2019-12-31T19:27:52.884Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_84003db0-7452e2d9, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 448-511
2019-12-31T19:27:52.884Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_84003db0-7452e2d9, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 448-511
2019-12-31T19:27:52.884Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_84003db0-7452e2d9, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 448-511
2019-12-31T19:27:52.884Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_84003db0-7452e2d9, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 448-511
2019-12-31T19:27:52.884Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-a38317a4-2c03-11ea-bf53-80e650054dfa, refreshWorker-after, vbucketState: "requested" (has 1024 vbuckets), 0-1023
2019-12-31T19:27:52.885Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-a38317a4-2c03-11ea-bf53-80e650054dfa, worker, looping beg, vbucketState: "requested" (has 1024 vbuckets), 0-1023
2019-12-31T19:27:52.885Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_1076212c-74615bd0, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 384-447
2019-12-31T19:27:52.885Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_1076212c-74615bd0, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 384-447
2019-12-31T19:27:52.885Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_1076212c-74615bd0, refreshWorker-prior, vbucketState: "requested" (has 64 vbuckets), 384-447
2019-12-31T19:27:52.885Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_1076212c-74615bd0, refreshWorker-after, vbucketState: "requested" (has 64 vbuckets), 384-447
2019-12-31T19:27:52.885Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_1076212c-74615bd0, worker, looping beg, vbucketState: "requested" (has 64 vbuckets), 384-447
2019-12-31T19:27:52.888Z [INF] WaitForIndexEmpty found 0 results. GSI index appears to be empty.
2019-12-31T19:27:52.888Z [INF] Auth: Saved principal w/ name:, seq: #0
2019-12-31T19:27:52.890Z [INF] HTTP: #001: GET /db/_blipsync
2019-12-31T19:27:52.890Z [WRN] QueryAccess called with empty username - returning empty result iterator -- db.(*DatabaseContext).QueryAccess() at query.go:257
2019-12-31T19:27:52.890Z [INF] Access: Recomputed channels for "": !:1,*:1
2019-12-31T19:27:52.890Z [WRN] QueryRoleAccess called with empty username -- db.(*DatabaseContext).QueryRoleAccess() at query.go:288
2019-12-31T19:27:52.890Z [INF] Access: Computed roles for "":
2019-12-31T19:27:52.890Z [INF] HTTP+: #001: --> 101 [3e7c9510] Upgraded to BLIP+WebSocket protocol (as GUEST) (0.0 ms)
2019-12-31T19:27:52.891Z [INF] WS: c:[3e7c9510] Start BLIP/Websocket handler
2019-12-31T19:27:52.891Z [DBG] WS+: c:[306e6aa0] Sender starting
2019-12-31T19:27:52.891Z [DBG] WSFrame+: c:[306e6aa0] Queued MSG#1
2019-12-31T19:27:52.891Z [DBG] WS+: c:[306e6aa0] Push MSG#1
2019-12-31T19:27:52.891Z [DBG] WS+: c:[3e7c9510] Sender starting
2019-12-31T19:27:52.891Z [DBG] WS+: c:[306e6aa0] Sending frame: MSG#1 (flags= 0, size= 47)
2019-12-31T19:27:52.891Z [DBG] WS+: c:[3e7c9510] Received frame: MSG#1 (flags= 0, length=47)
2019-12-31T19:27:52.891Z [DBG] WSFrame+: c:[3e7c9510] Incoming BLIP Request: MSG#1
2019-12-31T19:27:52.891Z [INF] SyncMsg: c:[3e7c9510] #1: Type:changes #Changes:1
2019-12-31T19:27:52.891Z [DBG] CRUD+: No document found for key=foo
2019-12-31T19:27:52.891Z [DBG] SyncMsg+: c:[3e7c9510] #1: Type:changes --> OK Time:174.281µs
2019-12-31T19:27:52.891Z [DBG] WS+: c:[3e7c9510] Push RPY#1~
2019-12-31T19:27:52.891Z [DBG] WS+: c:[3e7c9510] Sending frame: RPY#1~ (flags= 1001, size= 5)
2019-12-31T19:27:52.891Z [DBG] WS+: c:[306e6aa0] Received frame: RPY#1~ (flags= 1001, length=7)
2019-12-31T19:27:52.891Z [DBG] WSFrame+: c:[306e6aa0] Queued MSG#2~
2019-12-31T19:27:52.891Z [DBG] WS+: c:[306e6aa0] Push MSG#2~
2019-12-31T19:27:52.891Z [DBG] WS+: c:[306e6aa0] Sending frame: MSG#2~ (flags= 1000, size= 58)
2019-12-31T19:27:52.892Z [DBG] WS+: c:[3e7c9510] Received frame: MSG#2~ (flags= 1000, length=57)
2019-12-31T19:27:52.892Z [DBG] WSFrame+: c:[3e7c9510] Incoming BLIP Request: MSG#2~
2019-12-31T19:27:52.892Z [DBG] SyncMsg+: c:[3e7c9510] #2: Type:rev Id:foo Rev:1-abc Deleted:false
2019-12-31T19:27:52.892Z [DBG] CRUD+: c:[3e7c9510] Invoking sync on doc "foo" rev 1-abc
2019-12-31T19:27:52.892Z [DBG] CRUD+: Backed up revision body "foo"/"" (0 bytes, ttl:300)
2019-12-31T19:27:52.893Z [DBG] CRUD+: c:[3e7c9510] Saving doc (seq: #1, id: foo rev: 1-abc)
2019-12-31T19:27:52.893Z [DBG] CRUD+: c:[3e7c9510] Stored doc "foo" / "1-abc" as #1
2019-12-31T19:27:52.893Z [DBG] SyncMsg+: c:[3e7c9510] #2: Type:rev --> OK Time:1.164291ms
2019-12-31T19:27:52.893Z [DBG] WS+: c:[3e7c9510] Push RPY#2
2019-12-31T19:27:52.893Z [DBG] WS+: c:[3e7c9510] Sending frame: RPY#2 (flags= 1, size= 1)
2019-12-31T19:27:52.893Z [DBG] WS+: c:[306e6aa0] Received frame: RPY#2 (flags= 1, length=1)
2019-12-31T19:27:52.893Z [DBG] WSFrame+: c:[306e6aa0] Queued MSG#3
2019-12-31T19:27:52.893Z [DBG] WS+: c:[306e6aa0] Push MSG#3
2019-12-31T19:27:52.893Z [DBG] WS+: c:[306e6aa0] Sending frame: MSG#3 (flags= 0, size= 47)
2019-12-31T19:27:52.893Z [DBG] WS+: c:[3e7c9510] Received frame: MSG#3 (flags= 0, length=47)
2019-12-31T19:27:52.893Z [DBG] WSFrame+: c:[3e7c9510] Incoming BLIP Request: MSG#3
2019-12-31T19:27:52.893Z [INF] SyncMsg: c:[3e7c9510] #3: Type:changes #Changes:1
2019-12-31T19:27:52.893Z [DBG] SyncMsg+: c:[3e7c9510] #3: Type:changes --> OK Time:315.377µs
2019-12-31T19:27:52.893Z [DBG] WS+: c:[3e7c9510] Push RPY#3~
2019-12-31T19:27:52.893Z [DBG] WS+: c:[3e7c9510] Sending frame: RPY#3~ (flags= 1001, size= 13)
2019-12-31T19:27:52.894Z [DBG] WS+: c:[306e6aa0] Received frame: RPY#3~ (flags= 1001, length=15)
2019-12-31T19:27:52.894Z [DBG] WSFrame+: c:[306e6aa0] Queued MSG#4
2019-12-31T19:27:52.894Z [DBG] WS+: c:[306e6aa0] Push MSG#4
2019-12-31T19:27:52.894Z [DBG] WS+: c:[306e6aa0] Sending frame: MSG#4 (flags= 0, size= 36)
2019-12-31T19:27:52.894Z [DBG] WS+: c:[3e7c9510] Received frame: MSG#4 (flags= 0, length=36)
2019-12-31T19:27:52.894Z [DBG] WSFrame+: c:[3e7c9510] Incoming BLIP Request: MSG#4
2019-12-31T19:27:52.894Z [INF] SyncMsg: c:[3e7c9510] #4: Type:subChanges Since:0 Continuous:true
2019-12-31T19:27:52.894Z [DBG] WS+: c:[3e7c9510] Push RPY#4
2019-12-31T19:27:52.894Z [DBG] WS+: c:[3e7c9510] Sending frame: RPY#4 (flags= 1, size= 1)
2019-12-31T19:27:52.894Z [DBG] WS+: c:[306e6aa0] Received frame: RPY#4 (flags= 1, length=1)
2019-12-31T19:27:52.894Z [INF] Sync: c:[3e7c9510] Sending changes since 0
2019-12-31T19:27:52.894Z [DBG] Changes+: c:[3e7c9510] Int sequence multi changes feed...
2019-12-31T19:27:52.894Z [INF] Changes: c:[3e7c9510] MultiChangesFeed(channels: {*}, options: {Since: 0, Limit: 0, Conflicts: false, IncludeDocs: false, Wait: true, Continuous: true, HeartbeatMs: 0, TimeoutMs: 0, ActiveOnly: false}) ...
2019-12-31T19:27:52.894Z [DBG] Changes+: c:[3e7c9510] MultiChangesFeed: channels expand to "!:1,*:1" ...
2019-12-31T19:27:52.894Z [DBG] Cache+: Initialized cache for channel "!" with min:50 max:500 age:1m0s, validFrom: 1
2019-12-31T19:27:52.894Z [DBG] Changes+: c:[3e7c9510] Grant for channel [!] is after the current sequence - skipped for this iteration. Grant:[1] Current:[0]
2019-12-31T19:27:52.894Z [DBG] Cache+: Initialized cache for channel "*" with min:50 max:500 age:1m0s, validFrom: 1
2019-12-31T19:27:52.894Z [DBG] Changes+: c:[3e7c9510] Grant for channel [*] is after the current sequence - skipped for this iteration. Grant:[1] Current:[0]
2019-12-31T19:27:52.894Z [DBG] Changes+: c:[3e7c9510] MultiChangesFeed waiting...
2019-12-31T19:27:52.894Z [DBG] Sync+: c:[3e7c9510] Sending 0 changes
2019-12-31T19:27:52.894Z [DBG] WSFrame+: c:[3e7c9510] Queued MSG#1~
2019-12-31T19:27:52.894Z [DBG] WS+: c:[3e7c9510] Push MSG#1~
2019-12-31T19:27:52.894Z [INF] Sync: c:[3e7c9510] Sent all changes to client
2019-12-31T19:27:52.894Z [DBG] WS+: c:[3e7c9510] Sending frame: MSG#1~ (flags= 101000, size= 51)
2019-12-31T19:27:52.894Z [DBG] WS+: c:[306e6aa0] Received frame: MSG#1~ (flags= 101000, length=53)
2019-12-31T19:27:52.894Z [DBG] WSFrame+: c:[306e6aa0] Incoming BLIP Request: MSG#1~
2019-12-31 19:27:52.894791 I | got changes message: MSG#1~
2019-12-31 19:27:52.894802 I | changes body: null, err: <nil>
2019-12-31T19:27:52.896Z [DBG] Changes+: Notifying that "test_data_bucket" changed (keys="{_sync:user:}") count=2
2019-12-31T19:27:52.896Z [DBG] DCP+: Received #1 after 4ms ("foo" / "1-abc")
2019-12-31T19:27:52.896Z [DBG] DCP+: #1 ==> channels [ * ]
2019-12-31T19:27:52.896Z [DBG] Changes+: Notifying that "test_data_bucket" changed (keys="{*}") count=3
2019-12-31T19:27:52.994Z [DBG] Changes+: c:[3e7c9510] MultiChangesFeed: channels expand to "!:1,*:1" ...
2019-12-31T19:27:52.994Z [DBG] Cache+: c:[3e7c9510] GetCachedChanges("!", 0) --> nothing cached
2019-12-31T19:27:52.994Z [DBG] Changes+: c:[3e7c9510] [changesFeed] Found 0 changes for channel "!"
2019-12-31T19:27:52.994Z [INF] Cache: c:[3e7c9510] GetCachedChanges("*", 0) --> 1 changes valid from #1
2019-12-31T19:27:52.994Z [DBG] Changes+: c:[3e7c9510] [changesFeed] Found 1 changes for channel "*"
2019-12-31T19:27:52.994Z [DBG] Changes+: c:[3e7c9510] Channel feed processing seq:1 in channel *
2019-12-31T19:27:52.994Z [DBG] Changes+: c:[3e7c9510] MultiChangesFeed sending {Seq:1, ID:foo, Changes:[map[rev:1-abc]]}
2019-12-31T19:27:52.994Z [DBG] Changes+: c:[3e7c9510] MultiChangesFeed waiting...
2019-12-31T19:27:52.994Z [DBG] Changes+: No new changes to send to change listener. Waiting for "test_data_bucket"'s count to pass 0
2019-12-31T19:27:52.994Z [DBG] Changes+: c:[3e7c9510] MultiChangesFeed reloading user &{roleImpl:{Name_: ExplicitChannels_:*:1 Channels_:!:1,*:1 Sequence_:0 PreviousChannels_: vbNo:<nil> cas:1577820472890753024} userImplBody:{Email_: Disabled_:false PasswordHash_:[] OldPasswordHash_:<nil> ExplicitRoles_: RolesSince_: OldExplicitRoles_:[]} auth:0xc000d325d0 roles:[]}
2019-12-31T19:27:52.994Z [DBG] Sync+: c:[3e7c9510] Sending 1 changes
2019-12-31T19:27:52.994Z [DBG] WSFrame+: c:[3e7c9510] Queued MSG#2~
2019-12-31T19:27:52.994Z [DBG] WS+: c:[3e7c9510] Push MSG#2~
2019-12-31T19:27:52.995Z [DBG] WS+: c:[3e7c9510] Sending frame: MSG#2~ (flags= 1000, size= 66)
2019-12-31T19:27:52.995Z [DBG] Changes+: c:[3e7c9510] MultiChangesFeed: channels expand to "!:1,*:1" ...
2019-12-31T19:27:52.995Z [DBG] Cache+: c:[3e7c9510] GetCachedChanges("!", 1) --> nothing cached
2019-12-31T19:27:52.995Z [DBG] Changes+: c:[3e7c9510] [changesFeed] Found 0 changes for channel "!"
2019-12-31T19:27:52.995Z [DBG] Cache+: c:[3e7c9510] GetCachedChanges("*", 1) --> nothing cached
2019-12-31T19:27:52.995Z [DBG] Changes+: c:[3e7c9510] [changesFeed] Found 0 changes for channel "*"
2019-12-31T19:27:52.995Z [DBG] Changes+: c:[3e7c9510] MultiChangesFeed waiting...
2019-12-31T19:27:52.995Z [DBG] Changes+: No new changes to send to change listener. Waiting for "test_data_bucket"'s count to pass 3
2019-12-31T19:27:52.995Z [DBG] WS+: c:[306e6aa0] Received frame: MSG#2~ (flags= 1000, length=18)
2019-12-31T19:27:52.995Z [DBG] WSFrame+: c:[306e6aa0] Incoming BLIP Request: MSG#2~
2019-12-31 19:27:52.995341 I | got changes message: MSG#2~
2019-12-31 19:27:52.995350 I | changes body: [[1,"foo","1-abc"]], err: <nil>
2019-12-31T19:27:52.995Z [DBG] WS+: c:[306e6aa0] Push RPY#2
2019-12-31T19:27:52.995Z [DBG] WS+: c:[306e6aa0] Sending frame: RPY#2 (flags= 1, size= 3)
2019-12-31T19:27:52.995Z [DBG] WS+: c:[306e6aa0] Sender stopped
2019-12-31T19:27:52.995Z [DBG] WS+: c:[3e7c9510] Received frame: RPY#2 (flags= 1, length=3)
2019-12-31T19:27:52.995Z [INF] Sync: c:[3e7c9510] Sent 1 changes to client, from seq 1
2019-12-31T19:27:52.995Z [INF] WS: c:[306e6aa0] Error: receiveLoop exiting with WebSocket error: read tcp 127.0.0.1:52108->127.0.0.1:40695: use of closed network connection
2019-12-31T19:27:52.995Z [DBG] Changes+: changeListener.Stop() called
2019-12-31T19:27:52.995Z [DBG] WS+: c:[306e6aa0] parseLoop stopped
2019-12-31T19:27:52.995Z [DBG] Sync+: c:[3e7c9510] Sending 0 changes
2019-12-31T19:27:52.995Z [DBG] Sync+: c:[3e7c9510] Sending 0 changes
2019-12-31T19:27:52.995Z [DBG] WS+: c:[3e7c9510] receiveLoop stopped
2019-12-31T19:27:52.995Z [DBG] Terminating background task: "Compact"
2019-12-31T19:27:52.995Z [DBG] Terminating background task: "CleanAgedItems"
2019-12-31T19:27:52.995Z [INF] WS: c:[306e6aa0] BLIP/Websocket receiveLoop exited: read tcp 127.0.0.1:52108->127.0.0.1:40695: use of closed network connection
2019-12-31T19:27:52.995Z [DBG] Terminating background task: "CleanSkippedSequenceQueue"
2019-12-31T19:27:52.995Z [INF] Changes: c:[3e7c9510] MultiChangesFeed done
2019-12-31T19:27:52.995Z [DBG] Terminating background task: "InsertPendingEntries"
2019-12-31T19:27:52.995Z [DBG] WS+: c:[3e7c9510] Sender stopped
2019-12-31T19:27:52.995Z [DBG] WS+: c:[3e7c9510] parseLoop stopped
2019-12-31T19:27:52.995Z [INF] HTTP: c:[3e7c9510] #001: --> BLIP+WebSocket connection closed
2019-12-31T19:27:52.996Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-a38317a4-2c03-11ea-bf53-80e650054dfa, refreshWorker-prior, vbucketState: "running" (has 1024 vbuckets), 0-1023
2019-12-31T19:27:52.996Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-a38317a4-2c03-11ea-bf53-80e650054dfa, refreshWorker-after, vbucketState: "running" (has 1024 vbuckets), 0-1023
2019-12-31T19:27:52.997Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: server: 127.0.0.1:11210, uprOpenName: SG-v-2.8-commit--uuid-a38317a4-2c03-11ea-bf53-80e650054dfa, worker, looping beg, vbucketState: "running" (has 1024 vbuckets), 0-1023
2019-12-31T19:27:52.997Z [WRN] c:test_data_bucket-SG Error processing DCP stream - will attempt to restart/reconnect if appropriate: pkt.Receive, err: read tcp 127.0.0.1:37052->127.0.0.1:11210: use of closed network connection. -- base.(*DCPReceiver).OnError() at dcp_receiver.go:61
2019-12-31T19:27:52.997Z [DBG] DCP+: c:test_data_bucket-SG cbdatasource: receiver closed, server: 127.0.0.1:11210, name: SG-v-2.8-commit--uuid-a38317a4-2c03-11ea-bf53-80e650054dfa, traces: vb: 0 => 94 (3x), 83 (1024x); vb: 84 => 86, md; vb: 115 => 86, md; vb: 225 => 86, md; vb: 520 => 86, md; vb: 608 => 86, md; vb: 704 => 86, md;
2019-12-31T19:27:53.005Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.006Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_56a5d570
2019-12-31T19:27:53.006Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_56a5d570: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37016->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.006Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_56a5d570-61515b2f, traces: vb: 0 => 94 (3x), 83 (64x);
2019-12-31T19:27:53.016Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:15
2019-12-31T19:27:53.016Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.016Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.016Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_f47365c5
2019-12-31T19:27:53.016Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_f47365c5-66ace35e, refreshWorker-prior, vbucketState: "running" (has 64 vbuckets), 192-255
2019-12-31T19:27:53.016Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_f47365c5-66ace35e, refreshWorker-after, vbucketState: "running" (has 64 vbuckets), 192-255
2019-12-31T19:27:53.016Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_f47365c5-66ace35e, worker, looping beg, vbucketState: "running" (has 64 vbuckets), 192-255
2019-12-31T19:27:53.016Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_f47365c5: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37044->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.016Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_f47365c5-66ace35e, traces: vb: 0 => 94 (3x), 83 (64x); vb: 225 => 86, md;
2019-12-31T19:27:53.022Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:14
2019-12-31T19:27:53.022Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.022Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.022Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_7332d0c7
2019-12-31T19:27:53.022Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_7332d0c7: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37040->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.022Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_7332d0c7-6bf5f26c, traces: vb: 0 => 94 (3x), 83 (64x); vb: 182 => 86, md;
2019-12-31T19:27:53.028Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:13
2019-12-31T19:27:53.028Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.028Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.028Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_1d526e8f
2019-12-31T19:27:53.028Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_1d526e8f: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37012->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.028Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_1d526e8f-2ef521df, traces: vb: 0 => 94 (3x), 83 (64x);
2019-12-31T19:27:53.032Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:12
2019-12-31T19:27:53.032Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.032Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.033Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_80d40edf
2019-12-31T19:27:53.033Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_80d40edf: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37038->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.033Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_80d40edf-2b5091bd, traces: vb: 0 => 94 (3x), 83 (64x); vb: 272 => 86, md; vb: 314 => 86, md;
2019-12-31T19:27:53.037Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:11
2019-12-31T19:27:53.037Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.037Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.037Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_120a6de6
2019-12-31T19:27:53.038Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_120a6de6-33aedf9a, refreshWorker-prior, vbucketState: "running" (has 64 vbuckets), 64-127
2019-12-31T19:27:53.038Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_120a6de6-33aedf9a, refreshWorker-after, vbucketState: "running" (has 64 vbuckets), 64-127
2019-12-31T19:27:53.038Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_120a6de6-33aedf9a, worker, looping beg, vbucketState: "running" (has 64 vbuckets), 64-127
2019-12-31T19:27:53.038Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_120a6de6: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37010->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.038Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_120a6de6-33aedf9a, traces: vb: 0 => 94 (3x), 83 (64x); vb: 84 => 86, md; vb: 115 => 86, md;
2019-12-31T19:27:53.042Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:10
2019-12-31T19:27:53.042Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.042Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.042Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_84003db0
2019-12-31T19:27:53.042Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_84003db0: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37048->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.042Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_84003db0-7452e2d9, traces: vb: 0 => 94 (3x), 83 (64x); vb: 507 => 86, md;
2019-12-31T19:27:53.047Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:9
2019-12-31T19:27:53.047Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.047Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.047Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_acbbef99
2019-12-31T19:27:53.047Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_acbbef99: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37030->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.047Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_acbbef99-1f20dc6b, traces: vb: 0 => 94 (3x), 83 (64x); vb: 39 => 86, md;
2019-12-31T19:27:53.052Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:8
2019-12-31T19:27:53.052Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.052Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.052Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_96da5535
2019-12-31T19:27:53.052Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_96da5535: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37034->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.052Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_96da5535-5a459da0, traces: vb: 0 => 94 (3x), 83 (64x);
2019-12-31T19:27:53.057Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:7
2019-12-31T19:27:53.057Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.057Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.057Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_627da171
2019-12-31T19:27:53.057Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_627da171: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37042->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.057Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_627da171-1d5eec3d, traces: vb: 0 => 94 (3x), 83 (64x);
2019-12-31T19:27:53.062Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:6
2019-12-31T19:27:53.062Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.062Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.062Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_5b084477
2019-12-31T19:27:53.062Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_5b084477: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37032->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.062Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_5b084477-5d9fa75a, traces: vb: 0 => 94 (3x), 83 (64x); vb: 704 => 86, md, 86, md;
2019-12-31T19:27:53.066Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:5
2019-12-31T19:27:53.066Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.066Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.067Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_1076212c
2019-12-31T19:27:53.067Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_1076212c: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37050->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.067Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_1076212c-74615bd0, traces: vb: 0 => 94 (3x), 83 (64x);
2019-12-31T19:27:53.071Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:4
2019-12-31T19:27:53.071Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.071Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.071Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_15a93994
2019-12-31T19:27:53.071Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_15a93994: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37046->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.071Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_15a93994-9ac155e, traces: vb: 0 => 94 (3x), 83 (64x);
2019-12-31T19:27:53.075Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:3
2019-12-31T19:27:53.075Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.075Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.075Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_7dc1913f
2019-12-31T19:27:53.075Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7dc1913f-df8918a, refreshWorker-prior, vbucketState: "running" (has 64 vbuckets), 512-575
2019-12-31T19:27:53.075Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7dc1913f-df8918a, refreshWorker-after, vbucketState: "running" (has 64 vbuckets), 512-575
2019-12-31T19:27:53.075Z [INF] DCP: cbdatasource: server: 127.0.0.1:11210, uprOpenName: sg:db_import_78f25425de4fc04d_7dc1913f-df8918a, worker, looping beg, vbucketState: "running" (has 64 vbuckets), 512-575
2019-12-31T19:27:53.076Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_7dc1913f: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37026->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.076Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_7dc1913f-df8918a, traces: vb: 0 => 94 (3x), 83 (64x); vb: 520 => 86, md;
2019-12-31T19:27:53.080Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:2
2019-12-31T19:27:53.080Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.080Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.080Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_103fc5fb
2019-12-31T19:27:53.080Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_103fc5fb: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37024->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.080Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_103fc5fb-cb5c637, traces: vb: 0 => 94 (3x), 83 (64x);
2019-12-31T19:27:53.084Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:1
2019-12-31T19:27:53.084Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.084Z [INF] DCP: janitor: awakes, op: janitor_close_pindex, msg: api-ClosePIndex
2019-12-31T19:27:53.084Z [INF] DCP: feed_dcp: close, name: db_import_78f25425de4fc04d_244a4eff
2019-12-31T19:27:53.084Z [INF] DCP: feed_dcp: OnError, name: db_import_78f25425de4fc04d_244a4eff: bucketName: test_data_bucket, bucketUUID: 680905b779497f22eb12727bbefcdaf6, err: pkt.Receive, err: read tcp 127.0.0.1:37014->127.0.0.1:11210: use of closed network connection
2019-12-31T19:27:53.084Z [INF] DCP: cbdatasource: receiver closed, server: 127.0.0.1:11210, name: sg:db_import_78f25425de4fc04d_244a4eff-1375c909, traces: vb: 0 => 94 (3x), 83 (64x); vb: 608 => 86, md; vb: 633 => 86, md;
2019-12-31T19:27:53.089Z [INF] DCP: c:test_data_bucket-SGI Closing sharded feed for SGI. Total partitions:0
2019-12-31T19:27:53.089Z [DBG] DCP+: c:test_data_bucket-SGI Closing DCPDest for SGI
2019-12-31T19:27:53.089Z [INF] rest.TestBlipPushRevisionInspectChanges: Reset logging
--- PASS: TestBlipPushRevisionInspectChanges (3.72s)
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment