{"action":"created","issue":{"url":"https://api.github.com/repos/couchbase/couchbase-lite-net/issues/980","repository_url":"https://api.github.com/repos/couchbase/couchbase-lite-net","labels_url":"https://api.github.com/repos/couchbase/couchbase-lite-net/issues/980/labels{/name}","comments_url":"https://api.github.com/repos/couchbase/couchbase-lite-net/issues/980/comments","events_url":"https://api.github.com/repos/couchbase/couchbase-lite-net/issues/980/events","html_url":"https://github.com/couchbase/couchbase-lite-net/issues/980","id":300816418,"number":980,"title":"Replication stuck in busy state with test_multiple_cbls_updates_concurrently_with_push","user":{"login":"raghusarangapani","id":24398601,"avatar_url":"https://avatars2.githubusercontent.com/u/24398601?v=4","gravatar_id":"","url":"https://api.github.com/users/raghusarangapani","html_url":"https://github.com/raghusarangapani","followers_url":"https://api.github.com/users/raghusarangapani/followers","following_url":"https://api.github.com/users/raghusarangapani/following{/other_user}","gists_url":"https://api.github.com/users/raghusarangapani/gists{/gist_id}","starred_url":"https://api.github.com/users/raghusarangapani/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/raghusarangapani/subscriptions","organizations_url":"https://api.github.com/users/raghusarangapani/orgs","repos_url":"https://api.github.com/users/raghusarangapani/repos","events_url":"https://api.github.com/users/raghusarangapani/events{/privacy}","received_events_url":"https://api.github.com/users/raghusarangapani/received_events","type":"User","site_admin":false},"labels":[{"id":107404160,"url":"https://api.github.com/repos/couchbase/couchbase-lite-net/labels/P1:%20high","name":"P1: high","color":"b60205","default":false},{"id":106776776,"url":"https://api.github.com/repos/couchbase/couchbase-lite-net/labels/ready","name":"ready","color":"ededed","default":false}],"state":"open","locked":false,"assignee":{"login":"borrrden","id":2470288,"avatar_url":"https://avatars0.githubusercontent.com/u/2470288?v=4","gravatar_id":"","url":"https://api.github.com/users/borrrden","html_url":"https://github.com/borrrden","followers_url":"https://api.github.com/users/borrrden/followers","following_url":"https://api.github.com/users/borrrden/following{/other_user}","gists_url":"https://api.github.com/users/borrrden/gists{/gist_id}","starred_url":"https://api.github.com/users/borrrden/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/borrrden/subscriptions","organizations_url":"https://api.github.com/users/borrrden/orgs","repos_url":"https://api.github.com/users/borrrden/repos","events_url":"https://api.github.com/users/borrrden/events{/privacy}","received_events_url":"https://api.github.com/users/borrrden/received_events","type":"User","site_admin":false},"assignees":[{"login":"borrrden","id":2470288,"avatar_url":"https://avatars0.githubusercontent.com/u/2470288?v=4","gravatar_id":"","url":"https://api.github.com/users/borrrden","html_url":"https://github.com/borrrden","followers_url":"https://api.github.com/users/borrrden/followers","following_url":"https://api.github.com/users/borrrden/following{/other_user}","gists_url":"https://api.github.com/users/borrrden/gists{/gist_id}","starred_url":"https://api.github.com/users/borrrden/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/borrrden/subscriptions","organizations_url":"https://api.github.com/users/borrrden/orgs","repos_url":"https://api.github.com/users/borrrden/repos","events_url":"https://api.github.com/users/borrrden/events{/privacy}","received_events_url":"https://api.github.com/users/borrrden/received_events","type":"User","site_admin":false}],"milestone":{"url":"https://api.github.com/repos/couchbase/couchbase-lite-net/milestones/18","html_url":"https://github.com/couchbase/couchbase-lite-net/milestone/18","labels_url":"https://api.github.com/repos/couchbase/couchbase-lite-net/milestones/18/labels","id":2010280,"number":18,"title":"2.0.0","description":"The 2.0.0 release milestone.  Issues in this milestone will be included in 2.0.0.","creator":{"login":"borrrden","id":2470288,"avatar_url":"https://avatars0.githubusercontent.com/u/2470288?v=4","gravatar_id":"","url":"https://api.github.com/users/borrrden","html_url":"https://github.com/borrrden","followers_url":"https://api.github.com/users/borrrden/followers","following_url":"https://api.github.com/users/borrrden/following{/other_user}","gists_url":"https://api.github.com/users/borrrden/gists{/gist_id}","starred_url":"https://api.github.com/users/borrrden/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/borrrden/subscriptions","organizations_url":"https://api.github.com/users/borrrden/orgs","repos_url":"https://api.github.com/users/borrrden/repos","events_url":"https://api.github.com/users/borrrden/events{/privacy}","received_events_url":"https://api.github.com/users/borrrden/received_events","type":"User","site_admin":false},"open_issues":4,"closed_issues":33,"state":"open","created_at":"2016-09-16T23:42:26Z","updated_at":"2018-03-04T15:49:24Z","due_on":"2018-02-28T08:00:00Z","closed_at":null},"comments":7,"created_at":"2018-02-27T22:23:41Z","updated_at":"2018-03-05T20:11:28Z","closed_at":null,"author_association":"NONE","body":"### Builds\r\n.net 2.0.0-b0571, SG 2.0.0-812, CBS 5.5.0-1924\r\n\r\n### Test Ran\r\n```\r\npytest -s --mode=di --server-version=5.5.0-1924 --sync-gateway-version=2.0.0-812 --liteserv-platform=net-msft --liteserv-host=192.168.33.21 --liteserv-port=55555  --xattrs testsuites/CBLTester/CBL_Functional_tests/test_no_conflicts_cbl.py --liteserv-version=2.0.0-b0571 -k test_multiple_cbls_updates_concurrently_with_push  --create-db-per-test test-db --skip-provisioning\r\n```\r\n### Actual\r\nThe test times out waiting for replicator to go idle.\r\nTest output\r\n```\r\n....\r\nActivity level: busy\r\nGot response: \r\nGot response: \"busy\"\r\nActivity level: busy\r\nFAILED\r\n.....\r\n>       replicator2.wait_until_replicator_idle(repl)\r\n.....\r\nE           Failed: Timeout >900s\r\n```\r\n\r\n### CBL logs\r\n```\r\nINFO) Sync {DBWorker#10} Saved local checkpoint cp-42vjx9lioMn1AspGRraDwa9UphU= to db\r\nINFO) Sync (Replicator) [13] 2018-02-27T13:53:37.7792737-08:00 Replicator[<*> DB[C:\\mobile-testkit\\CBLClient\\Apps\\CBLTestServer-Dotnet\\TestServer.NetCore\\bin\\Debug\\netcoreapp2.0\\CouchbaseLite\\cbl_db21519768338.06.cblite2\\]] is Busy, progress 840570/859654\r\nINFO) Sync (Replicator) [12] 2018-02-27T13:53:37.7870335-08:00 Replicator[<*> DB[C:\\mobile-testkit\\CBLClient\\Apps\\CBLTestServer-Dotnet\\TestServer.NetCore\\bin\\Debug\\netcoreapp2.0\\CouchbaseLite\\cbl_db21519768338.06.cblite2\\]] is Busy, progress 840570/859654\r\n```\r\nThe replicator is stuck in busy state and there is no activity.\r\n"},"comment":{"url":"https://api.github.com/repos/couchbase/couchbase-lite-net/issues/comments/370548417","html_url":"https://github.com/couchbase/couchbase-lite-net/issues/980#issuecomment-370548417","issue_url":"https://api.github.com/repos/couchbase/couchbase-lite-net/issues/980","id":370548417,"user":{"login":"snej","id":43241,"avatar_url":"https://avatars2.githubusercontent.com/u/43241?v=4","gravatar_id":"","url":"https://api.github.com/users/snej","html_url":"https://github.com/snej","followers_url":"https://api.github.com/users/snej/followers","following_url":"https://api.github.com/users/snej/following{/other_user}","gists_url":"https://api.github.com/users/snej/gists{/gist_id}","starred_url":"https://api.github.com/users/snej/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/snej/subscriptions","organizations_url":"https://api.github.com/users/snej/orgs","repos_url":"https://api.github.com/users/snej/repos","events_url":"https://api.github.com/users/snej/events{/privacy}","received_events_url":"https://api.github.com/users/snej/received_events","type":"User","site_admin":false},"created_at":"2018-03-05T20:11:28Z","updated_at":"2018-03-05T20:11:28Z","author_association":"MEMBER","body":"Thanks a lot for capturing all this. Let me see...\n\n* cbl2_passive -- `changeLists=229` means it's waiting for replies to 229 `proposeChanges` messages it's sent to the peer.\n* cbl1_2_continuous -- It's stalled out for a long time with `_pendingRevMessages=46`, meaning it's waiting for 46 `rev` messages from the peer.\n* Sure enough, `cbl2` has `revsToSend=46`. So why isn't it sending `rev` messages? That's triggered by `Pusher::maybeSendMoreRevs()` ... which implies that method isn't being called.\n* I think the culprit is `_couldntSendRevision()`, which is a new method called when a `rev` message can't be sent because the revision's been overwritten. It calls `doneWithRev()`, but not `maybeSendMoreRevs()` -- I'll add that call to it."}}
{"actor":{"display_login":"snej"}}