sg-replicate-issue.log

sg-replicate.log

2016/09/13 10:22:09 Replicate: [rep2-1] Unexpected notification, ignore
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnCatchingUp, waiting for event
2016/09/13 10:22:09 Replicate: sequenceNumberToString called with: 87 type: string
2016/09/13 10:22:09 Replicate: sequence is a string
2016/09/13 10:22:09 Replicate: sequenceNumberToString called with: 87 type: string
2016/09/13 10:22:09 Replicate: sequence is a string
2016/09/13 10:22:09 Replicate: [rep2-1] changes feed resp: &{200 OK 200 HTTP/1.1 1 1 map[Server:[Couchbase Sync Gateway/1.3.0] Date:[Tue, 13 Sep 2016 04:52:09 GMT] Cache-Control:[private, max-age=0, no-cache, no-store] Content-Type:[application/json]] 0xc82012ac00 -1 [] false map[] 0xc820488a80 <nil>}, err: <nil>
2016/09/13 10:22:09 Replicate: [rep2-1] event: &{FETCH_CHANGES_FEED_SUCCEEDED {[{88 121 [{1-71e4712f0f49e127a6ae64a4ae696b57}] false}] 88}}
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnActiveFetchChangesFeed got event: {FETCH_CHANGES_FEED_SUCCEEDED {[{88 121 [{1-71e4712f0f49e127a6ae64a4ae696b57}] false}] 88}}
2016/09/13 10:22:09 Replicate: [rep2-1] Transition from stateFnActiveFetchChangesFeed -> stateFnActiveFetchRevDiffs
2016/09/13 10:22:09 Replicate: [rep2-1] new state: 0x6e5eb0
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnActiveFetchRevDiffs
2016/09/13 10:22:09 Replicate: [rep2-1] Unexpected notification, ignore
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnCatchingUp, waiting for event
2016/09/13 10:22:09 Replicate: [rep2-1] revs diff resp: &{200 OK 200 HTTP/1.1 1 1 map[Content-Type:[text/plain; charset=utf-8] Server:[Couchbase Sync Gateway/1.3.0] Date:[Tue, 13 Sep 2016 04:52:09 GMT]] 0xc820568580 -1 [] false map[] 0xc820374380 <nil>}, err: <nil>
2016/09/13 10:22:09 Replicate: [rep2-1] event: &{FETCH_REVS_DIFF_SUCCEEDED map[121:{[1-71e4712f0f49e127a6ae64a4ae696b57]}]}
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnActiveFetchRevDiffs got event: {FETCH_REVS_DIFF_SUCCEEDED map[121:{[1-71e4712f0f49e127a6ae64a4ae696b57]}]}
2016/09/13 10:22:09 Replicate: [rep2-1] Transition from stateFnActiveFetchRevDiffs -> stateFnActiveFetchBulkGet
2016/09/13 10:22:09 Replicate: [rep2-1] Unexpected notification, ignore
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnCatchingUp, waiting for event
2016/09/13 10:22:09 Replicate: [rep2-1] new state: 0x6e6830
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnActiveFetchBulkGet
2016/09/13 10:22:09 Replicate: [rep2-1] bulkGetUrl http://10.2.0.205:4985/pttdata/_bulk_get?revs=true&attachments=true
2016/09/13 10:22:09 Replicate: [rep2-1] bulkGet req &{POST http://10.2.0.205:4985/pttdata/_bulk_get?revs=true&attachments=true HTTP/1.1 1 1 map[] {0xc820129740} 66 [] false 10.2.0.205:4985 map[] map[] <nil> map[]   <nil> <nil>}
2016/09/13 10:22:09 Replicate: [rep2-1] bulk get resp: &{200 OK 200 HTTP/1.1 1 1 map[Date:[Tue, 13 Sep 2016 04:52:09 GMT] Content-Length:[1031] Content-Type:[multipart/mixed; boundary="d5091b6d2949d306cfcebb168e5e6b90bcb5a91d061f421a99d6d1947e68"] Server:[Couchbase Sync Gateway/1.3.0]] 0xc8205689a0 1031 [] false map[] 0xc820374460 <nil>}, err: <nil>
2016/09/13 10:22:09 Replicate: [rep2-1] mainPart: &{map[Content-Type:[application/json]] 0xc8205667e0 0xc8204cef00 0  map[] {0xc8204e94a0}}.  Header: map[Content-Type:[application/json]]
2016/09/13 10:22:09 Replicate: [rep2-1] contentType: application/json
2016/09/13 10:22:09 Replicate: [rep2-1] boundary: 
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnActiveFetchBulkGet got event: {FETCH_BULK_GET_SUCCEEDED [{map[msgReceivedTime:1.453467114e+09 msgText:Oh My God !!!, Welcome to Kodiak Networks India Pvt Ltd. New Office at Manyata recipientType:contact expiration:1.456059114e+09 msgCreateTime:1.44309171491e+12 name:name_121 readers:[] writers:[] _id:121 errorDescription: msgPriority:0 msgProperty:4 opaqueData:NA status:0 to:[map[recipientName:919989229280 recipientId:s919989229280]] ver:1.0 _rev:1-71e4712f0f49e127a6ae64a4ae696b57 _revisions:map[ids:[71e4712f0f49e127a6ae64a4ae696b57] start:1] msgExpTime:0 msgLocation:map[geoLocation:map[geometry:map[coordinates:[] type:] id: properties:map[accuracy: clientReportTime: locDescp:] type:]] owners:[] ptxType:[multimedia] state:pending type:ptxmeta channels:[channel2-pool-1-thread-1-1] from:senderId::s919989229289] []}]}
2016/09/13 10:22:09 Replicate: [rep2-1] num docs w/o attachemnts: 1
2016/09/13 10:22:09 Replicate: [rep2-1] num docs w/ attachemnts: 0
2016/09/13 10:22:09 Replicate: [rep2-1] Transition from stateFnActiveFetchBulkGet -> stateFnActivePushBulkDocs
2016/09/13 10:22:09 Replicate: [rep2-1] new state: 0x6e7990
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnActivePushBulkDocs
2016/09/13 10:22:09 Replicate: [rep2-1] Unexpected notification, ignore
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnCatchingUp, waiting for event
2016/09/13 10:22:09 Replicate: [rep2-1] bulk get resp: &{201 Created 201 HTTP/1.1 1 1 map[Content-Length:[57] Content-Type:[application/json] Server:[Couchbase Sync Gateway/1.3.0] Date:[Tue, 13 Sep 2016 04:52:09 GMT]] 0xc82012b160 57 [] false map[] 0xc820488b60 <nil>}, err: <nil>
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnActivePushBulkDocs got event: {PUSH_BULK_DOCS_SUCCEEDED [{121 1-71e4712f0f49e127a6ae64a4ae696b57  }]}
2016/09/13 10:22:09 Replicate: [rep2-1] Transition from stateFnActivePushBulkDocs -> stateFnActivePushCheckpoint
2016/09/13 10:22:09 Replicate: [rep2-1] new state: 0x6e9020
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnActivePushCheckpoint
2016/09/13 10:22:09 Replicate: [rep2-1] calling pushCheckpointRequest. r.FetchedTargetCheckpoint: {87 0-58 _local/47d314bb15f231662636d5993de1a1f7f9130073}
2016/09/13 10:22:09 Replicate: [rep2-1] pushCheckpointRequest {88 0-58}
2016/09/13 10:22:09 Replicate: [rep2-1] Unexpected notification, ignore
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnCatchingUp, waiting for event
2016/09/13 10:22:09 Replicate: [rep2-1] r.Changes {[{88 121 [{1-71e4712f0f49e127a6ae64a4ae696b57}] false}] 88}
2016/09/13 10:22:09 Replicate: [rep2-1] r.Changes.LastSequence 88
2016/09/13 10:22:09 Replicate: [rep2-1] push checkpoint resp: &{Status:201 Created StatusCode:201 Proto:HTTP/1.1 ProtoMajor:1 ProtoMinor:1 Header:map[Content-Length:[79] Content-Type:[application/json] Server:[Couchbase Sync Gateway/1.3.0] Date:[Tue, 13 Sep 2016 04:52:09 GMT]] Body:0xc820569b40 ContentLength:79 TransferEncoding:[] Close:false Trailer:map[] Request:0xc820374700 TLS:<nil>}, err: <nil>
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnActivePushCheckpoint got event: {PUSH_CHECKPOINT_SUCCEEDED <nil>}
2016/09/13 10:22:09 Replicate: [rep2-1] Transition from stateFnActivePushCheckpoint -> stateFnActiveFetchCheckpoint
2016/09/13 10:22:09 Replicate: [rep2-1] new state: 0x6e4af0
2016/09/13 10:22:09 Replicate: [rep2-1] Unexpected notification, ignore
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnCatchingUp, waiting for event
2016/09/13 10:22:09 Replicate: [rep2-1] resp: &{200 OK 200 HTTP/1.1 1 1 map[Content-Length:[91] Content-Type:[application/json] Server:[Couchbase Sync Gateway/1.3.0] Date:[Tue, 13 Sep 2016 04:52:09 GMT]] 0xc820244d40 91 [] false map[] 0xc8203747e0 <nil>}, err: <nil>
2016/09/13 10:22:09 Replicate: [rep2-1] valid checkpoint
2016/09/13 10:22:09 Replicate: [rep2-1] body: {"_id":"_local/47d314bb15f231662636d5993de1a1f7f9130073","_rev":"0-59","lastSequence":"88"}
2016/09/13 10:22:09 Replicate: [rep2-1] checkpoint: 88
2016/09/13 10:22:09 Replicate: [rep2-1] event: &{FETCH_CHECKPOINT_SUCCEEDED {88 0-59 _local/47d314bb15f231662636d5993de1a1f7f9130073}}
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnActiveFetchCheckpoint got event: {FETCH_CHECKPOINT_SUCCEEDED {88 0-59 _local/47d314bb15f231662636d5993de1a1f7f9130073}}
2016/09/13 10:22:09 Replicate: [rep2-1] call fetchChangesFeed()
2016/09/13 10:22:09 Replicate: [rep2-1] Transition from stateFnActiveFetchCheckpoint -> stateFnActiveFetchChangesFeed
2016/09/13 10:22:09 Replicate: [rep2-1] new state: 0x6e5500
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnActiveFetchChangesFeed
2016/09/13 10:22:09 Replicate: [rep2-1] Unexpected notification, ignore
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnCatchingUp, waiting for event
2016/09/13 10:22:09 Replicate: sequenceNumberToString called with: 88 type: string
2016/09/13 10:22:09 Replicate: sequence is a string
2016/09/13 10:22:09 Replicate: sequenceNumberToString called with: 88 type: string
2016/09/13 10:22:09 Replicate: sequence is a string
2016/09/13 10:22:09 Replicate: [rep2-1] changes feed resp: &{200 OK 200 HTTP/1.1 1 1 map[Cache-Control:[private, max-age=0, no-cache, no-store] Content-Type:[application/json] Server:[Couchbase Sync Gateway/1.3.0] Date:[Tue, 13 Sep 2016 04:52:09 GMT]] 0xc82012b6e0 -1 [] false map[] 0xc8204300e0 <nil>}, err: <nil>
2016/09/13 10:22:09 Replicate: [rep2-1] event: &{FETCH_CHANGES_FEED_SUCCEEDED {[] 88}}
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnActiveFetchChangesFeed got event: {FETCH_CHANGES_FEED_SUCCEEDED {[] 88}}
2016/09/13 10:22:09 Replicate: [rep2-1] Unexpected notification, ignore
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnCatchingUp, waiting for event
2016/09/13 10:22:09 Replicate: [rep2-1] Replication stopped, caught up
2016/09/13 10:22:09 Replicate: [rep2-1] continuous repl new state: 0x6e28d0
2016/09/13 10:22:09 Replicate: [rep2-1] continuous repl state: 0x6e28d0
2016/09/13 10:22:09 Replicate: [rep2-1] stateFnWaitNewChanges, waiting for event
2016/09/13 10:22:09 Replicate: sequenceNumberToString called with: 88 type: string
2016/09/13 10:22:09 Replicate: sequence is a string
2016/09/13 10:22:09 Replicate: sequenceNumberToString called with: 88 type: string
2016/09/13 10:22:09 Replicate: sequence is a string
2016/09/13 10:22:09 Replicate: [rep2-1] fetching longpoll changes at url: http://10.2.0.205:4985/pttdata/_changes?feed=longpoll&limit=50&heartbeat=30000&style=all_docs&since=88
2016/09/13 10:22:09 Replicate: [rep2-1] new state: <nil>
2016/09/13 10:22:09 Replicate: [rep2-1] processEvents() is done
2016/09/13 10:22:09 Replicate: [rep2-1] longpoll changes feed resp: &{200 OK 200 HTTP/1.1 1 1 map[Date:[Tue, 13 Sep 2016 04:52:09 GMT] Cache-Control:[private, max-age=0, no-cache, no-store] Content-Type:[application/json] Server:[Couchbase Sync Gateway/1.3.0]] 0xc82023d100 -1 [chunked] false map[] 0xc8203748c0 <nil>}, err: <nil>
2016-09-13T10:22:18.022+05:30 Enabling logging: [*]
2016/09/13 10:22:18 Replicate: [rep2-1] ContinuousReplication.processEvents()
2016/09/13 10:22:18 Replicate: [rep2-1] continuous repl state: 0x6e2140
2016/09/13 10:22:18 Replicate: [rep2-1] stateFnPreStarted got event: {REPLICATION_START <nil>}
2016/09/13 10:22:18 Replicate: [rep2-1] stateFnPreStarted got START event: {REPLICATION_START <nil>}
2016/09/13 10:22:18 Replicate: [rep2-1] stateFnCatchingUp, waiting for event
2016/09/13 10:22:18 Replicate: [rep2-1] Unexpected notification, ignore
2016/09/13 10:22:18 Replicate: [rep2-1] stateFnCatchingUp, waiting for event
2016/09/13 10:22:18 Replicate: [rep2-1] sent notificication: &{REPLICATION_ACTIVE <nil> <nil>}
2016/09/13 10:22:18 Replicate: [rep2-1] Transition from stateFnActiveFetchCheckpoint -> stateFnActive
2016/09/13 10:22:18 Replicate: [rep2-1] new state: 0x6e4af0
2016/09/13 10:22:18 Replicate: [rep2-1] resp: &{200 OK 200 HTTP/1.1 1 1 map[Content-Type:[application/json] Server:[Couchbase Sync Gateway/1.3.0] Date:[Tue, 13 Sep 2016 04:52:18 GMT] Content-Length:[91]] 0xc820328080 91 [] false map[] 0xc82029e000 <nil>}, err: <nil>
2016/09/13 10:22:18 Replicate: [rep2-1] valid checkpoint
2016/09/13 10:22:18 Replicate: [rep2-1] body: {"_id":"_local/47d314bb15f231662636d5993de1a1f7f9130073","_rev":"0-59","lastSequence":"88"}
2016/09/13 10:22:18 Replicate: [rep2-1] checkpoint: 88
2016/09/13 10:22:18 Replicate: [rep2-1] event: &{FETCH_CHECKPOINT_SUCCEEDED {88 0-59 _local/47d314bb15f231662636d5993de1a1f7f9130073}}
2016/09/13 10:22:18 Replicate: [rep2-1] stateFnActiveFetchCheckpoint got event: {FETCH_CHECKPOINT_SUCCEEDED {88 0-59 _local/47d314bb15f231662636d5993de1a1f7f9130073}}
2016/09/13 10:22:18 Replicate: [rep2-1] call fetchChangesFeed()
2016/09/13 10:22:18 Replicate: [rep2-1] Transition from stateFnActiveFetchCheckpoint -> stateFnActiveFetchChangesFeed
2016/09/13 10:22:18 Replicate: [rep2-1] new state: 0x6e5500
2016/09/13 10:22:18 Replicate: [rep2-1] Unexpected notification, ignore
2016/09/13 10:22:18 Replicate: [rep2-1] stateFnCatchingUp, waiting for event
2016/09/13 10:22:18 Replicate: [rep2-1] stateFnActiveFetchChangesFeed
2016/09/13 10:22:18 Replicate: sequenceNumberToString called with: 88 type: string
2016/09/13 10:22:18 Replicate: sequence is a string
2016/09/13 10:22:18 Replicate: sequenceNumberToString called with: 88 type: string
2016/09/13 10:22:18 Replicate: sequence is a string
2016/09/13 10:22:18 Replicate: [rep2-1] changes feed resp: &{200 OK 200 HTTP/1.1 1 1 map[Content-Type:[application/json] Server:[Couchbase Sync Gateway/1.3.0] Date:[Tue, 13 Sep 2016 04:52:18 GMT] Cache-Control:[private, max-age=0, no-cache, no-store]] 0xc82012c720 -1 [] false map[] 0xc82037c000 <nil>}, err: <nil>
2016/09/13 10:22:18 Replicate: [rep2-1] event: &{FETCH_CHANGES_FEED_SUCCEEDED {[{88::90 124 [{1-7dc450efeefc7e01eefb008edf071ce3}] false} {88::92 128 [{1-98b084f3e4d2c12e9280ec3902b812bd}] false} {88::93 131 [{1-eba3e101c075c8109bc017c2bfbad72f}] false} {88::94 132 [{1-d94ed3b15165c56b395f70206fd2e079}] false} {88::96 137 [{1-57ff41b11696c07be2b8e3957d9c64a2}] false} {88::97 138 [{1-087bc93597d7ee313527c6a6bd3c222a}] false} {88::100 143 [{1-16eb850434dd32b1a3062397ae73e248}] false} {88::101 145 [{1-4b15bd925e5e6bd9e643ae1515ed6352}] false} {88::102 146 [{1-6a530acc6d4d71bc991824957aec1390}] false}] 88::102}}
2016/09/13 10:22:18 Replicate: [rep2-1] stateFnActiveFetchChangesFeed got event: {FETCH_CHANGES_FEED_SUCCEEDED {[{88::90 124 [{1-7dc450efeefc7e01eefb008edf071ce3}] false} {88::92 128 [{1-98b084f3e4d2c12e9280ec3902b812bd}] false} {88::93 131 [{1-eba3e101c075c8109bc017c2bfbad72f}] false} {88::94 132 [{1-d94ed3b15165c56b395f70206fd2e079}] false} {88::96 137 [{1-57ff41b11696c07be2b8e3957d9c64a2}] false} {88::97 138 [{1-087bc93597d7ee313527c6a6bd3c222a}] false} {88::100 143 [{1-16eb850434dd32b1a3062397ae73e248}] false} {88::101 145 [{1-4b15bd925e5e6bd9e643ae1515ed6352}] false} {88::102 146 [{1-6a530acc6d4d71bc991824957aec1390}] false}] 88::102}}
2016/09/13 10:22:18 Replicate: [rep2-1] Transition from stateFnActiveFetchChangesFeed -> stateFnActiveFetchRevDiffs
2016/09/13 10:22:18 Replicate: [rep2-1] new state: 0x6e5eb0
2016/09/13 10:22:18 Replicate: [rep2-1] stateFnActiveFetchRevDiffs
016/09/13 10:22:18 Replicate: [rep2-1] Unexpected notification, ignore
2016/09/13 10:22:18 Replicate: [rep2-1] stateFnCatchingUp, waiting for event
2016/09/13 10:22:18 Replicate: [rep2-1] revs diff resp: &{200 OK 200 HTTP/1.1 1 1 map[Content-Type:[text/plain; charset=utf-8] Server:[Couchbase Sync Gateway/1.3.0] Date:[Tue, 13 Sep 2016 04:52:18 GMT]] 0xc82048ffc0 -1 [] false map[] 0xc82029e1c0 <nil>}, err: <nil>
2016/09/13 10:22:18 Replicate: [rep2-1] event: &{FETCH_REVS_DIFF_SUCCEEDED map[143:{[1-16eb850434dd32b1a3062397ae73e248]} 146:{[1-6a530acc6d4d71bc991824957aec1390]} 137:{[1-57ff41b11696c07be2b8e3957d9c64a2]} 124:{[1-7dc450efeefc7e01eefb008edf071ce3]} 131:{[1-eba3e101c075c8109bc017c2bfbad72f]} 128:{[1-98b084f3e4d2c12e9280ec3902b812bd]} 132:{[1-d94ed3b15165c56b395f70206fd2e079]} 145:{[1-4b15bd925e5e6bd9e643ae1515ed6352]} 138:{[1-087bc93597d7ee313527c6a6bd3c222a]}]}

sg-replicate_config.json

site-1
{
   "interface":":4984",
   "adminInterface":":4985",
   "log": ["*"],
   "replications":[
                    {
                    "replication_id":"rep2-1",
                    "source": "http://10.2.0.205:4985/pttdata/",
                    "target": "http://10.2.0.185:4985/pttdata/",
                    "continuous":true
                    }]
}

site-2
{
   "interface":":4984",
   "adminInterface":":4985",
   "log": ["*"],
   "replications":[
                    {
                    "replication_id":"rep1-2",
                    "source": "http://10.2.0.185:4985/pttdata/",
                    "target": "http://10.2.0.205:4985/pttdata/",
                    "continuous":true
                    }]

syncgateway.log

10:20:06.863420 2016-09-13T10:20:06.863+05:30 Opening db /ptxdata as bucket "ptxdata", pool "default", server <http://cbs:8091>
10:20:06.863488 2016-09-13T10:20:06.863+05:30 Opening Couchbase database ptxdata on <http://cbs:8091>
10:20:06.924020 2016-09-13T10:20:06.924+05:30 Bucket: PutDDoc("sync_gateway", ...) [28.356545ms]
10:20:07.026675 2016-09-13T10:20:07.026+05:30 Bucket: PutDDoc("sync_housekeeping", ...) [102.608068ms]
10:20:07.028543 2016-09-13T10:20:07.028+05:30 Bucket: Incr("_sync:seq", 0, 0, 0) [1.743419ms]
10:20:07.028745 2016-09-13T10:20:07.028+05:30 Bucket: Incr("_sync:seq", 0, 0, 0) [179.216µs]
10:20:07.028787 2016-09-13T10:20:07.028+05:30 Cache: Initializing changes cache with options {ChannelCacheOptions:{ChannelCacheMinLength:0 ChannelCacheMaxLength:0 ChannelCacheAge:0} CachePendingSeqMaxWait:5s CachePendingSeqMaxNum:10000 CacheSkippedSeqMaxWait:1h0m0s}
10:20:07.028807 2016-09-13T10:20:07.028+05:30 Feed: Using TAP feed for bucket: "ptxdata" (based on feed_type specified in config file
10:20:07.028844 2016-09-13T10:20:07.028+05:30 Bucket: StartTapFeed(...) [37.685µs]
10:20:07.029122 2016-09-13T10:20:07.029+05:30 Bucket: Update("_sync:syncdata", 0, ...) --> CAS quit [258.599µs]
10:20:08.408927 2016-09-13T10:20:08.408+05:30 Bucket: View("sync_gateway", "principals", ...) [1.379773993s]
10:20:08.408951 2016-09-13T10:20:08.408+05:30 WARNING: No users have been defined in the 'ptxdata' database, which means that you will not be able to get useful data out of the sync gateway over the standard port.  FIX: define users in the configuration json or via the REST API on the admin port, and grant users to channels via the admin_channels parameter. -- rest.emitAccessRelatedWarnings() at server_context.go:895
10:20:08.409026 2016-09-13T10:20:08.409+05:30 Events: Creating new JSEventFunction
10:20:08.409050 2016-09-13T10:20:08.409+05:30 Events: Registered event handler: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/PTX], for event type 0
10:20:08.409060 2016-09-13T10:20:08.409+05:30 Events: Starting event manager with max processes:200, wait time:30000 ms
10:20:08.409095 2016-09-13T10:20:08.409+05:30 Starting admin server on :4985
10:20:08.415025 2016-09-13T10:20:08.415+05:30 Starting server on :4984 ...
10:20:19.777374 2016-09-13T10:20:19.777+05:30 HTTP:  #001: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:19.779254 2016-09-13T10:20:19.779+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [1.848939ms]
10:20:19.779325 2016-09-13T10:20:19.779+05:30 HTTP+: #001:     --> 200   (2.0 ms)
10:20:20.282250 2016-09-13T10:20:20.282+05:30 HTTP:  #002: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:20.282510 2016-09-13T10:20:20.282+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [223.123µs]
10:20:20.282587 2016-09-13T10:20:20.282+05:30 HTTP+: #002:     --> 200   (0.4 ms)
10:20:20.785327 2016-09-13T10:20:20.785+05:30 HTTP:  #003: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:20.785629 2016-09-13T10:20:20.785+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [272.965µs]
10:20:20.785705 2016-09-13T10:20:20.785+05:30 HTTP+: #003:     --> 200   (0.4 ms)
10:20:21.288340 2016-09-13T10:20:21.288+05:30 HTTP:  #004: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:21.288586 2016-09-13T10:20:21.288+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [216.151µs]
10:20:21.288651 2016-09-13T10:20:21.288+05:30 HTTP+: #004:     --> 200   (0.3 ms)
10:20:21.791450 2016-09-13T10:20:21.791+05:30 HTTP:  #005: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:21.791708 2016-09-13T10:20:21.791+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [226.619µs]
10:20:21.791753 2016-09-13T10:20:21.791+05:30 HTTP+: #005:     --> 200   (0.3 ms)
10:20:22.294544 2016-09-13T10:20:22.294+05:30 HTTP:  #006: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:22.294755 2016-09-13T10:20:22.294+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [179.407µs]
10:20:22.294809 2016-09-13T10:20:22.294+05:30 HTTP+: #006:     --> 200   (0.3 ms)
10:20:22.797876 2016-09-13T10:20:22.797+05:30 HTTP:  #007: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:22.798172 2016-09-13T10:20:22.798+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [241.177µs]
10:20:22.798242 2016-09-13T10:20:22.798+05:30 HTTP+: #007:     --> 200   (0.4 ms)
10:20:23.300998 2016-09-13T10:20:23.300+05:30 HTTP:  #008: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:23.301289 2016-09-13T10:20:23.301+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [259.914µs]
10:20:23.301363 2016-09-13T10:20:23.301+05:30 HTTP+: #008:     --> 200   (0.4 ms)
10:20:23.804050 2016-09-13T10:20:23.804+05:30 HTTP:  #009: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:23.804314 2016-09-13T10:20:23.804+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [235.45µs]
10:20:23.804368 2016-09-13T10:20:23.804+05:30 HTTP+: #009:     --> 200   (0.3 ms)
10:20:24.307194 2016-09-13T10:20:24.307+05:30 HTTP:  #010: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:24.307473 2016-09-13T10:20:24.307+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [232.261µs]
10:20:24.307527 2016-09-13T10:20:24.307+05:30 HTTP+: #010:     --> 200   (0.4 ms)
10:20:24.810209 2016-09-13T10:20:24.810+05:30 HTTP:  #011: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:24.810501 2016-09-13T10:20:24.810+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [249.677µs]
10:20:24.810571 2016-09-13T10:20:24.810+05:30 HTTP+: #011:     --> 200   (0.4 ms)
10:20:25.313244 2016-09-13T10:20:25.313+05:30 HTTP:  #012: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:25.313560 2016-09-13T10:20:25.313+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [275.628µs]
10:20:25.313613 2016-09-13T10:20:25.313+05:30 HTTP+: #012:     --> 200   (0.4 ms)
10:20:25.816739 2016-09-13T10:20:25.816+05:30 HTTP:  #013: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:25.816976 2016-09-13T10:20:25.816+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [209.046µs]
10:20:25.817028 2016-09-13T10:20:25.817+05:30 HTTP+: #013:     --> 200   (0.3 ms)
10:20:26.319875 2016-09-13T10:20:26.319+05:30 HTTP:  #014: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:26.320132 2016-09-13T10:20:26.320+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [217.496µs]
10:20:26.320199 2016-09-13T10:20:26.320+05:30 HTTP+: #014:     --> 200   (0.3 ms)
10:20:26.823038 2016-09-13T10:20:26.823+05:30 HTTP:  #015: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:26.823319 2016-09-13T10:20:26.823+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [249.937µs]
10:20:26.823376 2016-09-13T10:20:26.823+05:30 HTTP+: #015:     --> 200   (0.4 ms)
10:20:27.326091 2016-09-13T10:20:27.326+05:30 HTTP:  #016: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:27.326357 2016-09-13T10:20:27.326+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [237.843µs]
10:20:27.326414 2016-09-13T10:20:27.326+05:30 HTTP+: #016:     --> 200   (0.3 ms)
10:20:27.829376 2016-09-13T10:20:27.829+05:30 HTTP:  #017: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:27.829678 2016-09-13T10:20:27.829+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [274.008µs]
10:20:27.829741 2016-09-13T10:20:27.829+05:30 HTTP+: #017:     --> 200   (0.4 ms)
10:20:28.332572 2016-09-13T10:20:28.332+05:30 HTTP:  #018: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:28.332822 2016-09-13T10:20:28.332+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [222.045µs]
10:20:28.332875 2016-09-13T10:20:28.332+05:30 HTTP+: #018:     --> 200   (0.3 ms)
10:20:28.835702 2016-09-13T10:20:28.835+05:30 HTTP:  #019: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:28.836018 2016-09-13T10:20:28.836+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [283.503µs]
10:20:28.836075 2016-09-13T10:20:28.836+05:30 HTTP+: #019:     --> 200   (0.4 ms)
10:20:29.338621 2016-09-13T10:20:29.338+05:30 HTTP:  #020: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:29.338927 2016-09-13T10:20:29.338+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [274.795µs]
10:20:29.338997 2016-09-13T10:20:29.338+05:30 HTTP+: #020:     --> 200   (0.4 ms)
10:20:29.841554 2016-09-13T10:20:29.841+05:30 HTTP:  #021: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:29.841836 2016-09-13T10:20:29.841+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [252.058µs]
10:20:29.841887 2016-09-13T10:20:29.841+05:30 HTTP+: #021:     --> 200   (0.4 ms)
10:20:30.344608 2016-09-13T10:20:30.344+05:30 HTTP:  #022: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:30.344874 2016-09-13T10:20:30.344+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [239.857µs]
10:20:30.344944 2016-09-13T10:20:30.344+05:30 HTTP+: #022:     --> 200   (0.4 ms)
10:20:30.847705 2016-09-13T10:20:30.847+05:30 HTTP:  #023: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:20:30.847951 2016-09-13T10:20:30.847+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [218.611µs]
10:20:30.848004 2016-09-13T10:20:30.847+05:30 HTTP+: #023:     --> 200   (0.3 ms)
10:20:31.158739 2016-09-13T10:20:31.158+05:30 HTTP:  #024: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=66  (ADMIN)
10:20:31.158901 2016-09-13T10:20:31.158+05:30 Changes+: Int sequence multi changes feed...
10:20:31.159039 2016-09-13T10:20:31.158+05:30 Changes: MultiChangesFeed({*}, {Since:66 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc820387740 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:20:31.159568 2016-09-13T10:20:31.159+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:20:31.159701 2016-09-13T10:20:31.159+05:30 Cache: Initialized cache for channel "*" with options: &{ChannelCacheMinLength:50 ChannelCacheMaxLength:500 ChannelCacheAge:1m0s}
10:20:31.159748 2016-09-13T10:20:31.159+05:30 Cache: getCachedChanges("*", {1 0 0 66 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 0 changes valid from #67
10:20:31.159764 2016-09-13T10:20:31.159+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:20:31.159781 2016-09-13T10:20:31.159+05:30 Changes: MultiChangesFeed done 
10:20:31.160760 2016-09-13T10:20:31.160+05:30 HTTP+: #024:     --> 200 OK  (0.0 ms)
10:20:31.162873 2016-09-13T10:20:31.162+05:30 HTTP:  #025: GET /pttdata/_changes?feed=longpoll&limit=50&heartbeat=30000&style=all_docs&since=66  (ADMIN)
10:20:31.162936 2016-09-13T10:20:31.162+05:30 Changes+: Int sequence multi changes feed...
10:20:31.162986 2016-09-13T10:20:31.162+05:30 Changes: MultiChangesFeed({*}, {Since:66 Limit:50 Conflicts:true IncludeDocs:false Wait:true Continuous:false Terminator:0xc820169800 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:20:31.163244 2016-09-13T10:20:31.163+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:20:31.163274 2016-09-13T10:20:31.163+05:30 Cache: getCachedChanges("*", {1 0 0 66 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 0 changes valid from #67
10:20:31.163279 2016-09-13T10:20:31.163+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:20:31.163285 2016-09-13T10:20:31.163+05:30 Changes+: MultiChangesFeed waiting... 
10:20:31.163294 2016-09-13T10:20:31.163+05:30 Changes+: Waiting for "pttdata"'s count to pass 0
10:20:41.756811 2016-09-13T10:20:41.756+05:30 HTTP:  #026: GET /
10:20:41.756862 2016-09-13T10:20:41.756+05:30 HTTP+: #026:     --> 200   (0.1 ms)
10:20:41.910830 2016-09-13T10:20:41.910+05:30 HTTP:  #027: GET /pttdata/  (ADMIN)
10:20:41.913092 2016-09-13T10:20:41.913+05:30 Bucket: Incr("_sync:seq", 0, 0, 0) [2.211329ms]
10:20:41.913262 2016-09-13T10:20:41.913+05:30 HTTP+: #027:     --> 200   (2.5 ms)
10:20:42.067970 2016-09-13T10:20:42.067+05:30 HTTP:  #028: GET /ptxdata/  (ADMIN)
10:20:42.069837 2016-09-13T10:20:42.069+05:30 Bucket: Incr("_sync:seq", 0, 0, 0) [1.817021ms]
10:20:42.069883 2016-09-13T10:20:42.069+05:30 HTTP+: #028:     --> 200   (2.0 ms)
10:20:50.714374 2016-09-13T10:20:50.714+05:30 Changes: Connection lost from client:  (as ADMIN)
10:20:50.714451 2016-09-13T10:20:50.714+05:30 HTTP+: #025:     --> 200 OK  (0.0 ms)
10:20:55.880403 2016-09-13T10:20:55.880+05:30 HTTP:  #029: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=66  (ADMIN)
10:20:55.880475 2016-09-13T10:20:55.880+05:30 Changes+: Int sequence multi changes feed...
10:20:55.880542 2016-09-13T10:20:55.880+05:30 Changes: MultiChangesFeed({*}, {Since:66 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc8206a96e0 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:20:55.880856 2016-09-13T10:20:55.880+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:20:55.880881 2016-09-13T10:20:55.880+05:30 Cache: getCachedChanges("*", {1 0 0 66 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 0 changes valid from #67
10:20:55.880886 2016-09-13T10:20:55.880+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:20:55.880892 2016-09-13T10:20:55.880+05:30 Changes: MultiChangesFeed done 
10:20:55.880908 2016-09-13T10:20:55.880+05:30 HTTP+: #029:     --> 200 OK  (0.0 ms)
10:20:55.882447 2016-09-13T10:20:55.882+05:30 HTTP:  #030: GET /pttdata/_changes?feed=longpoll&limit=50&heartbeat=30000&style=all_docs&since=66  (ADMIN)
10:20:55.882497 2016-09-13T10:20:55.882+05:30 Changes+: Int sequence multi changes feed...
10:20:55.882534 2016-09-13T10:20:55.882+05:30 Changes: MultiChangesFeed({*}, {Since:66 Limit:50 Conflicts:true IncludeDocs:false Wait:true Continuous:false Terminator:0xc82059cea0 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:20:55.882782 2016-09-13T10:20:55.882+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:20:55.882834 2016-09-13T10:20:55.882+05:30 Cache: getCachedChanges("*", {1 0 0 66 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 0 changes valid from #67
10:20:55.882839 2016-09-13T10:20:55.882+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:20:55.882844 2016-09-13T10:20:55.882+05:30 Changes+: MultiChangesFeed waiting... 
10:20:55.882853 2016-09-13T10:20:55.882+05:30 Changes+: Waiting for "pttdata"'s count to pass 0
10:21:00.378578 2016-09-13T10:21:00.378+05:30 HTTP:  #031: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:00.378801 2016-09-13T10:21:00.378+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [192.81µs]
10:21:00.378844 2016-09-13T10:21:00.378+05:30 HTTP+: #031:     --> 200   (0.3 ms)
10:21:12.250908 2016-09-13T10:21:12.250+05:30 HTTP:  #032: GET /
10:21:12.250987 2016-09-13T10:21:12.250+05:30 HTTP+: #032:     --> 200   (0.1 ms)
10:21:12.405051 2016-09-13T10:21:12.405+05:30 HTTP:  #033: GET /pttdata/  (ADMIN)
10:21:12.405558 2016-09-13T10:21:12.405+05:30 Bucket: Incr("_sync:seq", 0, 0, 0) [468.689µs]
10:21:12.405655 2016-09-13T10:21:12.405+05:30 HTTP+: #033:     --> 200   (0.6 ms)
10:21:12.559678 2016-09-13T10:21:12.559+05:30 HTTP:  #034: GET /ptxdata/  (ADMIN)
10:21:12.559910 2016-09-13T10:21:12.559+05:30 Bucket: Incr("_sync:seq", 0, 0, 0) [199.091µs]
10:21:12.559967 2016-09-13T10:21:12.559+05:30 HTTP+: #034:     --> 200   (0.3 ms)
10:21:15.805686 2016-09-13T10:21:15.805+05:30 HTTP:  #035: PUT /pttdata/100  (ADMIN)
10:21:15.806179 2016-09-13T10:21:15.806+05:30 CRUD+: Invoking sync on doc "100" rev 1-6c6e0ddca6ccca4283a497208f7d29a2
10:21:15.851332 2016-09-13T10:21:15.851+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [214.4µs]
10:21:15.851354 2016-09-13T10:21:15.851+05:30 CRUD: 	Doc "100" in channels "{channel2-pool-1-thread-1-1}"
10:21:15.851569 2016-09-13T10:21:15.851+05:30 Cache: SAVING #67
10:21:15.851856 2016-09-13T10:21:15.851+05:30 Bucket: WriteUpdate("100", 0, ...) --> <nil> [45.974772ms]
10:21:15.851926 2016-09-13T10:21:15.851+05:30 CRUD: Stored doc "100" / "1-6c6e0ddca6ccca4283a497208f7d29a2"
10:21:15.851974 2016-09-13T10:21:15.851+05:30 HTTP+: #035:     --> 201   (46.4 ms)
10:21:15.852127 2016-09-13T10:21:15.852+05:30 Events+: Event queue worker sending event Document change event for doc id: 100 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:15.852157 2016-09-13T10:21:15.852+05:30 Events+: Event queue worker sending event Document change event for doc id: 100 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:15.852177 2016-09-13T10:21:15.852+05:30 Events+: Event queue worker sending event Document change event for doc id: 100 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:15.959262 2016-09-13T10:21:15.959+05:30 Cache: Received #67 after 107ms ("100" / "1-6c6e0ddca6ccca4283a497208f7d29a2")
10:21:15.959335 2016-09-13T10:21:15.959+05:30 Cache: Initialized cache for channel "channel2-pool-1-thread-1-1" with options: &{ChannelCacheMinLength:50 ChannelCacheMaxLength:500 ChannelCacheAge:1m0s}
10:21:15.959344 2016-09-13T10:21:15.959+05:30 Cache:     #67 ==> channel "channel2-pool-1-thread-1-1"
10:21:15.959348 2016-09-13T10:21:15.959+05:30 Cache:     #67 ==> channel "*"
10:21:15.959365 2016-09-13T10:21:15.959+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=2
10:21:15.959385 2016-09-13T10:21:15.959+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:15.959402 2016-09-13T10:21:15.959+05:30 Changes: MultiChangesFeed done 
10:21:15.959405 2016-09-13T10:21:15.959+05:30 Cache: getCachedChanges("*", {1 0 0 66 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 1 changes valid from #67
10:21:15.959427 2016-09-13T10:21:15.959+05:30 DIndex+: [changesFeed] Found 1 changes for channel *
10:21:15.959478 2016-09-13T10:21:15.959+05:30 Changes+: Sending seq:67 from channel *
10:21:15.959539 2016-09-13T10:21:15.959+05:30 Changes+: MultiChangesFeed sending &{Seq:67 ID:100 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-6c6e0ddca6ccca4283a497208f7d29a2]] Err:<nil> allRemoved:false branched:false} 
10:21:15.959546 2016-09-13T10:21:15.959+05:30 Changes: MultiChangesFeed done 
10:21:15.959614 2016-09-13T10:21:15.959+05:30 HTTP+: #030:     --> 200 OK  (0.0 ms)
10:21:15.964246 2016-09-13T10:21:15.964+05:30 HTTP:  #036: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=66  (ADMIN)
10:21:15.964346 2016-09-13T10:21:15.964+05:30 Changes+: Int sequence multi changes feed...
10:21:15.964399 2016-09-13T10:21:15.964+05:30 Changes: MultiChangesFeed({*}, {Since:66 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc8208c0180 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:15.964648 2016-09-13T10:21:15.964+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:15.964678 2016-09-13T10:21:15.964+05:30 Cache: getCachedChanges("*", {1 0 0 66 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 1 changes valid from #67
10:21:15.964683 2016-09-13T10:21:15.964+05:30 DIndex+: [changesFeed] Found 1 changes for channel *
10:21:15.964710 2016-09-13T10:21:15.964+05:30 Changes+: Sending seq:67 from channel *
10:21:15.964756 2016-09-13T10:21:15.964+05:30 Changes+: MultiChangesFeed sending &{Seq:67 ID:100 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-6c6e0ddca6ccca4283a497208f7d29a2]] Err:<nil> allRemoved:false branched:false} 
10:21:15.964762 2016-09-13T10:21:15.964+05:30 Changes: MultiChangesFeed done 
10:21:15.964793 2016-09-13T10:21:15.964+05:30 HTTP+: #036:     --> 200 OK  (0.0 ms)
10:21:15.968568 2016-09-13T10:21:15.968+05:30 HTTP:  #037: POST /pttdata/_bulk_get?revs=true&attachments=true  (ADMIN)
10:21:15.969012 2016-09-13T10:21:15.969+05:30 HTTP+: #037:     --> 200   (0.5 ms)
10:21:16.029724 2016-09-13T10:21:16.029+05:30 HTTP:  #038: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=67  (ADMIN)
10:21:16.029809 2016-09-13T10:21:16.029+05:30 Changes+: Int sequence multi changes feed...
10:21:16.029826 2016-09-13T10:21:16.029+05:30 Changes: MultiChangesFeed({*}, {Since:67 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc8209b4060 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:16.030006 2016-09-13T10:21:16.029+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:16.030016 2016-09-13T10:21:16.030+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:16.030031 2016-09-13T10:21:16.030+05:30 Changes: MultiChangesFeed done 
10:21:16.030043 2016-09-13T10:21:16.030+05:30 HTTP+: #038:     --> 200 OK  (0.0 ms)
10:21:16.031038 2016-09-13T10:21:16.031+05:30 HTTP:  #039: GET /pttdata/_changes?feed=longpoll&limit=50&heartbeat=30000&style=all_docs&since=67  (ADMIN)
10:21:16.031169 2016-09-13T10:21:16.031+05:30 Changes+: Int sequence multi changes feed...
10:21:16.031205 2016-09-13T10:21:16.031+05:30 Changes: MultiChangesFeed({*}, {Since:67 Limit:50 Conflicts:true IncludeDocs:false Wait:true Continuous:false Terminator:0xc8209b4420 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:16.031466 2016-09-13T10:21:16.031+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:16.031480 2016-09-13T10:21:16.031+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:16.031485 2016-09-13T10:21:16.031+05:30 Changes+: MultiChangesFeed waiting... 
10:21:16.031503 2016-09-13T10:21:16.031+05:30 Changes+: Waiting for "pttdata"'s count to pass 2
10:21:16.148022 2016-09-13T10:21:16.148+05:30 Cache: Received #67 after 296ms ("100" / "1-6c6e0ddca6ccca4283a497208f7d29a2")
10:21:16.148034 2016-09-13T10:21:16.148+05:30 Cache+:   Ignoring duplicate of #67
10:21:16.867547 2016-09-13T10:21:16.867+05:30 HTTP:  #040: PUT /pttdata/101  (ADMIN)
10:21:16.869764 2016-09-13T10:21:16.869+05:30 CRUD+: Invoking sync on doc "101" rev 1-90bf22e5925d98438b0579ada6312c1c
10:21:16.870265 2016-09-13T10:21:16.870+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [207.236µs]
10:21:16.870288 2016-09-13T10:21:16.870+05:30 CRUD: 	Doc "101" in channels "{channel2-pool-1-thread-1-1}"
10:21:16.870395 2016-09-13T10:21:16.870+05:30 Cache: SAVING #68
10:21:16.870696 2016-09-13T10:21:16.870+05:30 Bucket: WriteUpdate("101", 0, ...) --> <nil> [2.968666ms]
10:21:16.870782 2016-09-13T10:21:16.870+05:30 CRUD: Stored doc "101" / "1-90bf22e5925d98438b0579ada6312c1c"
10:21:16.870820 2016-09-13T10:21:16.870+05:30 HTTP+: #040:     --> 201   (3.3 ms)
10:21:16.870944 2016-09-13T10:21:16.870+05:30 Events+: Event queue worker sending event Document change event for doc id: 101 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:16.870955 2016-09-13T10:21:16.870+05:30 Events+: Event queue worker sending event Document change event for doc id: 101 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:16.870973 2016-09-13T10:21:16.870+05:30 Events+: Event queue worker sending event Document change event for doc id: 101 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:17.000127 2016-09-13T10:21:17.000+05:30 HTTP:  #041: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:17.000337 2016-09-13T10:21:17.000+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [179.7µs]
10:21:17.000380 2016-09-13T10:21:17.000+05:30 HTTP+: #041:     --> 200   (0.3 ms)
10:21:17.004047 2016-09-13T10:21:17.004+05:30 HTTP:  #042: POST /pttdata/_revs_diff  (ADMIN)
10:21:17.004823 2016-09-13T10:21:17.004+05:30 Bucket: Get("100") [419.235µs]
10:21:17.004858 2016-09-13T10:21:17.004+05:30 HTTP+: #042:     --> 200   (0.8 ms)
10:21:17.005890 2016-09-13T10:21:17.005+05:30 HTTP:  #043: PUT /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:17.006303 2016-09-13T10:21:17.006+05:30 Bucket: Update("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73", 0, ...) --> <nil> [382.143µs]
10:21:17.006346 2016-09-13T10:21:17.006+05:30 HTTP+: #043:     --> 201   (0.5 ms)
10:21:17.007085 2016-09-13T10:21:17.007+05:30 HTTP:  #044: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:17.007317 2016-09-13T10:21:17.007+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [203.233µs]
10:21:17.007359 2016-09-13T10:21:17.007+05:30 HTTP+: #044:     --> 200   (0.3 ms)
10:21:17.874521 2016-09-13T10:21:17.874+05:30 HTTP:  #045: PUT /pttdata/102  (ADMIN)
10:21:17.874912 2016-09-13T10:21:17.874+05:30 CRUD+: Invoking sync on doc "102" rev 1-da7241a914e702c17063a8432c16908d
10:21:17.875303 2016-09-13T10:21:17.875+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [190.548µs]
10:21:17.875340 2016-09-13T10:21:17.875+05:30 CRUD: 	Doc "102" in channels "{channel2-pool-1-thread-1-1}"
10:21:17.875550 2016-09-13T10:21:17.875+05:30 Cache: SAVING #69
10:21:17.875797 2016-09-13T10:21:17.875+05:30 Bucket: WriteUpdate("102", 0, ...) --> <nil> [1.143863ms]
10:21:17.875864 2016-09-13T10:21:17.875+05:30 CRUD: Stored doc "102" / "1-da7241a914e702c17063a8432c16908d"
10:21:17.875925 2016-09-13T10:21:17.875+05:30 HTTP+: #045:     --> 201   (1.4 ms)
10:21:17.876063 2016-09-13T10:21:17.876+05:30 Events+: Event queue worker sending event Document change event for doc id: 102 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:17.876073 2016-09-13T10:21:17.876+05:30 Events+: Event queue worker sending event Document change event for doc id: 102 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:17.876087 2016-09-13T10:21:17.876+05:30 Events+: Event queue worker sending event Document change event for doc id: 102 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:18.148460 2016-09-13T10:21:18.148+05:30 Cache: Received #69 after 272ms ("102" / "1-da7241a914e702c17063a8432c16908d")
10:21:18.148511 2016-09-13T10:21:18.148+05:30 Cache:   Deferring #69 (1 now waiting for #68...#68)
10:21:18.148460 2016-09-13T10:21:18.148+05:30 Cache: Received #68 after 1277ms ("101" / "1-90bf22e5925d98438b0579ada6312c1c")
10:21:18.148536 2016-09-13T10:21:18.148+05:30 Cache:     #68 ==> channel "channel2-pool-1-thread-1-1"
10:21:18.148542 2016-09-13T10:21:18.148+05:30 Cache:     #68 ==> channel "*"
10:21:18.148567 2016-09-13T10:21:18.148+05:30 Cache:     #69 ==> channel "channel2-pool-1-thread-1-1"
10:21:18.148571 2016-09-13T10:21:18.148+05:30 Cache:     #69 ==> channel "*"
10:21:18.148601 2016-09-13T10:21:18.148+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=3
10:21:18.148659 2016-09-13T10:21:18.148+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:18.148677 2016-09-13T10:21:18.148+05:30 Cache: getCachedChanges("*", {1 0 0 67 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 2 changes valid from #68
10:21:18.148682 2016-09-13T10:21:18.148+05:30 DIndex+: [changesFeed] Found 2 changes for channel *
10:21:18.148731 2016-09-13T10:21:18.148+05:30 Changes+: Sending seq:68 from channel *
10:21:18.148740 2016-09-13T10:21:18.148+05:30 Changes+: Sending seq:69 from channel *
10:21:18.148794 2016-09-13T10:21:18.148+05:30 Changes+: MultiChangesFeed sending &{Seq:68 ID:101 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-90bf22e5925d98438b0579ada6312c1c]] Err:<nil> allRemoved:false branched:false} 
10:21:18.148839 2016-09-13T10:21:18.148+05:30 Changes+: MultiChangesFeed sending &{Seq:69 ID:102 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-da7241a914e702c17063a8432c16908d]] Err:<nil> allRemoved:false branched:false} 
10:21:18.148845 2016-09-13T10:21:18.148+05:30 Changes: MultiChangesFeed done 
10:21:18.148864 2016-09-13T10:21:18.148+05:30 HTTP+: #039:     --> 200 OK  (0.0 ms)
10:21:18.152638 2016-09-13T10:21:18.152+05:30 HTTP:  #046: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=67  (ADMIN)
10:21:18.152715 2016-09-13T10:21:18.152+05:30 Changes+: Int sequence multi changes feed...
10:21:18.152734 2016-09-13T10:21:18.152+05:30 Changes: MultiChangesFeed({*}, {Since:67 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc820276c60 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:18.152986 2016-09-13T10:21:18.152+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:18.153031 2016-09-13T10:21:18.153+05:30 Cache: getCachedChanges("*", {1 0 0 67 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 2 changes valid from #68
10:21:18.153036 2016-09-13T10:21:18.153+05:30 DIndex+: [changesFeed] Found 2 changes for channel *
10:21:18.153070 2016-09-13T10:21:18.153+05:30 Changes+: Sending seq:68 from channel *
10:21:18.153079 2016-09-13T10:21:18.153+05:30 Changes+: Sending seq:69 from channel *
10:21:18.153127 2016-09-13T10:21:18.153+05:30 Changes+: MultiChangesFeed sending &{Seq:68 ID:101 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-90bf22e5925d98438b0579ada6312c1c]] Err:<nil> allRemoved:false branched:false} 
10:21:18.153171 2016-09-13T10:21:18.153+05:30 Changes+: MultiChangesFeed sending &{Seq:69 ID:102 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-da7241a914e702c17063a8432c16908d]] Err:<nil> allRemoved:false branched:false} 
10:21:18.153178 2016-09-13T10:21:18.153+05:30 Changes: MultiChangesFeed done 
10:21:18.153194 2016-09-13T10:21:18.153+05:30 HTTP+: #046:     --> 200 OK  (0.0 ms)
10:21:18.159105 2016-09-13T10:21:18.159+05:30 HTTP:  #047: POST /pttdata/_bulk_get?revs=true&attachments=true  (ADMIN)
10:21:18.159416 2016-09-13T10:21:18.159+05:30 HTTP+: #047:     --> 200   (0.4 ms)
10:21:18.167531 2016-09-13T10:21:18.167+05:30 HTTP:  #048: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=69  (ADMIN)
10:21:18.167591 2016-09-13T10:21:18.167+05:30 Changes+: Int sequence multi changes feed...
10:21:18.167607 2016-09-13T10:21:18.167+05:30 Changes: MultiChangesFeed({*}, {Since:69 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc820aab3e0 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:18.167862 2016-09-13T10:21:18.167+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:18.167871 2016-09-13T10:21:18.167+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:18.167876 2016-09-13T10:21:18.167+05:30 Changes: MultiChangesFeed done 
10:21:18.167890 2016-09-13T10:21:18.167+05:30 HTTP+: #048:     --> 200 OK  (0.0 ms)
10:21:18.168779 2016-09-13T10:21:18.168+05:30 HTTP:  #049: GET /pttdata/_changes?feed=longpoll&limit=50&heartbeat=30000&style=all_docs&since=69  (ADMIN)
10:21:18.168832 2016-09-13T10:21:18.168+05:30 Changes+: Int sequence multi changes feed...
10:21:18.168847 2016-09-13T10:21:18.168+05:30 Changes: MultiChangesFeed({*}, {Since:69 Limit:50 Conflicts:true IncludeDocs:false Wait:true Continuous:false Terminator:0xc820aab7a0 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:18.169110 2016-09-13T10:21:18.169+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:18.169120 2016-09-13T10:21:18.169+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:18.169126 2016-09-13T10:21:18.169+05:30 Changes+: MultiChangesFeed waiting... 
10:21:18.169136 2016-09-13T10:21:18.169+05:30 Changes+: Waiting for "pttdata"'s count to pass 3
10:21:18.342593 2016-09-13T10:21:18.342+05:30 Cache: Received #69 after 466ms ("102" / "1-da7241a914e702c17063a8432c16908d")
10:21:18.342621 2016-09-13T10:21:18.342+05:30 Cache+:   Ignoring duplicate of #69
10:21:18.342668 2016-09-13T10:21:18.342+05:30 Cache: Received #68 after 1472ms ("101" / "1-90bf22e5925d98438b0579ada6312c1c")
10:21:18.342679 2016-09-13T10:21:18.342+05:30 Cache+:   Ignoring duplicate of #68
10:21:18.878873 2016-09-13T10:21:18.878+05:30 HTTP:  #050: PUT /pttdata/103  (ADMIN)
10:21:18.879304 2016-09-13T10:21:18.879+05:30 CRUD+: Invoking sync on doc "103" rev 1-a91fade792a00b1d1d31fdff4b1301ad
10:21:18.879703 2016-09-13T10:21:18.879+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [207.209µs]
10:21:18.879738 2016-09-13T10:21:18.879+05:30 CRUD: 	Doc "103" in channels "{channel2-pool-1-thread-1-1}"
10:21:18.879866 2016-09-13T10:21:18.879+05:30 Cache: SAVING #70
10:21:18.880173 2016-09-13T10:21:18.880+05:30 Bucket: WriteUpdate("103", 0, ...) --> <nil> [1.150258ms]
10:21:18.880246 2016-09-13T10:21:18.880+05:30 CRUD: Stored doc "103" / "1-a91fade792a00b1d1d31fdff4b1301ad"
10:21:18.880282 2016-09-13T10:21:18.880+05:30 HTTP+: #050:     --> 201   (1.4 ms)
10:21:18.880371 2016-09-13T10:21:18.880+05:30 Events+: Event queue worker sending event Document change event for doc id: 103 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:18.880380 2016-09-13T10:21:18.880+05:30 Events+: Event queue worker sending event Document change event for doc id: 103 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:18.880386 2016-09-13T10:21:18.880+05:30 Events+: Event queue worker sending event Document change event for doc id: 103 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:19.001202 2016-09-13T10:21:19.001+05:30 HTTP:  #051: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:19.001412 2016-09-13T10:21:19.001+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [171.581µs]
10:21:19.001442 2016-09-13T10:21:19.001+05:30 HTTP+: #051:     --> 200   (0.3 ms)
10:21:19.004791 2016-09-13T10:21:19.004+05:30 HTTP:  #052: POST /pttdata/_revs_diff  (ADMIN)
10:21:19.005426 2016-09-13T10:21:19.005+05:30 Bucket: Get("101") [378.878µs]
10:21:19.005764 2016-09-13T10:21:19.005+05:30 Bucket: Get("102") [320.371µs]
10:21:19.005794 2016-09-13T10:21:19.005+05:30 HTTP+: #052:     --> 200   (1.0 ms)
10:21:19.006875 2016-09-13T10:21:19.006+05:30 HTTP:  #053: PUT /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:19.007374 2016-09-13T10:21:19.007+05:30 Bucket: Update("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73", 0, ...) --> <nil> [454.689µs]
10:21:19.007405 2016-09-13T10:21:19.007+05:30 HTTP+: #053:     --> 201   (0.5 ms)
10:21:19.008229 2016-09-13T10:21:19.008+05:30 HTTP:  #054: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:19.008406 2016-09-13T10:21:19.008+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [147.032µs]
10:21:19.008447 2016-09-13T10:21:19.008+05:30 HTTP+: #054:     --> 200   (0.2 ms)
10:21:19.887431 2016-09-13T10:21:19.887+05:30 HTTP:  #055: PUT /pttdata/104  (ADMIN)
10:21:19.887830 2016-09-13T10:21:19.887+05:30 CRUD+: Invoking sync on doc "104" rev 1-399275c3de3148c8a4fe8e06a2d7d5e7
10:21:19.888246 2016-09-13T10:21:19.888+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [225.612µs]
10:21:19.888292 2016-09-13T10:21:19.888+05:30 CRUD: 	Doc "104" in channels "{channel2-pool-1-thread-1-1}"
10:21:19.888401 2016-09-13T10:21:19.888+05:30 Cache: SAVING #71
10:21:19.888683 2016-09-13T10:21:19.888+05:30 Bucket: WriteUpdate("104", 0, ...) --> <nil> [1.126958ms]
10:21:19.888749 2016-09-13T10:21:19.888+05:30 CRUD: Stored doc "104" / "1-399275c3de3148c8a4fe8e06a2d7d5e7"
10:21:19.888823 2016-09-13T10:21:19.888+05:30 HTTP+: #055:     --> 201   (1.4 ms)
10:21:19.888949 2016-09-13T10:21:19.888+05:30 Events+: Event queue worker sending event Document change event for doc id: 104 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:19.888962 2016-09-13T10:21:19.888+05:30 Events+: Event queue worker sending event Document change event for doc id: 104 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:19.888973 2016-09-13T10:21:19.888+05:30 Events+: Event queue worker sending event Document change event for doc id: 104 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:19.958682 2016-09-13T10:21:19.958+05:30 Cache: Received #70 after 1078ms ("103" / "1-a91fade792a00b1d1d31fdff4b1301ad")
10:21:19.958703 2016-09-13T10:21:19.958+05:30 Cache:     #70 ==> channel "channel2-pool-1-thread-1-1"
10:21:19.958709 2016-09-13T10:21:19.958+05:30 Cache:     #70 ==> channel "*"
10:21:19.958739 2016-09-13T10:21:19.958+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=4
10:21:19.958798 2016-09-13T10:21:19.958+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:19.958840 2016-09-13T10:21:19.958+05:30 Cache: getCachedChanges("*", {1 0 0 69 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 1 changes valid from #70
10:21:19.958845 2016-09-13T10:21:19.958+05:30 DIndex+: [changesFeed] Found 1 changes for channel *
10:21:19.958874 2016-09-13T10:21:19.958+05:30 Changes+: Sending seq:70 from channel *
10:21:19.958939 2016-09-13T10:21:19.958+05:30 Changes+: MultiChangesFeed sending &{Seq:70 ID:103 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-a91fade792a00b1d1d31fdff4b1301ad]] Err:<nil> allRemoved:false branched:false} 
10:21:19.958947 2016-09-13T10:21:19.958+05:30 Changes: MultiChangesFeed done 
10:21:19.958987 2016-09-13T10:21:19.958+05:30 HTTP+: #049:     --> 200 OK  (0.0 ms)
10:21:19.962337 2016-09-13T10:21:19.962+05:30 HTTP:  #056: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=69  (ADMIN)
10:21:19.962406 2016-09-13T10:21:19.962+05:30 Changes+: Int sequence multi changes feed...
10:21:19.962424 2016-09-13T10:21:19.962+05:30 Changes: MultiChangesFeed({*}, {Since:69 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc8212fb020 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:19.962730 2016-09-13T10:21:19.962+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:19.962762 2016-09-13T10:21:19.962+05:30 Cache: getCachedChanges("*", {1 0 0 69 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 1 changes valid from #70
10:21:19.962766 2016-09-13T10:21:19.962+05:30 DIndex+: [changesFeed] Found 1 changes for channel *
10:21:19.962795 2016-09-13T10:21:19.962+05:30 Changes+: Sending seq:70 from channel *
10:21:19.962844 2016-09-13T10:21:19.962+05:30 Changes+: MultiChangesFeed sending &{Seq:70 ID:103 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-a91fade792a00b1d1d31fdff4b1301ad]] Err:<nil> allRemoved:false branched:false} 
10:21:19.962863 2016-09-13T10:21:19.962+05:30 Changes: MultiChangesFeed done 
10:21:19.962895 2016-09-13T10:21:19.962+05:30 HTTP+: #056:     --> 200 OK  (0.0 ms)
10:21:19.965799 2016-09-13T10:21:19.965+05:30 HTTP:  #057: POST /pttdata/_bulk_get?revs=true&attachments=true  (ADMIN)
10:21:19.965985 2016-09-13T10:21:19.965+05:30 HTTP+: #057:     --> 200   (0.2 ms)
10:21:19.971933 2016-09-13T10:21:19.971+05:30 HTTP:  #058: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=70  (ADMIN)
10:21:19.971980 2016-09-13T10:21:19.971+05:30 Changes+: Int sequence multi changes feed...
10:21:19.971994 2016-09-13T10:21:19.971+05:30 Changes: MultiChangesFeed({*}, {Since:70 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc8208c0f00 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:19.972219 2016-09-13T10:21:19.972+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:19.972231 2016-09-13T10:21:19.972+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:19.972235 2016-09-13T10:21:19.972+05:30 Changes: MultiChangesFeed done 
10:21:19.972257 2016-09-13T10:21:19.972+05:30 HTTP+: #058:     --> 200 OK  (0.0 ms)
10:21:19.973187 2016-09-13T10:21:19.973+05:30 HTTP:  #059: GET /pttdata/_changes?feed=longpoll&limit=50&heartbeat=30000&style=all_docs&since=70  (ADMIN)
10:21:19.973255 2016-09-13T10:21:19.973+05:30 Changes+: Int sequence multi changes feed...
10:21:19.973271 2016-09-13T10:21:19.973+05:30 Changes: MultiChangesFeed({*}, {Since:70 Limit:50 Conflicts:true IncludeDocs:false Wait:true Continuous:false Terminator:0xc8208c12c0 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:19.973525 2016-09-13T10:21:19.973+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:19.973556 2016-09-13T10:21:19.973+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:19.973561 2016-09-13T10:21:19.973+05:30 Changes+: MultiChangesFeed waiting... 
10:21:19.973580 2016-09-13T10:21:19.973+05:30 Changes+: Waiting for "pttdata"'s count to pass 4
10:21:20.148086 2016-09-13T10:21:20.148+05:30 Cache: Received #71 after 259ms ("104" / "1-399275c3de3148c8a4fe8e06a2d7d5e7")
10:21:20.148107 2016-09-13T10:21:20.148+05:30 Cache:     #71 ==> channel "channel2-pool-1-thread-1-1"
10:21:20.148113 2016-09-13T10:21:20.148+05:30 Cache:     #71 ==> channel "*"
10:21:20.148126 2016-09-13T10:21:20.148+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=5
10:21:20.148161 2016-09-13T10:21:20.148+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:20.148175 2016-09-13T10:21:20.148+05:30 Cache: getCachedChanges("*", {1 0 0 70 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 1 changes valid from #71
10:21:20.148180 2016-09-13T10:21:20.148+05:30 DIndex+: [changesFeed] Found 1 changes for channel *
10:21:20.148201 2016-09-13T10:21:20.148+05:30 Changes+: Sending seq:71 from channel *
10:21:20.148254 2016-09-13T10:21:20.148+05:30 Changes+: MultiChangesFeed sending &{Seq:71 ID:104 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-399275c3de3148c8a4fe8e06a2d7d5e7]] Err:<nil> allRemoved:false branched:false} 
10:21:20.148260 2016-09-13T10:21:20.148+05:30 Changes: MultiChangesFeed done 
10:21:20.148086 2016-09-13T10:21:20.148+05:30 Cache: Received #70 after 1268ms ("103" / "1-a91fade792a00b1d1d31fdff4b1301ad")
10:21:20.148302 2016-09-13T10:21:20.148+05:30 HTTP+: #059:     --> 200 OK  (0.0 ms)
10:21:20.148305 2016-09-13T10:21:20.148+05:30 Cache+:   Ignoring duplicate of #70
10:21:20.151247 2016-09-13T10:21:20.151+05:30 HTTP:  #060: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=70  (ADMIN)
10:21:20.151294 2016-09-13T10:21:20.151+05:30 Changes+: Int sequence multi changes feed...
10:21:20.151321 2016-09-13T10:21:20.151+05:30 Changes: MultiChangesFeed({*}, {Since:70 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc8212df4a0 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:20.151564 2016-09-13T10:21:20.151+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:20.151584 2016-09-13T10:21:20.151+05:30 Cache: getCachedChanges("*", {1 0 0 70 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 1 changes valid from #71
10:21:20.151599 2016-09-13T10:21:20.151+05:30 DIndex+: [changesFeed] Found 1 changes for channel *
10:21:20.151634 2016-09-13T10:21:20.151+05:30 Changes+: Sending seq:71 from channel *
10:21:20.151678 2016-09-13T10:21:20.151+05:30 Changes+: MultiChangesFeed sending &{Seq:71 ID:104 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-399275c3de3148c8a4fe8e06a2d7d5e7]] Err:<nil> allRemoved:false branched:false} 
10:21:20.151695 2016-09-13T10:21:20.151+05:30 Changes: MultiChangesFeed done 
10:21:20.151714 2016-09-13T10:21:20.151+05:30 HTTP+: #060:     --> 200 OK  (0.0 ms)
10:21:20.154705 2016-09-13T10:21:20.154+05:30 HTTP:  #061: POST /pttdata/_bulk_get?revs=true&attachments=true  (ADMIN)
10:21:20.154887 2016-09-13T10:21:20.154+05:30 HTTP+: #061:     --> 200   (0.2 ms)
10:21:20.161019 2016-09-13T10:21:20.161+05:30 HTTP:  #062: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=71  (ADMIN)
10:21:20.161067 2016-09-13T10:21:20.161+05:30 Changes+: Int sequence multi changes feed...
10:21:20.161081 2016-09-13T10:21:20.161+05:30 Changes: MultiChangesFeed({*}, {Since:71 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc8212fbaa0 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:20.161288 2016-09-13T10:21:20.161+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:20.161307 2016-09-13T10:21:20.161+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:20.161311 2016-09-13T10:21:20.161+05:30 Changes: MultiChangesFeed done 
10:21:20.161321 2016-09-13T10:21:20.161+05:30 HTTP+: #062:     --> 200 OK  (0.0 ms)
10:21:20.162099 2016-09-13T10:21:20.162+05:30 HTTP:  #063: GET /pttdata/_changes?feed=longpoll&limit=50&heartbeat=30000&style=all_docs&since=71  (ADMIN)
10:21:20.162153 2016-09-13T10:21:20.162+05:30 Changes+: Int sequence multi changes feed...
10:21:20.162169 2016-09-13T10:21:20.162+05:30 Changes: MultiChangesFeed({*}, {Since:71 Limit:50 Conflicts:true IncludeDocs:false Wait:true Continuous:false Terminator:0xc8212fbe60 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:20.162435 2016-09-13T10:21:20.162+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:20.162458 2016-09-13T10:21:20.162+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:20.162462 2016-09-13T10:21:20.162+05:30 Changes+: MultiChangesFeed waiting... 
10:21:20.162482 2016-09-13T10:21:20.162+05:30 Changes+: Waiting for "pttdata"'s count to pass 5
10:21:20.342588 2016-09-13T10:21:20.342+05:30 Cache: Received #71 after 454ms ("104" / "1-399275c3de3148c8a4fe8e06a2d7d5e7")
10:21:20.342598 2016-09-13T10:21:20.342+05:30 Cache+:   Ignoring duplicate of #71
10:21:20.891658 2016-09-13T10:21:20.891+05:30 HTTP:  #064: PUT /pttdata/105  (ADMIN)
10:21:20.892032 2016-09-13T10:21:20.892+05:30 CRUD+: Invoking sync on doc "105" rev 1-329c0ada0defc48960547020cc0274f6
10:21:20.892496 2016-09-13T10:21:20.892+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [217.771µs]
10:21:20.892530 2016-09-13T10:21:20.892+05:30 CRUD: 	Doc "105" in channels "{channel2-pool-1-thread-1-1}"
10:21:20.892646 2016-09-13T10:21:20.892+05:30 Cache: SAVING #72
10:21:20.892980 2016-09-13T10:21:20.892+05:30 Bucket: WriteUpdate("105", 0, ...) --> <nil> [1.208867ms]
10:21:20.893046 2016-09-13T10:21:20.893+05:30 CRUD: Stored doc "105" / "1-329c0ada0defc48960547020cc0274f6"
10:21:20.893091 2016-09-13T10:21:20.893+05:30 HTTP+: #064:     --> 201   (1.4 ms)
10:21:20.893215 2016-09-13T10:21:20.893+05:30 Events+: Event queue worker sending event Document change event for doc id: 105 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:20.893229 2016-09-13T10:21:20.893+05:30 Events+: Event queue worker sending event Document change event for doc id: 105 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:20.893236 2016-09-13T10:21:20.893+05:30 Events+: Event queue worker sending event Document change event for doc id: 105 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:21.000949 2016-09-13T10:21:21.000+05:30 HTTP:  #065: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:21.001063 2016-09-13T10:21:21.001+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [96.214µs]
10:21:21.001112 2016-09-13T10:21:21.001+05:30 HTTP+: #065:     --> 200   (0.2 ms)
10:21:21.004329 2016-09-13T10:21:21.004+05:30 HTTP:  #066: POST /pttdata/_revs_diff  (ADMIN)
10:21:21.004986 2016-09-13T10:21:21.004+05:30 Bucket: Get("103") [273.617µs]
10:21:21.005297 2016-09-13T10:21:21.005+05:30 Bucket: Get("104") [295.835µs]
10:21:21.005330 2016-09-13T10:21:21.005+05:30 HTTP+: #066:     --> 200   (1.0 ms)
10:21:21.006427 2016-09-13T10:21:21.006+05:30 HTTP:  #067: PUT /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:21.006911 2016-09-13T10:21:21.006+05:30 Bucket: Update("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73", 0, ...) --> <nil> [426.477µs]
10:21:21.006952 2016-09-13T10:21:21.006+05:30 HTTP+: #067:     --> 201   (0.5 ms)
10:21:21.007700 2016-09-13T10:21:21.007+05:30 HTTP:  #068: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:21.007942 2016-09-13T10:21:21.007+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [211.438µs]
10:21:21.007993 2016-09-13T10:21:21.007+05:30 HTTP+: #068:     --> 200   (0.3 ms)
10:21:21.895578 2016-09-13T10:21:21.895+05:30 HTTP:  #069: PUT /pttdata/106  (ADMIN)
10:21:21.895944 2016-09-13T10:21:21.895+05:30 CRUD+: Invoking sync on doc "106" rev 1-bfe4745532d04297edaea4271cc318f6
10:21:21.896332 2016-09-13T10:21:21.896+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [197.585µs]
10:21:21.896356 2016-09-13T10:21:21.896+05:30 CRUD: 	Doc "106" in channels "{channel2-pool-1-thread-1-1}"
10:21:21.896485 2016-09-13T10:21:21.896+05:30 Cache: SAVING #73
10:21:21.896686 2016-09-13T10:21:21.896+05:30 Bucket: WriteUpdate("106", 0, ...) --> <nil> [997.059µs]
10:21:21.896748 2016-09-13T10:21:21.896+05:30 CRUD: Stored doc "106" / "1-bfe4745532d04297edaea4271cc318f6"
10:21:21.896792 2016-09-13T10:21:21.896+05:30 HTTP+: #069:     --> 201   (1.2 ms)
10:21:21.896917 2016-09-13T10:21:21.896+05:30 Events+: Event queue worker sending event Document change event for doc id: 106 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:21.896962 2016-09-13T10:21:21.896+05:30 Events+: Event queue worker sending event Document change event for doc id: 106 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:21.896979 2016-09-13T10:21:21.896+05:30 Events+: Event queue worker sending event Document change event for doc id: 106 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:21.959515 2016-09-13T10:21:21.959+05:30 Cache: Received #72 after 1066ms ("105" / "1-329c0ada0defc48960547020cc0274f6")
10:21:21.959561 2016-09-13T10:21:21.959+05:30 Cache:     #72 ==> channel "channel2-pool-1-thread-1-1"
10:21:21.959567 2016-09-13T10:21:21.959+05:30 Cache:     #72 ==> channel "*"
10:21:21.959598 2016-09-13T10:21:21.959+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=6
10:21:21.959646 2016-09-13T10:21:21.959+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:21.959674 2016-09-13T10:21:21.959+05:30 Cache: Received #73 after  63ms ("106" / "1-bfe4745532d04297edaea4271cc318f6")
10:21:21.959696 2016-09-13T10:21:21.959+05:30 Cache:     #73 ==> channel "channel2-pool-1-thread-1-1"
10:21:21.959703 2016-09-13T10:21:21.959+05:30 Cache:     #73 ==> channel "*"
10:21:21.959724 2016-09-13T10:21:21.959+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=7
10:21:21.959675 2016-09-13T10:21:21.959+05:30 Cache: getCachedChanges("*", {1 0 0 71 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 1 changes valid from #72
10:21:21.959732 2016-09-13T10:21:21.959+05:30 DIndex+: [changesFeed] Found 1 changes for channel *
10:21:21.959764 2016-09-13T10:21:21.959+05:30 Changes+: Sending seq:72 from channel *
10:21:21.959819 2016-09-13T10:21:21.959+05:30 Changes+: MultiChangesFeed sending &{Seq:72 ID:105 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-329c0ada0defc48960547020cc0274f6]] Err:<nil> allRemoved:false branched:false} 
10:21:21.959826 2016-09-13T10:21:21.959+05:30 Changes: MultiChangesFeed done 
10:21:21.959860 2016-09-13T10:21:21.959+05:30 HTTP+: #063:     --> 200 OK  (0.0 ms)
10:21:21.962892 2016-09-13T10:21:21.962+05:30 HTTP:  #070: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=71  (ADMIN)
10:21:21.962995 2016-09-13T10:21:21.962+05:30 Changes+: Int sequence multi changes feed...
10:21:21.963030 2016-09-13T10:21:21.963+05:30 Changes: MultiChangesFeed({*}, {Since:71 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc8212dfaa0 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:21.963306 2016-09-13T10:21:21.963+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:21.963351 2016-09-13T10:21:21.963+05:30 Cache: getCachedChanges("*", {1 0 0 71 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 2 changes valid from #72
10:21:21.963356 2016-09-13T10:21:21.963+05:30 DIndex+: [changesFeed] Found 2 changes for channel *
10:21:21.963407 2016-09-13T10:21:21.963+05:30 Changes+: Sending seq:72 from channel *
10:21:21.963416 2016-09-13T10:21:21.963+05:30 Changes+: Sending seq:73 from channel *
10:21:21.963459 2016-09-13T10:21:21.963+05:30 Changes+: MultiChangesFeed sending &{Seq:72 ID:105 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-329c0ada0defc48960547020cc0274f6]] Err:<nil> allRemoved:false branched:false} 
10:21:21.963493 2016-09-13T10:21:21.963+05:30 Changes+: MultiChangesFeed sending &{Seq:73 ID:106 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-bfe4745532d04297edaea4271cc318f6]] Err:<nil> allRemoved:false branched:false} 
10:21:21.963499 2016-09-13T10:21:21.963+05:30 Changes: MultiChangesFeed done 
10:21:21.963512 2016-09-13T10:21:21.963+05:30 HTTP+: #070:     --> 200 OK  (0.0 ms)
10:21:21.966931 2016-09-13T10:21:21.966+05:30 HTTP:  #071: POST /pttdata/_bulk_get?revs=true&attachments=true  (ADMIN)
10:21:21.967181 2016-09-13T10:21:21.967+05:30 HTTP+: #071:     --> 200   (0.3 ms)
10:21:21.974217 2016-09-13T10:21:21.974+05:30 HTTP:  #072: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=73  (ADMIN)
10:21:21.974266 2016-09-13T10:21:21.974+05:30 Changes+: Int sequence multi changes feed...
10:21:21.974280 2016-09-13T10:21:21.974+05:30 Changes: MultiChangesFeed({*}, {Since:73 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc820d78e40 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:21.974471 2016-09-13T10:21:21.974+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:21.974479 2016-09-13T10:21:21.974+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:21.974483 2016-09-13T10:21:21.974+05:30 Changes: MultiChangesFeed done 
10:21:21.974491 2016-09-13T10:21:21.974+05:30 HTTP+: #072:     --> 200 OK  (0.0 ms)
10:21:21.975333 2016-09-13T10:21:21.975+05:30 HTTP:  #073: GET /pttdata/_changes?feed=longpoll&limit=50&heartbeat=30000&style=all_docs&since=73  (ADMIN)
10:21:21.975387 2016-09-13T10:21:21.975+05:30 Changes+: Int sequence multi changes feed...
10:21:21.975401 2016-09-13T10:21:21.975+05:30 Changes: MultiChangesFeed({*}, {Since:73 Limit:50 Conflicts:true IncludeDocs:false Wait:true Continuous:false Terminator:0xc820d79200 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:21.975660 2016-09-13T10:21:21.975+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:21.975682 2016-09-13T10:21:21.975+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:21.975703 2016-09-13T10:21:21.975+05:30 Changes+: MultiChangesFeed waiting... 
10:21:21.975724 2016-09-13T10:21:21.975+05:30 Changes+: Waiting for "pttdata"'s count to pass 7
10:21:22.148965 2016-09-13T10:21:22.148+05:30 Cache: Received #73 after 252ms ("106" / "1-bfe4745532d04297edaea4271cc318f6")
10:21:22.148987 2016-09-13T10:21:22.148+05:30 Cache+:   Ignoring duplicate of #73
10:21:22.342664 2016-09-13T10:21:22.342+05:30 Cache: Received #72 after 1450ms ("105" / "1-329c0ada0defc48960547020cc0274f6")
10:21:22.342675 2016-09-13T10:21:22.342+05:30 Cache+:   Ignoring duplicate of #72
10:21:22.899149 2016-09-13T10:21:22.899+05:30 HTTP:  #074: PUT /pttdata/107  (ADMIN)
10:21:22.899512 2016-09-13T10:21:22.899+05:30 CRUD+: Invoking sync on doc "107" rev 1-cc5ad5db5277b502f45d71948ff76c58
10:21:22.899884 2016-09-13T10:21:22.899+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [156.441µs]
10:21:22.899910 2016-09-13T10:21:22.899+05:30 CRUD: 	Doc "107" in channels "{channel2-pool-1-thread-1-1}"
10:21:22.900011 2016-09-13T10:21:22.900+05:30 Cache: SAVING #74
10:21:22.900270 2016-09-13T10:21:22.900+05:30 Bucket: WriteUpdate("107", 0, ...) --> <nil> [987.658µs]
10:21:22.900347 2016-09-13T10:21:22.900+05:30 CRUD: Stored doc "107" / "1-cc5ad5db5277b502f45d71948ff76c58"
10:21:22.900385 2016-09-13T10:21:22.900+05:30 HTTP+: #074:     --> 201   (1.3 ms)
10:21:22.900481 2016-09-13T10:21:22.900+05:30 Events+: Event queue worker sending event Document change event for doc id: 107 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:22.900491 2016-09-13T10:21:22.900+05:30 Events+: Event queue worker sending event Document change event for doc id: 107 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:22.900498 2016-09-13T10:21:22.900+05:30 Events+: Event queue worker sending event Document change event for doc id: 107 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:23.001509 2016-09-13T10:21:23.001+05:30 HTTP:  #075: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:23.001720 2016-09-13T10:21:23.001+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [191.113µs]
10:21:23.001749 2016-09-13T10:21:23.001+05:30 HTTP+: #075:     --> 200   (0.2 ms)
10:21:23.005034 2016-09-13T10:21:23.005+05:30 HTTP:  #076: POST /pttdata/_revs_diff  (ADMIN)
10:21:23.005674 2016-09-13T10:21:23.005+05:30 Bucket: Get("105") [325.363µs]
10:21:23.005953 2016-09-13T10:21:23.005+05:30 Bucket: Get("106") [262.399µs]
10:21:23.005981 2016-09-13T10:21:23.005+05:30 HTTP+: #076:     --> 200   (1.0 ms)
10:21:23.006941 2016-09-13T10:21:23.006+05:30 HTTP:  #077: PUT /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:23.007472 2016-09-13T10:21:23.007+05:30 Bucket: Update("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73", 0, ...) --> <nil> [501.7µs]
10:21:23.007536 2016-09-13T10:21:23.007+05:30 HTTP+: #077:     --> 201   (0.6 ms)
10:21:23.008294 2016-09-13T10:21:23.008+05:30 HTTP:  #078: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:23.008548 2016-09-13T10:21:23.008+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [222.931µs]
10:21:23.008590 2016-09-13T10:21:23.008+05:30 HTTP+: #078:     --> 200   (0.3 ms)
10:21:23.902942 2016-09-13T10:21:23.902+05:30 HTTP:  #079: PUT /pttdata/108  (ADMIN)
10:21:23.903321 2016-09-13T10:21:23.903+05:30 CRUD+: Invoking sync on doc "108" rev 1-754b9c53a7a79f0d6763d716c62888fe
10:21:23.903690 2016-09-13T10:21:23.903+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [175.558µs]
10:21:23.903715 2016-09-13T10:21:23.903+05:30 CRUD: 	Doc "108" in channels "{channel2-pool-1-thread-1-1}"
10:21:23.903842 2016-09-13T10:21:23.903+05:30 Cache: SAVING #75
10:21:23.904064 2016-09-13T10:21:23.904+05:30 Bucket: WriteUpdate("108", 0, ...) --> <nil> [1.007659ms]
10:21:23.904164 2016-09-13T10:21:23.904+05:30 CRUD: Stored doc "108" / "1-754b9c53a7a79f0d6763d716c62888fe"
10:21:23.904209 2016-09-13T10:21:23.904+05:30 HTTP+: #079:     --> 201   (1.3 ms)
10:21:23.904325 2016-09-13T10:21:23.904+05:30 Events+: Event queue worker sending event Document change event for doc id: 108 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:23.904338 2016-09-13T10:21:23.904+05:30 Events+: Event queue worker sending event Document change event for doc id: 108 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:23.904344 2016-09-13T10:21:23.904+05:30 Events+: Event queue worker sending event Document change event for doc id: 108 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:23.958981 2016-09-13T10:21:23.958+05:30 Cache: Received #74 after 1058ms ("107" / "1-cc5ad5db5277b502f45d71948ff76c58")
10:21:23.958999 2016-09-13T10:21:23.958+05:30 Cache:     #74 ==> channel "channel2-pool-1-thread-1-1"
10:21:23.959006 2016-09-13T10:21:23.959+05:30 Cache:     #74 ==> channel "*"
10:21:23.959022 2016-09-13T10:21:23.959+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=8
10:21:23.959081 2016-09-13T10:21:23.959+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:23.959110 2016-09-13T10:21:23.959+05:30 Cache: getCachedChanges("*", {1 0 0 73 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 1 changes valid from #74
10:21:23.959117 2016-09-13T10:21:23.959+05:30 DIndex+: [changesFeed] Found 1 changes for channel *
10:21:23.959158 2016-09-13T10:21:23.959+05:30 Changes+: Sending seq:74 from channel *
10:21:23.959228 2016-09-13T10:21:23.959+05:30 Changes+: MultiChangesFeed sending &{Seq:74 ID:107 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-cc5ad5db5277b502f45d71948ff76c58]] Err:<nil> allRemoved:false branched:false} 
10:21:23.959236 2016-09-13T10:21:23.959+05:30 Changes: MultiChangesFeed done 
10:21:23.959276 2016-09-13T10:21:23.959+05:30 HTTP+: #073:     --> 200 OK  (0.0 ms)
10:21:23.962993 2016-09-13T10:21:23.962+05:30 HTTP:  #080: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=73  (ADMIN)
10:21:23.963058 2016-09-13T10:21:23.963+05:30 Changes+: Int sequence multi changes feed...
10:21:23.963075 2016-09-13T10:21:23.963+05:30 Changes: MultiChangesFeed({*}, {Since:73 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc820f52360 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:23.963346 2016-09-13T10:21:23.963+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:23.963376 2016-09-13T10:21:23.963+05:30 Cache: getCachedChanges("*", {1 0 0 73 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 1 changes valid from #74
10:21:23.963380 2016-09-13T10:21:23.963+05:30 DIndex+: [changesFeed] Found 1 changes for channel *
10:21:23.963404 2016-09-13T10:21:23.963+05:30 Changes+: Sending seq:74 from channel *
10:21:23.963448 2016-09-13T10:21:23.963+05:30 Changes+: MultiChangesFeed sending &{Seq:74 ID:107 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-cc5ad5db5277b502f45d71948ff76c58]] Err:<nil> allRemoved:false branched:false} 
10:21:23.963457 2016-09-13T10:21:23.963+05:30 Changes: MultiChangesFeed done 
10:21:23.963476 2016-09-13T10:21:23.963+05:30 HTTP+: #080:     --> 200 OK  (0.0 ms)
10:21:23.966357 2016-09-13T10:21:23.966+05:30 HTTP:  #081: POST /pttdata/_bulk_get?revs=true&attachments=true  (ADMIN)
10:21:23.966561 2016-09-13T10:21:23.966+05:30 HTTP+: #081:     --> 200   (0.3 ms)
10:21:23.972125 2016-09-13T10:21:23.972+05:30 HTTP:  #082: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=74  (ADMIN)
10:21:23.972178 2016-09-13T10:21:23.972+05:30 Changes+: Int sequence multi changes feed...
10:21:23.972194 2016-09-13T10:21:23.972+05:30 Changes: MultiChangesFeed({*}, {Since:74 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc820499800 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:23.972389 2016-09-13T10:21:23.972+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:23.972398 2016-09-13T10:21:23.972+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:23.972402 2016-09-13T10:21:23.972+05:30 Changes: MultiChangesFeed done 
10:21:23.972412 2016-09-13T10:21:23.972+05:30 HTTP+: #082:     --> 200 OK  (0.0 ms)
10:21:23.973232 2016-09-13T10:21:23.973+05:30 HTTP:  #083: GET /pttdata/_changes?feed=longpoll&limit=50&heartbeat=30000&style=all_docs&since=74  (ADMIN)
10:21:23.973284 2016-09-13T10:21:23.973+05:30 Changes+: Int sequence multi changes feed...
10:21:23.973300 2016-09-13T10:21:23.973+05:30 Changes: MultiChangesFeed({*}, {Since:74 Limit:50 Conflicts:true IncludeDocs:false Wait:true Continuous:false Terminator:0xc820499bc0 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:23.973535 2016-09-13T10:21:23.973+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:23.973565 2016-09-13T10:21:23.973+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:23.973573 2016-09-13T10:21:23.973+05:30 Changes+: MultiChangesFeed waiting... 
10:21:23.973592 2016-09-13T10:21:23.973+05:30 Changes+: Waiting for "pttdata"'s count to pass 8
10:21:24.149087 2016-09-13T10:21:24.149+05:30 Cache: Received #75 after 245ms ("108" / "1-754b9c53a7a79f0d6763d716c62888fe")
10:21:24.149104 2016-09-13T10:21:24.149+05:30 Cache:     #75 ==> channel "channel2-pool-1-thread-1-1"
10:21:24.149110 2016-09-13T10:21:24.149+05:30 Cache:     #75 ==> channel "*"
10:21:24.149123 2016-09-13T10:21:24.149+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=9
10:21:24.149137 2016-09-13T10:21:24.149+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:24.149159 2016-09-13T10:21:24.149+05:30 Cache: getCachedChanges("*", {1 0 0 74 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 1 changes valid from #75
10:21:24.149167 2016-09-13T10:21:24.149+05:30 DIndex+: [changesFeed] Found 1 changes for channel *
10:21:24.149190 2016-09-13T10:21:24.149+05:30 Changes+: Sending seq:75 from channel *
10:21:24.149236 2016-09-13T10:21:24.149+05:30 Changes+: MultiChangesFeed sending &{Seq:75 ID:108 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-754b9c53a7a79f0d6763d716c62888fe]] Err:<nil> allRemoved:false branched:false} 
10:21:24.149246 2016-09-13T10:21:24.149+05:30 Changes: MultiChangesFeed done 
10:21:24.149264 2016-09-13T10:21:24.149+05:30 HTTP+: #083:     --> 200 OK  (0.0 ms)
10:21:24.151783 2016-09-13T10:21:24.151+05:30 HTTP:  #084: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=74  (ADMIN)
10:21:24.151856 2016-09-13T10:21:24.151+05:30 Changes+: Int sequence multi changes feed...
10:21:24.151871 2016-09-13T10:21:24.151+05:30 Changes: MultiChangesFeed({*}, {Since:74 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc820b917a0 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:24.152168 2016-09-13T10:21:24.152+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:24.152198 2016-09-13T10:21:24.152+05:30 Cache: getCachedChanges("*", {1 0 0 74 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 1 changes valid from #75
10:21:24.152202 2016-09-13T10:21:24.152+05:30 DIndex+: [changesFeed] Found 1 changes for channel *
10:21:24.152227 2016-09-13T10:21:24.152+05:30 Changes+: Sending seq:75 from channel *
10:21:24.152271 2016-09-13T10:21:24.152+05:30 Changes+: MultiChangesFeed sending &{Seq:75 ID:108 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-754b9c53a7a79f0d6763d716c62888fe]] Err:<nil> allRemoved:false branched:false} 
10:21:24.152280 2016-09-13T10:21:24.152+05:30 Changes: MultiChangesFeed done 
10:21:24.152298 2016-09-13T10:21:24.152+05:30 HTTP+: #084:     --> 200 OK  (0.0 ms)
10:21:24.154901 2016-09-13T10:21:24.154+05:30 HTTP:  #085: POST /pttdata/_bulk_get?revs=true&attachments=true  (ADMIN)
10:21:24.155058 2016-09-13T10:21:24.155+05:30 HTTP+: #085:     --> 200   (0.2 ms)
10:21:24.160656 2016-09-13T10:21:24.160+05:30 HTTP:  #086: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=75  (ADMIN)
10:21:24.160775 2016-09-13T10:21:24.160+05:30 Changes+: Int sequence multi changes feed...
10:21:24.160812 2016-09-13T10:21:24.160+05:30 Changes: MultiChangesFeed({*}, {Since:75 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc820b91d40 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:24.161003 2016-09-13T10:21:24.160+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:24.161016 2016-09-13T10:21:24.161+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:24.161021 2016-09-13T10:21:24.161+05:30 Changes: MultiChangesFeed done 
10:21:24.161032 2016-09-13T10:21:24.161+05:30 HTTP+: #086:     --> 200 OK  (0.0 ms)
10:21:24.161858 2016-09-13T10:21:24.161+05:30 HTTP:  #087: GET /pttdata/_changes?feed=longpoll&limit=50&heartbeat=30000&style=all_docs&since=75  (ADMIN)
10:21:24.161908 2016-09-13T10:21:24.161+05:30 Changes+: Int sequence multi changes feed...
10:21:24.161923 2016-09-13T10:21:24.161+05:30 Changes: MultiChangesFeed({*}, {Since:75 Limit:50 Conflicts:true IncludeDocs:false Wait:true Continuous:false Terminator:0xc820d42120 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:24.162169 2016-09-13T10:21:24.162+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:24.162181 2016-09-13T10:21:24.162+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:24.162186 2016-09-13T10:21:24.162+05:30 Changes+: MultiChangesFeed waiting... 
10:21:24.162195 2016-09-13T10:21:24.162+05:30 Changes+: Waiting for "pttdata"'s count to pass 9
10:21:24.342875 2016-09-13T10:21:24.342+05:30 Cache: Received #75 after 439ms ("108" / "1-754b9c53a7a79f0d6763d716c62888fe")
10:21:24.342885 2016-09-13T10:21:24.342+05:30 Cache+:   Ignoring duplicate of #75
10:21:24.342959 2016-09-13T10:21:24.342+05:30 Cache: Received #74 after 1442ms ("107" / "1-cc5ad5db5277b502f45d71948ff76c58")
10:21:24.342965 2016-09-13T10:21:24.342+05:30 Cache+:   Ignoring duplicate of #74
10:21:24.906808 2016-09-13T10:21:24.906+05:30 HTTP:  #088: PUT /pttdata/109  (ADMIN)
10:21:24.907209 2016-09-13T10:21:24.907+05:30 CRUD+: Invoking sync on doc "109" rev 1-aa9416cc5d5e8850c34c4e3f0e78e918
10:21:24.907642 2016-09-13T10:21:24.907+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [198.164µs]
10:21:24.907687 2016-09-13T10:21:24.907+05:30 CRUD: 	Doc "109" in channels "{channel2-pool-1-thread-1-1}"
10:21:24.907794 2016-09-13T10:21:24.907+05:30 Cache: SAVING #76
10:21:24.908056 2016-09-13T10:21:24.908+05:30 Bucket: WriteUpdate("109", 0, ...) --> <nil> [1.124077ms]
10:21:24.908156 2016-09-13T10:21:24.908+05:30 CRUD: Stored doc "109" / "1-aa9416cc5d5e8850c34c4e3f0e78e918"
10:21:24.908200 2016-09-13T10:21:24.908+05:30 HTTP+: #088:     --> 201   (1.4 ms)
10:21:24.908298 2016-09-13T10:21:24.908+05:30 Events+: Event queue worker sending event Document change event for doc id: 109 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:24.908313 2016-09-13T10:21:24.908+05:30 Events+: Event queue worker sending event Document change event for doc id: 109 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:24.908332 2016-09-13T10:21:24.908+05:30 Events+: Event queue worker sending event Document change event for doc id: 109 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:25.001731 2016-09-13T10:21:25.001+05:30 HTTP:  #089: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:25.001930 2016-09-13T10:21:25.001+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [180.898µs]
10:21:25.001959 2016-09-13T10:21:25.001+05:30 HTTP+: #089:     --> 200   (0.2 ms)
10:21:25.005261 2016-09-13T10:21:25.005+05:30 HTTP:  #090: POST /pttdata/_revs_diff  (ADMIN)
10:21:25.005883 2016-09-13T10:21:25.005+05:30 Bucket: Get("107") [391.095µs]
10:21:25.006176 2016-09-13T10:21:25.006+05:30 Bucket: Get("108") [273.631µs]
10:21:25.006216 2016-09-13T10:21:25.006+05:30 HTTP+: #090:     --> 200   (1.0 ms)
10:21:25.007132 2016-09-13T10:21:25.007+05:30 HTTP:  #091: PUT /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:25.007525 2016-09-13T10:21:25.007+05:30 Bucket: Update("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73", 0, ...) --> <nil> [360.157µs]
10:21:25.007562 2016-09-13T10:21:25.007+05:30 HTTP+: #091:     --> 201   (0.4 ms)
10:21:25.008209 2016-09-13T10:21:25.008+05:30 HTTP:  #092: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:25.008419 2016-09-13T10:21:25.008+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [181.675µs]
10:21:25.008459 2016-09-13T10:21:25.008+05:30 HTTP+: #092:     --> 200   (0.3 ms)
10:21:25.911685 2016-09-13T10:21:25.911+05:30 HTTP:  #093: PUT /pttdata/110  (ADMIN)
10:21:25.912074 2016-09-13T10:21:25.912+05:30 CRUD+: Invoking sync on doc "110" rev 1-12d4500bd89eb3cbeab04097278e4851
10:21:25.912508 2016-09-13T10:21:25.912+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [221.773µs]
10:21:25.912543 2016-09-13T10:21:25.912+05:30 CRUD: 	Doc "110" in channels "{channel2-pool-1-thread-1-1}"
10:21:25.912669 2016-09-13T10:21:25.912+05:30 Cache: SAVING #77
10:21:25.913005 2016-09-13T10:21:25.912+05:30 Bucket: WriteUpdate("110", 0, ...) --> <nil> [1.214429ms]
10:21:25.913063 2016-09-13T10:21:25.913+05:30 CRUD: Stored doc "110" / "1-12d4500bd89eb3cbeab04097278e4851"
10:21:25.913114 2016-09-13T10:21:25.913+05:30 HTTP+: #093:     --> 201   (1.4 ms)
10:21:25.913240 2016-09-13T10:21:25.913+05:30 Events+: Event queue worker sending event Document change event for doc id: 110 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:25.913297 2016-09-13T10:21:25.913+05:30 Events+: Event queue worker sending event Document change event for doc id: 110 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:25.913305 2016-09-13T10:21:25.913+05:30 Events+: Event queue worker sending event Document change event for doc id: 110 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:25.960036 2016-09-13T10:21:25.960+05:30 Cache: Received #76 after 1052ms ("109" / "1-aa9416cc5d5e8850c34c4e3f0e78e918")
10:21:25.960074 2016-09-13T10:21:25.960+05:30 Cache:     #76 ==> channel "channel2-pool-1-thread-1-1"
10:21:25.960081 2016-09-13T10:21:25.960+05:30 Cache:     #76 ==> channel "*"
10:21:25.960107 2016-09-13T10:21:25.960+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=10
10:21:25.960146 2016-09-13T10:21:25.960+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:25.960164 2016-09-13T10:21:25.960+05:30 Cache: getCachedChanges("*", {1 0 0 75 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 1 changes valid from #76
10:21:25.960169 2016-09-13T10:21:25.960+05:30 DIndex+: [changesFeed] Found 1 changes for channel *
10:21:25.960196 2016-09-13T10:21:25.960+05:30 Changes+: Sending seq:76 from channel *
10:21:25.960038 2016-09-13T10:21:25.960+05:30 Cache: Received #77 after  47ms ("110" / "1-12d4500bd89eb3cbeab04097278e4851")
10:21:25.960270 2016-09-13T10:21:25.960+05:30 Changes+: MultiChangesFeed sending &{Seq:76 ID:109 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-aa9416cc5d5e8850c34c4e3f0e78e918]] Err:<nil> allRemoved:false branched:false} 
10:21:25.960274 2016-09-13T10:21:25.960+05:30 Cache:     #77 ==> channel "channel2-pool-1-thread-1-1"
10:21:25.960277 2016-09-13T10:21:25.960+05:30 Changes: MultiChangesFeed done 
10:21:25.960280 2016-09-13T10:21:25.960+05:30 Cache:     #77 ==> channel "*"
10:21:25.960311 2016-09-13T10:21:25.960+05:30 HTTP+: #087:     --> 200 OK  (0.0 ms)
10:21:25.960319 2016-09-13T10:21:25.960+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=11
10:21:25.963272 2016-09-13T10:21:25.963+05:30 HTTP:  #094: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=75  (ADMIN)
10:21:25.963324 2016-09-13T10:21:25.963+05:30 Changes+: Int sequence multi changes feed...
10:21:25.963347 2016-09-13T10:21:25.963+05:30 Changes: MultiChangesFeed({*}, {Since:75 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc821032840 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:25.963608 2016-09-13T10:21:25.963+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:25.963627 2016-09-13T10:21:25.963+05:30 Cache: getCachedChanges("*", {1 0 0 75 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 2 changes valid from #76
10:21:25.963654 2016-09-13T10:21:25.963+05:30 DIndex+: [changesFeed] Found 2 changes for channel *
10:21:25.963678 2016-09-13T10:21:25.963+05:30 Changes+: Sending seq:76 from channel *
10:21:25.963686 2016-09-13T10:21:25.963+05:30 Changes+: Sending seq:77 from channel *
10:21:25.963725 2016-09-13T10:21:25.963+05:30 Changes+: MultiChangesFeed sending &{Seq:76 ID:109 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-aa9416cc5d5e8850c34c4e3f0e78e918]] Err:<nil> allRemoved:false branched:false} 
10:21:25.963750 2016-09-13T10:21:25.963+05:30 Changes+: MultiChangesFeed sending &{Seq:77 ID:110 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-12d4500bd89eb3cbeab04097278e4851]] Err:<nil> allRemoved:false branched:false} 
10:21:25.963755 2016-09-13T10:21:25.963+05:30 Changes: MultiChangesFeed done 
10:21:25.963768 2016-09-13T10:21:25.963+05:30 HTTP+: #094:     --> 200 OK  (0.0 ms)
10:21:25.967018 2016-09-13T10:21:25.967+05:30 HTTP:  #095: POST /pttdata/_bulk_get?revs=true&attachments=true  (ADMIN)
10:21:25.967319 2016-09-13T10:21:25.967+05:30 HTTP+: #095:     --> 200   (0.4 ms)
10:21:25.974391 2016-09-13T10:21:25.974+05:30 HTTP:  #096: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=77  (ADMIN)
10:21:25.974509 2016-09-13T10:21:25.974+05:30 Changes+: Int sequence multi changes feed...
10:21:25.974550 2016-09-13T10:21:25.974+05:30 Changes: MultiChangesFeed({*}, {Since:77 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc821080c60 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:25.974826 2016-09-13T10:21:25.974+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:25.974840 2016-09-13T10:21:25.974+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:25.974845 2016-09-13T10:21:25.974+05:30 Changes: MultiChangesFeed done 
10:21:25.975138 2016-09-13T10:21:25.975+05:30 HTTP+: #096:     --> 200 OK  (0.0 ms)
10:21:25.975902 2016-09-13T10:21:25.975+05:30 HTTP:  #097: GET /pttdata/_changes?feed=longpoll&limit=50&heartbeat=30000&style=all_docs&since=77  (ADMIN)
10:21:25.975961 2016-09-13T10:21:25.975+05:30 Changes+: Int sequence multi changes feed...
10:21:25.975976 2016-09-13T10:21:25.975+05:30 Changes: MultiChangesFeed({*}, {Since:77 Limit:50 Conflicts:true IncludeDocs:false Wait:true Continuous:false Terminator:0xc821080d80 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:25.976226 2016-09-13T10:21:25.976+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:25.976239 2016-09-13T10:21:25.976+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:25.976243 2016-09-13T10:21:25.976+05:30 Changes+: MultiChangesFeed waiting... 
10:21:25.976264 2016-09-13T10:21:25.976+05:30 Changes+: Waiting for "pttdata"'s count to pass 11
10:21:26.149138 2016-09-13T10:21:26.149+05:30 Cache: Received #77 after 236ms ("110" / "1-12d4500bd89eb3cbeab04097278e4851")
10:21:26.149157 2016-09-13T10:21:26.149+05:30 Cache+:   Ignoring duplicate of #77
10:21:26.342723 2016-09-13T10:21:26.342+05:30 Cache: Received #76 after 1434ms ("109" / "1-aa9416cc5d5e8850c34c4e3f0e78e918")
10:21:26.342734 2016-09-13T10:21:26.342+05:30 Cache+:   Ignoring duplicate of #76
10:21:26.915492 2016-09-13T10:21:26.915+05:30 HTTP:  #098: PUT /pttdata/111  (ADMIN)
10:21:26.915846 2016-09-13T10:21:26.915+05:30 CRUD+: Invoking sync on doc "111" rev 1-88eda7bb51429d1fd599cf52982811f8
10:21:26.916313 2016-09-13T10:21:26.916+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [271.687µs]
10:21:26.916346 2016-09-13T10:21:26.916+05:30 CRUD: 	Doc "111" in channels "{channel2-pool-1-thread-1-1}"
10:21:26.916493 2016-09-13T10:21:26.916+05:30 Cache: SAVING #78
10:21:26.916754 2016-09-13T10:21:26.916+05:30 Bucket: WriteUpdate("111", 0, ...) --> <nil> [1.137618ms]
10:21:26.916856 2016-09-13T10:21:26.916+05:30 CRUD: Stored doc "111" / "1-88eda7bb51429d1fd599cf52982811f8"
10:21:26.916918 2016-09-13T10:21:26.916+05:30 HTTP+: #098:     --> 201   (1.4 ms)
10:21:26.917036 2016-09-13T10:21:26.916+05:30 Events+: Event queue worker sending event Document change event for doc id: 111 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:26.917075 2016-09-13T10:21:26.917+05:30 Events+: Event queue worker sending event Document change event for doc id: 111 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:26.917082 2016-09-13T10:21:26.917+05:30 Events+: Event queue worker sending event Document change event for doc id: 111 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:27.001933 2016-09-13T10:21:27.001+05:30 HTTP:  #099: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:27.002128 2016-09-13T10:21:27.002+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [170.341µs]
10:21:27.002192 2016-09-13T10:21:27.002+05:30 HTTP+: #099:     --> 200   (0.3 ms)
10:21:27.005575 2016-09-13T10:21:27.005+05:30 HTTP:  #100: POST /pttdata/_revs_diff  (ADMIN)
10:21:27.006118 2016-09-13T10:21:27.006+05:30 Bucket: Get("109") [259.777µs]
10:21:27.006394 2016-09-13T10:21:27.006+05:30 Bucket: Get("110") [260.404µs]
10:21:27.006424 2016-09-13T10:21:27.006+05:30 HTTP+: #100:     --> 200   (0.9 ms)
10:21:27.007376 2016-09-13T10:21:27.007+05:30 HTTP:  #101: PUT /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:27.007786 2016-09-13T10:21:27.007+05:30 Bucket: Update("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73", 0, ...) --> <nil> [378.839µs]
10:21:27.007826 2016-09-13T10:21:27.007+05:30 HTTP+: #101:     --> 201   (0.5 ms)
10:21:27.008534 2016-09-13T10:21:27.008+05:30 HTTP:  #102: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:27.008798 2016-09-13T10:21:27.008+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [221.275µs]
10:21:27.008829 2016-09-13T10:21:27.008+05:30 HTTP+: #102:     --> 200   (0.3 ms)
10:21:27.919429 2016-09-13T10:21:27.919+05:30 HTTP:  #103: PUT /pttdata/112  (ADMIN)
10:21:27.919857 2016-09-13T10:21:27.919+05:30 CRUD+: Invoking sync on doc "112" rev 1-ce027adafa8ab27d2ef94e59c6cff803
10:21:27.920333 2016-09-13T10:21:27.920+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [282.557µs]
10:21:27.920372 2016-09-13T10:21:27.920+05:30 CRUD: 	Doc "112" in channels "{channel2-pool-1-thread-1-1}"
10:21:27.920490 2016-09-13T10:21:27.920+05:30 Cache: SAVING #79
10:21:27.920751 2016-09-13T10:21:27.920+05:30 Bucket: WriteUpdate("112", 0, ...) --> <nil> [1.198324ms]
10:21:27.920840 2016-09-13T10:21:27.920+05:30 CRUD: Stored doc "112" / "1-ce027adafa8ab27d2ef94e59c6cff803"
10:21:27.920881 2016-09-13T10:21:27.920+05:30 HTTP+: #103:     --> 201   (1.5 ms)
10:21:27.921023 2016-09-13T10:21:27.920+05:30 Events+: Event queue worker sending event Document change event for doc id: 112 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:27.921032 2016-09-13T10:21:27.921+05:30 Events+: Event queue worker sending event Document change event for doc id: 112 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:27.921049 2016-09-13T10:21:27.921+05:30 Events+: Event queue worker sending event Document change event for doc id: 112 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:28.149531 2016-09-13T10:21:28.149+05:30 Cache: Received #78 after 1233ms ("111" / "1-88eda7bb51429d1fd599cf52982811f8")
10:21:28.149567 2016-09-13T10:21:28.149+05:30 Cache:     #78 ==> channel "channel2-pool-1-thread-1-1"
10:21:28.149574 2016-09-13T10:21:28.149+05:30 Cache:     #78 ==> channel "*"
10:21:28.149595 2016-09-13T10:21:28.149+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=12
10:21:28.149635 2016-09-13T10:21:28.149+05:30 Cache: Received #79 after 228ms ("112" / "1-ce027adafa8ab27d2ef94e59c6cff803")
10:21:28.149680 2016-09-13T10:21:28.149+05:30 Cache:     #79 ==> channel "channel2-pool-1-thread-1-1"
10:21:28.149686 2016-09-13T10:21:28.149+05:30 Cache:     #79 ==> channel "*"
10:21:28.149700 2016-09-13T10:21:28.149+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=13
10:21:28.149635 2016-09-13T10:21:28.149+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:28.149722 2016-09-13T10:21:28.149+05:30 Cache: getCachedChanges("*", {1 0 0 77 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 2 changes valid from #78
10:21:28.149729 2016-09-13T10:21:28.149+05:30 DIndex+: [changesFeed] Found 2 changes for channel *
10:21:28.149762 2016-09-13T10:21:28.149+05:30 Changes+: Sending seq:78 from channel *
10:21:28.149768 2016-09-13T10:21:28.149+05:30 Changes+: Sending seq:79 from channel *
10:21:28.149825 2016-09-13T10:21:28.149+05:30 Changes+: MultiChangesFeed sending &{Seq:78 ID:111 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-88eda7bb51429d1fd599cf52982811f8]] Err:<nil> allRemoved:false branched:false} 
10:21:28.149864 2016-09-13T10:21:28.149+05:30 Changes+: MultiChangesFeed sending &{Seq:79 ID:112 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-ce027adafa8ab27d2ef94e59c6cff803]] Err:<nil> allRemoved:false branched:false} 
10:21:28.149872 2016-09-13T10:21:28.149+05:30 Changes: MultiChangesFeed done 
10:21:28.149894 2016-09-13T10:21:28.149+05:30 HTTP+: #097:     --> 200 OK  (0.0 ms)
10:21:28.153379 2016-09-13T10:21:28.153+05:30 HTTP:  #104: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=77  (ADMIN)
10:21:28.153503 2016-09-13T10:21:28.153+05:30 Changes+: Int sequence multi changes feed...
10:21:28.153553 2016-09-13T10:21:28.153+05:30 Changes: MultiChangesFeed({*}, {Since:77 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc8210d8ba0 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:28.153820 2016-09-13T10:21:28.153+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:28.153840 2016-09-13T10:21:28.153+05:30 Cache: getCachedChanges("*", {1 0 0 77 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 2 changes valid from #78
10:21:28.153855 2016-09-13T10:21:28.153+05:30 DIndex+: [changesFeed] Found 2 changes for channel *
10:21:28.153879 2016-09-13T10:21:28.153+05:30 Changes+: Sending seq:78 from channel *
10:21:28.153888 2016-09-13T10:21:28.153+05:30 Changes+: Sending seq:79 from channel *
10:21:28.153930 2016-09-13T10:21:28.153+05:30 Changes+: MultiChangesFeed sending &{Seq:78 ID:111 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-88eda7bb51429d1fd599cf52982811f8]] Err:<nil> allRemoved:false branched:false} 
10:21:28.153956 2016-09-13T10:21:28.153+05:30 Changes+: MultiChangesFeed sending &{Seq:79 ID:112 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-ce027adafa8ab27d2ef94e59c6cff803]] Err:<nil> allRemoved:false branched:false} 
10:21:28.153963 2016-09-13T10:21:28.153+05:30 Changes: MultiChangesFeed done 
10:21:28.153977 2016-09-13T10:21:28.153+05:30 HTTP+: #104:     --> 200 OK  (0.0 ms)
10:21:28.156902 2016-09-13T10:21:28.156+05:30 HTTP:  #105: POST /pttdata/_bulk_get?revs=true&attachments=true  (ADMIN)
10:21:28.157150 2016-09-13T10:21:28.157+05:30 HTTP+: #105:     --> 200   (0.3 ms)
10:21:28.163836 2016-09-13T10:21:28.163+05:30 HTTP:  #106: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=79  (ADMIN)
10:21:28.163950 2016-09-13T10:21:28.163+05:30 Changes+: Int sequence multi changes feed...
10:21:28.163989 2016-09-13T10:21:28.163+05:30 Changes: MultiChangesFeed({*}, {Since:79 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc8210c7560 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:28.164243 2016-09-13T10:21:28.164+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:28.164277 2016-09-13T10:21:28.164+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:28.164282 2016-09-13T10:21:28.164+05:30 Changes: MultiChangesFeed done 
10:21:28.164303 2016-09-13T10:21:28.164+05:30 HTTP+: #106:     --> 200 OK  (0.0 ms)
10:21:28.165220 2016-09-13T10:21:28.165+05:30 HTTP:  #107: GET /pttdata/_changes?feed=longpoll&limit=50&heartbeat=30000&style=all_docs&since=79  (ADMIN)
10:21:28.165334 2016-09-13T10:21:28.165+05:30 Changes+: Int sequence multi changes feed...
10:21:28.165350 2016-09-13T10:21:28.165+05:30 Changes: MultiChangesFeed({*}, {Since:79 Limit:50 Conflicts:true IncludeDocs:false Wait:true Continuous:false Terminator:0xc8210c7680 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:28.165588 2016-09-13T10:21:28.165+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:28.165597 2016-09-13T10:21:28.165+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:28.165601 2016-09-13T10:21:28.165+05:30 Changes+: MultiChangesFeed waiting... 
10:21:28.165618 2016-09-13T10:21:28.165+05:30 Changes+: Waiting for "pttdata"'s count to pass 13
10:21:28.343415 2016-09-13T10:21:28.343+05:30 Cache: Received #78 after 1426ms ("111" / "1-88eda7bb51429d1fd599cf52982811f8")
10:21:28.343445 2016-09-13T10:21:28.343+05:30 Cache+:   Ignoring duplicate of #78
10:21:28.343417 2016-09-13T10:21:28.343+05:30 Cache: Received #79 after 422ms ("112" / "1-ce027adafa8ab27d2ef94e59c6cff803")
10:21:28.343452 2016-09-13T10:21:28.343+05:30 Cache+:   Ignoring duplicate of #79
10:21:28.923324 2016-09-13T10:21:28.923+05:30 HTTP:  #108: PUT /pttdata/113  (ADMIN)
10:21:28.923651 2016-09-13T10:21:28.923+05:30 CRUD+: Invoking sync on doc "113" rev 1-5981e13b6aa626261dbf801c602ae3b0
10:21:28.924118 2016-09-13T10:21:28.924+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [218.68µs]
10:21:28.924167 2016-09-13T10:21:28.924+05:30 CRUD: 	Doc "113" in channels "{channel2-pool-1-thread-1-1}"
10:21:28.924274 2016-09-13T10:21:28.924+05:30 Cache: SAVING #80
10:21:28.924608 2016-09-13T10:21:28.924+05:30 Bucket: WriteUpdate("113", 0, ...) --> <nil> [1.163268ms]
10:21:28.924664 2016-09-13T10:21:28.924+05:30 CRUD: Stored doc "113" / "1-5981e13b6aa626261dbf801c602ae3b0"
10:21:28.924703 2016-09-13T10:21:28.924+05:30 HTTP+: #108:     --> 201   (1.4 ms)
10:21:28.924789 2016-09-13T10:21:28.924+05:30 Events+: Event queue worker sending event Document change event for doc id: 113 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:28.924798 2016-09-13T10:21:28.924+05:30 Events+: Event queue worker sending event Document change event for doc id: 113 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:28.924804 2016-09-13T10:21:28.924+05:30 Events+: Event queue worker sending event Document change event for doc id: 113 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:29.003151 2016-09-13T10:21:29.003+05:30 HTTP:  #109: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:29.003403 2016-09-13T10:21:29.003+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [220.355µs]
10:21:29.003433 2016-09-13T10:21:29.003+05:30 HTTP+: #109:     --> 200   (0.3 ms)
10:21:29.006833 2016-09-13T10:21:29.006+05:30 HTTP:  #110: POST /pttdata/_revs_diff  (ADMIN)
10:21:29.007401 2016-09-13T10:21:29.007+05:30 Bucket: Get("111") [318.958µs]
10:21:29.007744 2016-09-13T10:21:29.007+05:30 Bucket: Get("112") [325.686µs]
10:21:29.007774 2016-09-13T10:21:29.007+05:30 HTTP+: #110:     --> 200   (1.0 ms)
10:21:29.008747 2016-09-13T10:21:29.008+05:30 HTTP:  #111: PUT /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:29.009074 2016-09-13T10:21:29.009+05:30 Bucket: Update("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73", 0, ...) --> <nil> [294.437µs]
10:21:29.009124 2016-09-13T10:21:29.009+05:30 HTTP+: #111:     --> 201   (0.4 ms)
10:21:29.009905 2016-09-13T10:21:29.009+05:30 HTTP:  #112: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:29.010091 2016-09-13T10:21:29.010+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [167.726µs]
10:21:29.010166 2016-09-13T10:21:29.010+05:30 HTTP+: #112:     --> 200   (0.2 ms)
10:21:29.932503 2016-09-13T10:21:29.932+05:30 HTTP:  #113: PUT /pttdata/114  (ADMIN)
10:21:29.932988 2016-09-13T10:21:29.932+05:30 CRUD+: Invoking sync on doc "114" rev 1-192709015c036405f623dc45fcc58575
10:21:29.933435 2016-09-13T10:21:29.933+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [247.614µs]
10:21:29.933472 2016-09-13T10:21:29.933+05:30 CRUD: 	Doc "114" in channels "{channel2-pool-1-thread-1-1}"
10:21:29.933601 2016-09-13T10:21:29.933+05:30 Cache: SAVING #81
10:21:29.933928 2016-09-13T10:21:29.933+05:30 Bucket: WriteUpdate("114", 0, ...) --> <nil> [1.271672ms]
10:21:29.934016 2016-09-13T10:21:29.934+05:30 CRUD: Stored doc "114" / "1-192709015c036405f623dc45fcc58575"
10:21:29.934067 2016-09-13T10:21:29.934+05:30 HTTP+: #113:     --> 201   (1.6 ms)
10:21:29.934210 2016-09-13T10:21:29.934+05:30 Events+: Event queue worker sending event Document change event for doc id: 114 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:29.934241 2016-09-13T10:21:29.934+05:30 Events+: Event queue worker sending event Document change event for doc id: 114 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:29.934262 2016-09-13T10:21:29.934+05:30 Events+: Event queue worker sending event Document change event for doc id: 114 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:29.959704 2016-09-13T10:21:29.959+05:30 Cache: Received #81 after  26ms ("114" / "1-192709015c036405f623dc45fcc58575")
10:21:29.959737 2016-09-13T10:21:29.959+05:30 Cache:   Deferring #81 (1 now waiting for #80...#80)
10:21:29.959704 2016-09-13T10:21:29.959+05:30 Cache: Received #80 after 1035ms ("113" / "1-5981e13b6aa626261dbf801c602ae3b0")
10:21:29.959755 2016-09-13T10:21:29.959+05:30 Cache:     #80 ==> channel "channel2-pool-1-thread-1-1"
10:21:29.959762 2016-09-13T10:21:29.959+05:30 Cache:     #80 ==> channel "*"
10:21:29.959770 2016-09-13T10:21:29.959+05:30 Cache:     #81 ==> channel "channel2-pool-1-thread-1-1"
10:21:29.959774 2016-09-13T10:21:29.959+05:30 Cache:     #81 ==> channel "*"
10:21:29.959799 2016-09-13T10:21:29.959+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=14
10:21:29.959819 2016-09-13T10:21:29.959+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:29.959833 2016-09-13T10:21:29.959+05:30 Cache: getCachedChanges("*", {1 0 0 79 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 2 changes valid from #80
10:21:29.959837 2016-09-13T10:21:29.959+05:30 DIndex+: [changesFeed] Found 2 changes for channel *
10:21:29.959864 2016-09-13T10:21:29.959+05:30 Changes+: Sending seq:80 from channel *
10:21:29.959869 2016-09-13T10:21:29.959+05:30 Changes+: Sending seq:81 from channel *
10:21:29.959951 2016-09-13T10:21:29.959+05:30 Changes+: MultiChangesFeed sending &{Seq:80 ID:113 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-5981e13b6aa626261dbf801c602ae3b0]] Err:<nil> allRemoved:false branched:false} 
10:21:29.959969 2016-09-13T10:21:29.959+05:30 Changes+: MultiChangesFeed sending &{Seq:81 ID:114 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-192709015c036405f623dc45fcc58575]] Err:<nil> allRemoved:false branched:false} 
10:21:29.959985 2016-09-13T10:21:29.959+05:30 Changes: MultiChangesFeed done 
10:21:29.960028 2016-09-13T10:21:29.960+05:30 HTTP+: #107:     --> 200 OK  (0.0 ms)
10:21:29.963084 2016-09-13T10:21:29.963+05:30 HTTP:  #114: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=79  (ADMIN)
10:21:29.963236 2016-09-13T10:21:29.963+05:30 Changes+: Int sequence multi changes feed...
10:21:29.963259 2016-09-13T10:21:29.963+05:30 Changes: MultiChangesFeed({*}, {Since:79 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc821080fc0 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:29.963533 2016-09-13T10:21:29.963+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:29.963551 2016-09-13T10:21:29.963+05:30 Cache: getCachedChanges("*", {1 0 0 79 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 2 changes valid from #80
10:21:29.963566 2016-09-13T10:21:29.963+05:30 DIndex+: [changesFeed] Found 2 changes for channel *
10:21:29.963589 2016-09-13T10:21:29.963+05:30 Changes+: Sending seq:80 from channel *
10:21:29.963598 2016-09-13T10:21:29.963+05:30 Changes+: Sending seq:81 from channel *
10:21:29.963642 2016-09-13T10:21:29.963+05:30 Changes+: MultiChangesFeed sending &{Seq:80 ID:113 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-5981e13b6aa626261dbf801c602ae3b0]] Err:<nil> allRemoved:false branched:false} 
10:21:29.963667 2016-09-13T10:21:29.963+05:30 Changes+: MultiChangesFeed sending &{Seq:81 ID:114 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-192709015c036405f623dc45fcc58575]] Err:<nil> allRemoved:false branched:false} 
10:21:29.963672 2016-09-13T10:21:29.963+05:30 Changes: MultiChangesFeed done 
10:21:29.963686 2016-09-13T10:21:29.963+05:30 HTTP+: #114:     --> 200 OK  (0.0 ms)
10:21:29.966990 2016-09-13T10:21:29.966+05:30 HTTP:  #115: POST /pttdata/_bulk_get?revs=true&attachments=true  (ADMIN)
10:21:29.967246 2016-09-13T10:21:29.967+05:30 HTTP+: #115:     --> 200   (0.3 ms)
10:21:29.974683 2016-09-13T10:21:29.974+05:30 HTTP:  #116: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=81  (ADMIN)
10:21:29.974730 2016-09-13T10:21:29.974+05:30 Changes+: Int sequence multi changes feed...
10:21:29.974750 2016-09-13T10:21:29.974+05:30 Changes: MultiChangesFeed({*}, {Since:81 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc820d35500 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:29.975074 2016-09-13T10:21:29.975+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:29.975088 2016-09-13T10:21:29.975+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:29.975105 2016-09-13T10:21:29.975+05:30 Changes: MultiChangesFeed done 
10:21:29.975136 2016-09-13T10:21:29.975+05:30 HTTP+: #116:     --> 200 OK  (0.0 ms)
10:21:29.976167 2016-09-13T10:21:29.976+05:30 HTTP:  #117: GET /pttdata/_changes?feed=longpoll&limit=50&heartbeat=30000&style=all_docs&since=81  (ADMIN)
10:21:29.976219 2016-09-13T10:21:29.976+05:30 Changes+: Int sequence multi changes feed...
10:21:29.976234 2016-09-13T10:21:29.976+05:30 Changes: MultiChangesFeed({*}, {Since:81 Limit:50 Conflicts:true IncludeDocs:false Wait:true Continuous:false Terminator:0xc820d35620 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:29.976471 2016-09-13T10:21:29.976+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:29.976481 2016-09-13T10:21:29.976+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:29.976496 2016-09-13T10:21:29.976+05:30 Changes+: MultiChangesFeed waiting... 
10:21:29.976505 2016-09-13T10:21:29.976+05:30 Changes+: Waiting for "pttdata"'s count to pass 14
10:21:30.148857 2016-09-13T10:21:30.148+05:30 Cache: Received #80 after 1224ms ("113" / "1-5981e13b6aa626261dbf801c602ae3b0")
10:21:30.148881 2016-09-13T10:21:30.148+05:30 Cache+:   Ignoring duplicate of #80
10:21:30.344463 2016-09-13T10:21:30.344+05:30 Cache: Received #81 after 410ms ("114" / "1-192709015c036405f623dc45fcc58575")
10:21:30.344487 2016-09-13T10:21:30.344+05:30 Cache+:   Ignoring duplicate of #81
10:21:30.936736 2016-09-13T10:21:30.936+05:30 HTTP:  #118: PUT /pttdata/115  (ADMIN)
10:21:30.937113 2016-09-13T10:21:30.937+05:30 CRUD+: Invoking sync on doc "115" rev 1-3e8f8bb7a381123076eb5ce763aa1ee6
10:21:30.937526 2016-09-13T10:21:30.937+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [203.86µs]
10:21:30.937549 2016-09-13T10:21:30.937+05:30 CRUD: 	Doc "115" in channels "{channel2-pool-1-thread-1-1}"
10:21:30.937675 2016-09-13T10:21:30.937+05:30 Cache: SAVING #82
10:21:30.937934 2016-09-13T10:21:30.937+05:30 Bucket: WriteUpdate("115", 0, ...) --> <nil> [1.080403ms]
10:21:30.937998 2016-09-13T10:21:30.937+05:30 CRUD: Stored doc "115" / "1-3e8f8bb7a381123076eb5ce763aa1ee6"
10:21:30.938079 2016-09-13T10:21:30.938+05:30 HTTP+: #118:     --> 201   (1.4 ms)
10:21:30.938246 2016-09-13T10:21:30.938+05:30 Events+: Event queue worker sending event Document change event for doc id: 115 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:30.938261 2016-09-13T10:21:30.938+05:30 Events+: Event queue worker sending event Document change event for doc id: 115 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:30.938267 2016-09-13T10:21:30.938+05:30 Events+: Event queue worker sending event Document change event for doc id: 115 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:31.002570 2016-09-13T10:21:31.002+05:30 HTTP:  #119: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:31.002741 2016-09-13T10:21:31.002+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [141.757µs]
10:21:31.002814 2016-09-13T10:21:31.002+05:30 HTTP+: #119:     --> 200   (0.2 ms)
10:21:31.005819 2016-09-13T10:21:31.005+05:30 HTTP:  #120: POST /pttdata/_revs_diff  (ADMIN)
10:21:31.006358 2016-09-13T10:21:31.006+05:30 Bucket: Get("113") [287.9µs]
10:21:31.006650 2016-09-13T10:21:31.006+05:30 Bucket: Get("114") [276.523µs]
10:21:31.006678 2016-09-13T10:21:31.006+05:30 HTTP+: #120:     --> 200   (0.9 ms)
10:21:31.007676 2016-09-13T10:21:31.007+05:30 HTTP:  #121: PUT /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:31.008027 2016-09-13T10:21:31.008+05:30 Bucket: Update("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73", 0, ...) --> <nil> [315.362µs]
10:21:31.008056 2016-09-13T10:21:31.008+05:30 HTTP+: #121:     --> 201   (0.4 ms)
10:21:31.008940 2016-09-13T10:21:31.008+05:30 HTTP:  #122: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:31.009131 2016-09-13T10:21:31.009+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [171.912µs]
10:21:31.009179 2016-09-13T10:21:31.009+05:30 HTTP+: #122:     --> 200   (0.2 ms)
10:21:31.786606 2016-09-13T10:21:31.786+05:30 Changes: Connection lost from client:  (as ADMIN)
10:21:31.786657 2016-09-13T10:21:31.786+05:30 HTTP+: #117:     --> 200 OK  (0.0 ms)
10:21:31.940702 2016-09-13T10:21:31.940+05:30 HTTP:  #123: PUT /pttdata/116  (ADMIN)
10:21:31.941054 2016-09-13T10:21:31.941+05:30 CRUD+: Invoking sync on doc "116" rev 1-11a853719aa1976d033d62606cdeee0b
10:21:31.941579 2016-09-13T10:21:31.941+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [238.765µs]
10:21:31.941610 2016-09-13T10:21:31.941+05:30 CRUD: 	Doc "116" in channels "{channel2-pool-1-thread-1-1}"
10:21:31.941765 2016-09-13T10:21:31.941+05:30 Cache: SAVING #83
10:21:31.942059 2016-09-13T10:21:31.942+05:30 Bucket: WriteUpdate("116", 0, ...) --> <nil> [1.215224ms]
10:21:31.942138 2016-09-13T10:21:31.942+05:30 CRUD: Stored doc "116" / "1-11a853719aa1976d033d62606cdeee0b"
10:21:31.942226 2016-09-13T10:21:31.942+05:30 HTTP+: #123:     --> 201   (1.5 ms)
10:21:31.942339 2016-09-13T10:21:31.942+05:30 Events+: Event queue worker sending event Document change event for doc id: 116 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:31.942363 2016-09-13T10:21:31.942+05:30 Events+: Event queue worker sending event Document change event for doc id: 116 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:31.942381 2016-09-13T10:21:31.942+05:30 Events+: Event queue worker sending event Document change event for doc id: 116 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:31.960625 2016-09-13T10:21:31.960+05:30 Cache: Received #83 after  18ms ("116" / "1-11a853719aa1976d033d62606cdeee0b")
10:21:31.960649 2016-09-13T10:21:31.960+05:30 Cache:   Deferring #83 (1 now waiting for #82...#82)
10:21:31.960755 2016-09-13T10:21:31.960+05:30 Cache: Received #82 after 1023ms ("115" / "1-3e8f8bb7a381123076eb5ce763aa1ee6")
10:21:31.960788 2016-09-13T10:21:31.960+05:30 Cache:     #82 ==> channel "channel2-pool-1-thread-1-1"
10:21:31.960795 2016-09-13T10:21:31.960+05:30 Cache:     #82 ==> channel "*"
10:21:31.960804 2016-09-13T10:21:31.960+05:30 Cache:     #83 ==> channel "channel2-pool-1-thread-1-1"
10:21:31.960808 2016-09-13T10:21:31.960+05:30 Cache:     #83 ==> channel "*"
10:21:31.960835 2016-09-13T10:21:31.960+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=15
10:21:31.960849 2016-09-13T10:21:31.960+05:30 Changes: MultiChangesFeed done 
10:21:32.149902 2016-09-13T10:21:32.149+05:30 Cache: Received #82 after 1212ms ("115" / "1-3e8f8bb7a381123076eb5ce763aa1ee6")
10:21:32.149914 2016-09-13T10:21:32.149+05:30 Cache+:   Ignoring duplicate of #82
10:21:32.344598 2016-09-13T10:21:32.344+05:30 Cache: Received #83 after 402ms ("116" / "1-11a853719aa1976d033d62606cdeee0b")
10:21:32.344611 2016-09-13T10:21:32.344+05:30 Cache+:   Ignoring duplicate of #83
10:21:32.944886 2016-09-13T10:21:32.944+05:30 HTTP:  #124: PUT /pttdata/117  (ADMIN)
10:21:32.945384 2016-09-13T10:21:32.945+05:30 CRUD+: Invoking sync on doc "117" rev 1-73a6b56d736dcafa8964d7ca1e52bfac
10:21:32.945798 2016-09-13T10:21:32.945+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [185.63µs]
10:21:32.945818 2016-09-13T10:21:32.945+05:30 CRUD: 	Doc "117" in channels "{channel2-pool-1-thread-1-1}"
10:21:32.945907 2016-09-13T10:21:32.945+05:30 Cache: SAVING #84
10:21:32.946167 2016-09-13T10:21:32.946+05:30 Bucket: WriteUpdate("117", 0, ...) --> <nil> [1.169926ms]
10:21:32.946256 2016-09-13T10:21:32.946+05:30 CRUD: Stored doc "117" / "1-73a6b56d736dcafa8964d7ca1e52bfac"
10:21:32.946325 2016-09-13T10:21:32.946+05:30 HTTP+: #124:     --> 201   (1.5 ms)
10:21:32.946466 2016-09-13T10:21:32.946+05:30 Events+: Event queue worker sending event Document change event for doc id: 117 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:32.946480 2016-09-13T10:21:32.946+05:30 Events+: Event queue worker sending event Document change event for doc id: 117 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:32.946486 2016-09-13T10:21:32.946+05:30 Events+: Event queue worker sending event Document change event for doc id: 117 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:33.950578 2016-09-13T10:21:33.950+05:30 HTTP:  #125: PUT /pttdata/118  (ADMIN)
10:21:33.951006 2016-09-13T10:21:33.951+05:30 CRUD+: Invoking sync on doc "118" rev 1-748e12de79ec0b69739f37c306b018e7
10:21:33.951434 2016-09-13T10:21:33.951+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [227.773µs]
10:21:33.951489 2016-09-13T10:21:33.951+05:30 CRUD: 	Doc "118" in channels "{channel2-pool-1-thread-1-1}"
10:21:33.951595 2016-09-13T10:21:33.951+05:30 Cache: SAVING #85
10:21:33.951817 2016-09-13T10:21:33.951+05:30 Bucket: WriteUpdate("118", 0, ...) --> <nil> [1.101202ms]
10:21:33.951869 2016-09-13T10:21:33.951+05:30 CRUD: Stored doc "118" / "1-748e12de79ec0b69739f37c306b018e7"
10:21:33.951934 2016-09-13T10:21:33.951+05:30 HTTP+: #125:     --> 201   (1.4 ms)
10:21:33.952047 2016-09-13T10:21:33.952+05:30 Events+: Event queue worker sending event Document change event for doc id: 118 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:33.952068 2016-09-13T10:21:33.952+05:30 Events+: Event queue worker sending event Document change event for doc id: 118 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:33.952084 2016-09-13T10:21:33.952+05:30 Events+: Event queue worker sending event Document change event for doc id: 118 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:33.959889 2016-09-13T10:21:33.959+05:30 Cache: Received #85 after   8ms ("118" / "1-748e12de79ec0b69739f37c306b018e7")
10:21:33.959904 2016-09-13T10:21:33.959+05:30 Cache:   Deferring #85 (1 now waiting for #84...#84)
10:21:34.149040 2016-09-13T10:21:34.149+05:30 Cache: Received #84 after 1203ms ("117" / "1-73a6b56d736dcafa8964d7ca1e52bfac")
10:21:34.149057 2016-09-13T10:21:34.149+05:30 Cache:     #84 ==> channel "channel2-pool-1-thread-1-1"
10:21:34.149063 2016-09-13T10:21:34.149+05:30 Cache:     #84 ==> channel "*"
10:21:34.149072 2016-09-13T10:21:34.149+05:30 Cache:     #85 ==> channel "channel2-pool-1-thread-1-1"
10:21:34.149075 2016-09-13T10:21:34.149+05:30 Cache:     #85 ==> channel "*"
10:21:34.149101 2016-09-13T10:21:34.149+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=16
10:21:34.344315 2016-09-13T10:21:34.344+05:30 Cache: Received #84 after 1398ms ("117" / "1-73a6b56d736dcafa8964d7ca1e52bfac")
10:21:34.344328 2016-09-13T10:21:34.344+05:30 Cache+:   Ignoring duplicate of #84
10:21:34.344330 2016-09-13T10:21:34.344+05:30 Cache: Received #85 after 392ms ("118" / "1-748e12de79ec0b69739f37c306b018e7")
10:21:34.344354 2016-09-13T10:21:34.344+05:30 Cache+:   Ignoring duplicate of #85
10:21:34.954323 2016-09-13T10:21:34.954+05:30 HTTP:  #126: PUT /pttdata/119  (ADMIN)
10:21:34.954694 2016-09-13T10:21:34.954+05:30 CRUD+: Invoking sync on doc "119" rev 1-e15af0a6d0a005c1c7161a3efe93f881
10:21:34.955283 2016-09-13T10:21:34.955+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [331.822µs]
10:21:34.955318 2016-09-13T10:21:34.955+05:30 CRUD: 	Doc "119" in channels "{channel2-pool-1-thread-1-1}"
10:21:34.955447 2016-09-13T10:21:34.955+05:30 Cache: SAVING #86
10:21:34.955681 2016-09-13T10:21:34.955+05:30 Bucket: WriteUpdate("119", 0, ...) --> <nil> [1.251915ms]
10:21:34.955759 2016-09-13T10:21:34.955+05:30 CRUD: Stored doc "119" / "1-e15af0a6d0a005c1c7161a3efe93f881"
10:21:34.955790 2016-09-13T10:21:34.955+05:30 HTTP+: #126:     --> 201   (1.5 ms)
10:21:34.955887 2016-09-13T10:21:34.955+05:30 Events+: Event queue worker sending event Document change event for doc id: 119 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:34.955896 2016-09-13T10:21:34.955+05:30 Events+: Event queue worker sending event Document change event for doc id: 119 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:34.955902 2016-09-13T10:21:34.955+05:30 Events+: Event queue worker sending event Document change event for doc id: 119 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:35.958173 2016-09-13T10:21:35.958+05:30 HTTP:  #127: PUT /pttdata/120  (ADMIN)
10:21:35.958551 2016-09-13T10:21:35.958+05:30 CRUD+: Invoking sync on doc "120" rev 1-d08f06071d63db7c2d47369a61637621
10:21:35.959012 2016-09-13T10:21:35.959+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [204.408µs]
10:21:35.959043 2016-09-13T10:21:35.959+05:30 CRUD: 	Doc "120" in channels "{channel2-pool-1-thread-1-1}"
10:21:35.959129 2016-09-13T10:21:35.959+05:30 Cache: SAVING #87
10:21:35.959388 2016-09-13T10:21:35.959+05:30 Bucket: WriteUpdate("120", 0, ...) --> <nil> [1.100187ms]
10:21:35.959467 2016-09-13T10:21:35.959+05:30 CRUD: Stored doc "120" / "1-d08f06071d63db7c2d47369a61637621"
10:21:35.959506 2016-09-13T10:21:35.959+05:30 HTTP+: #127:     --> 201   (1.4 ms)
10:21:35.959622 2016-09-13T10:21:35.959+05:30 Events+: Event queue worker sending event Document change event for doc id: 120 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:35.959674 2016-09-13T10:21:35.959+05:30 Events+: Event queue worker sending event Document change event for doc id: 120 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:35.959680 2016-09-13T10:21:35.959+05:30 Events+: Event queue worker sending event Document change event for doc id: 120 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:35.961708 2016-09-13T10:21:35.961+05:30 Cache: Received #86 after 1006ms ("119" / "1-e15af0a6d0a005c1c7161a3efe93f881")
10:21:35.961723 2016-09-13T10:21:35.961+05:30 Cache:     #86 ==> channel "channel2-pool-1-thread-1-1"
10:21:35.961729 2016-09-13T10:21:35.961+05:30 Cache:     #86 ==> channel "*"
10:21:35.961768 2016-09-13T10:21:35.961+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=17
10:21:35.961864 2016-09-13T10:21:35.961+05:30 Cache: Received #87 after   2ms ("120" / "1-d08f06071d63db7c2d47369a61637621")
10:21:35.961878 2016-09-13T10:21:35.961+05:30 Cache:     #87 ==> channel "channel2-pool-1-thread-1-1"
10:21:35.961883 2016-09-13T10:21:35.961+05:30 Cache:     #87 ==> channel "*"
10:21:35.961896 2016-09-13T10:21:35.961+05:30 Changes+: Notifying that "pttdata" changed (keys="{*, channel2-pool-1-thread-1-1}") count=18
10:21:36.149622 2016-09-13T10:21:36.149+05:30 Cache: Received #86 after 1194ms ("119" / "1-e15af0a6d0a005c1c7161a3efe93f881")
10:21:36.149634 2016-09-13T10:21:36.149+05:30 Cache+:   Ignoring duplicate of #86
10:21:36.345886 2016-09-13T10:21:36.345+05:30 Cache: Received #87 after 386ms ("120" / "1-d08f06071d63db7c2d47369a61637621")
10:21:36.345903 2016-09-13T10:21:36.345+05:30 Cache+:   Ignoring duplicate of #87
10:21:36.953106 2016-09-13T10:21:36.953+05:30 HTTP:  #128: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=81  (ADMIN)
10:21:36.953189 2016-09-13T10:21:36.953+05:30 Changes+: Int sequence multi changes feed...
10:21:36.953255 2016-09-13T10:21:36.953+05:30 Changes: MultiChangesFeed({*}, {Since:81 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc8214ae600 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:36.953520 2016-09-13T10:21:36.953+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:36.953548 2016-09-13T10:21:36.953+05:30 Cache: getCachedChanges("*", {1 0 0 81 <nil> <nil> %!d(string=) 0 0 0 %!d(string=)}) --> 6 changes valid from #82
10:21:36.953554 2016-09-13T10:21:36.953+05:30 DIndex+: [changesFeed] Found 6 changes for channel *
10:21:36.953587 2016-09-13T10:21:36.953+05:30 Changes+: Sending seq:82 from channel *
10:21:36.953597 2016-09-13T10:21:36.953+05:30 Changes+: Sending seq:83 from channel *
10:21:36.953654 2016-09-13T10:21:36.953+05:30 Changes+: MultiChangesFeed sending &{Seq:82 ID:115 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-3e8f8bb7a381123076eb5ce763aa1ee6]] Err:<nil> allRemoved:false branched:false} 
10:21:36.953689 2016-09-13T10:21:36.953+05:30 Changes+: Sending seq:84 from channel *
10:21:36.953704 2016-09-13T10:21:36.953+05:30 Changes+: MultiChangesFeed sending &{Seq:83 ID:116 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-11a853719aa1976d033d62606cdeee0b]] Err:<nil> allRemoved:false branched:false} 
10:21:36.953719 2016-09-13T10:21:36.953+05:30 Changes+: Sending seq:85 from channel *
10:21:36.953732 2016-09-13T10:21:36.953+05:30 Changes+: MultiChangesFeed sending &{Seq:84 ID:117 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-73a6b56d736dcafa8964d7ca1e52bfac]] Err:<nil> allRemoved:false branched:false} 
10:21:36.953745 2016-09-13T10:21:36.953+05:30 Changes+: Sending seq:86 from channel *
10:21:36.953758 2016-09-13T10:21:36.953+05:30 Changes+: MultiChangesFeed sending &{Seq:85 ID:118 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-748e12de79ec0b69739f37c306b018e7]] Err:<nil> allRemoved:false branched:false} 
10:21:36.953770 2016-09-13T10:21:36.953+05:30 Changes+: Sending seq:87 from channel *
10:21:36.953813 2016-09-13T10:21:36.953+05:30 Changes+: MultiChangesFeed sending &{Seq:86 ID:119 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-e15af0a6d0a005c1c7161a3efe93f881]] Err:<nil> allRemoved:false branched:false} 
10:21:36.953836 2016-09-13T10:21:36.953+05:30 Changes+: MultiChangesFeed sending &{Seq:87 ID:120 Deleted:false Removed:{} Doc:map[] Changes:[map[rev:1-d08f06071d63db7c2d47369a61637621]] Err:<nil> allRemoved:false branched:false} 
10:21:36.953842 2016-09-13T10:21:36.953+05:30 Changes: MultiChangesFeed done 
10:21:36.953861 2016-09-13T10:21:36.953+05:30 HTTP+: #128:     --> 200 OK  (0.0 ms)
10:21:36.958576 2016-09-13T10:21:36.958+05:30 HTTP:  #129: POST /pttdata/_bulk_get?revs=true&attachments=true  (ADMIN)
10:21:36.959079 2016-09-13T10:21:36.959+05:30 HTTP+: #129:     --> 200   (0.6 ms)
10:21:36.962382 2016-09-13T10:21:36.962+05:30 HTTP:  #130: PUT /pttdata/121  (ADMIN)
10:21:36.962666 2016-09-13T10:21:36.962+05:30 CRUD+: Invoking sync on doc "121" rev 1-71e4712f0f49e127a6ae64a4ae696b57
10:21:36.963082 2016-09-13T10:21:36.963+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [161.73µs]
10:21:36.963099 2016-09-13T10:21:36.963+05:30 CRUD: 	Doc "121" in channels "{channel2-pool-1-thread-1-1}"
10:21:36.963262 2016-09-13T10:21:36.963+05:30 Cache: SAVING #88
10:21:36.963544 2016-09-13T10:21:36.963+05:30 Bucket: WriteUpdate("121", 0, ...) --> <nil> [1.063215ms]
10:21:36.963614 2016-09-13T10:21:36.963+05:30 CRUD: Stored doc "121" / "1-71e4712f0f49e127a6ae64a4ae696b57"
10:21:36.963650 2016-09-13T10:21:36.963+05:30 HTTP+: #130:     --> 201   (1.3 ms)
10:21:36.963723 2016-09-13T10:21:36.963+05:30 Events+: Event queue worker sending event Document change event for doc id: 121 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:36.963731 2016-09-13T10:21:36.963+05:30 Events+: Event queue worker sending event Document change event for doc id: 121 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:36.963751 2016-09-13T10:21:36.963+05:30 Events+: Event queue worker sending event Document change event for doc id: 121 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:36.971237 2016-09-13T10:21:36.971+05:30 HTTP:  #131: GET /pttdata/_changes?feed=normal&limit=50&heartbeat=30000&style=all_docs&since=87  (ADMIN)
10:21:36.971292 2016-09-13T10:21:36.971+05:30 Changes+: Int sequence multi changes feed...
10:21:36.971308 2016-09-13T10:21:36.971+05:30 Changes: MultiChangesFeed({*}, {Since:87 Limit:50 Conflicts:true IncludeDocs:false Wait:false Continuous:false Terminator:0xc8214ae8a0 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:36.971570 2016-09-13T10:21:36.971+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:36.971595 2016-09-13T10:21:36.971+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:36.971601 2016-09-13T10:21:36.971+05:30 Changes: MultiChangesFeed done 
10:21:36.971639 2016-09-13T10:21:36.971+05:30 HTTP+: #131:     --> 200 OK  (0.0 ms)
10:21:36.973072 2016-09-13T10:21:36.973+05:30 HTTP:  #132: GET /pttdata/_changes?feed=longpoll&limit=50&heartbeat=30000&style=all_docs&since=87  (ADMIN)
10:21:36.973125 2016-09-13T10:21:36.973+05:30 Changes+: Int sequence multi changes feed...
10:21:36.973173 2016-09-13T10:21:36.973+05:30 Changes: MultiChangesFeed({*}, {Since:87 Limit:50 Conflicts:true IncludeDocs:false Wait:true Continuous:false Terminator:0xc8214ae9c0 HeartbeatMs:30000 TimeoutMs:300000 ActiveOnly:false}) ... 
10:21:36.973423 2016-09-13T10:21:36.973+05:30 Changes+: MultiChangesFeed: channels expand to channels.TimedSet{"*":channels.VbSequence{VbNo:(*uint16)(nil), Sequence:0x0}} ... 
10:21:36.973441 2016-09-13T10:21:36.973+05:30 DIndex+: [changesFeed] Found 0 changes for channel *
10:21:36.973447 2016-09-13T10:21:36.973+05:30 Changes+: MultiChangesFeed waiting... 
10:21:36.973458 2016-09-13T10:21:36.973+05:30 Changes+: Waiting for "pttdata"'s count to pass 18
10:21:37.975350 2016-09-13T10:21:37.975+05:30 HTTP:  #133: PUT /pttdata/122  (ADMIN)
10:21:37.975754 2016-09-13T10:21:37.975+05:30 CRUD+: Invoking sync on doc "122" rev 1-06e881e4a2543f284c6b85effb011187
10:21:37.976233 2016-09-13T10:21:37.976+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [248.245µs]
10:21:37.976279 2016-09-13T10:21:37.976+05:30 CRUD: 	Doc "122" in channels "{channel2-pool-1-thread-1-1}"
10:21:37.976388 2016-09-13T10:21:37.976+05:30 Cache: SAVING #89
10:21:37.976585 2016-09-13T10:21:37.976+05:30 Bucket: WriteUpdate("122", 0, ...) --> <nil> [1.100295ms]
10:21:37.976629 2016-09-13T10:21:37.976+05:30 CRUD: Stored doc "122" / "1-06e881e4a2543f284c6b85effb011187"
10:21:37.976670 2016-09-13T10:21:37.976+05:30 HTTP+: #133:     --> 201   (1.3 ms)
10:21:37.976767 2016-09-13T10:21:37.976+05:30 Events+: Event queue worker sending event Document change event for doc id: 122 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:37.976776 2016-09-13T10:21:37.976+05:30 Events+: Event queue worker sending event Document change event for doc id: 122 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:37.976795 2016-09-13T10:21:37.976+05:30 Events+: Event queue worker sending event Document change event for doc id: 122 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:38.884173 2016-09-13T10:21:38.884+05:30 Cache: Received #84 after 5938ms ("117" / "1-73a6b56d736dcafa8964d7ca1e52bfac")
10:21:38.884199 2016-09-13T10:21:38.884+05:30 Cache+:   Ignoring duplicate of #84
10:21:38.978974 2016-09-13T10:21:38.978+05:30 HTTP:  #134: PUT /pttdata/123  (ADMIN)
10:21:38.980443 2016-09-13T10:21:38.980+05:30 Bucket: WriteUpdate("123", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.36102ms]
10:21:38.980494 2016-09-13T10:21:38.980+05:30 HTTP: #134:     --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused  (1.5 ms)
10:21:39.983254 2016-09-13T10:21:39.983+05:30 HTTP:  #135: PUT /pttdata/124  (ADMIN)
10:21:39.985200 2016-09-13T10:21:39.985+05:30 CRUD+: Invoking sync on doc "124" rev 1-7dc450efeefc7e01eefb008edf071ce3
10:21:39.985607 2016-09-13T10:21:39.985+05:30 Bucket: Incr("_sync:seq", 1, 1, 0) [222.536µs]
10:21:39.985635 2016-09-13T10:21:39.985+05:30 CRUD: 	Doc "124" in channels "{channel2-pool-1-thread-1-1}"
10:21:39.985780 2016-09-13T10:21:39.985+05:30 Cache: SAVING #90
10:21:39.986129 2016-09-13T10:21:39.986+05:30 Bucket: WriteUpdate("124", 0, ...) --> <nil> [2.712164ms]
10:21:39.986231 2016-09-13T10:21:39.986+05:30 CRUD: Stored doc "124" / "1-7dc450efeefc7e01eefb008edf071ce3"
10:21:39.986280 2016-09-13T10:21:39.986+05:30 HTTP+: #135:     --> 201   (3.1 ms)
10:21:39.986434 2016-09-13T10:21:39.986+05:30 Events+: Event queue worker sending event Document change event for doc id: 124 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:39.986447 2016-09-13T10:21:39.986+05:30 Events+: Event queue worker sending event Document change event for doc id: 124 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:39.986453 2016-09-13T10:21:39.986+05:30 Events+: Event queue worker sending event Document change event for doc id: 124 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:40.988724 2016-09-13T10:21:40.988+05:30 HTTP:  #136: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:40.989241 2016-09-13T10:21:40.989+05:30 HTTP:  #137: PUT /pttdata/125  (ADMIN)
10:21:40.990487 2016-09-13T10:21:40.990+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [1.741033ms]
10:21:40.990559 2016-09-13T10:21:40.990+05:30 HTTP+: #136:     --> 200   (1.9 ms)
10:21:40.990566 2016-09-13T10:21:40.990+05:30 Bucket: WriteUpdate("125", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.221974ms]
10:21:40.990634 2016-09-13T10:21:40.990+05:30 HTTP: #137:     --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused  (1.4 ms)
10:21:40.995240 2016-09-13T10:21:40.995+05:30 HTTP:  #138: POST /pttdata/_revs_diff  (ADMIN)
10:21:41.004910 2016-09-13T10:21:41.004+05:30 Bucket: Get("119") [1.676058ms]
10:21:41.006217 2016-09-13T10:21:41.006+05:30 Bucket: Get("120") [1.255533ms]
10:21:41.006268 2016-09-13T10:21:41.006+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:41.006591 2016-09-13T10:21:41.006+05:30 Bucket: Get("115") [284.632µs]
10:21:41.006896 2016-09-13T10:21:41.006+05:30 Bucket: Get("116") [285.149µs]
10:21:41.008153 2016-09-13T10:21:41.008+05:30 Bucket: Get("117") [1.20976ms]
10:21:41.008185 2016-09-13T10:21:41.008+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:41.009404 2016-09-13T10:21:41.009+05:30 Bucket: Get("118") [1.190623ms]
10:21:41.009432 2016-09-13T10:21:41.009+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:41.009652 2016-09-13T10:21:41.009+05:30 HTTP+: #138:     --> 200   (14.4 ms)
10:21:41.013631 2016-09-13T10:21:41.013+05:30 HTTP:  #139: POST /pttdata/_bulk_docs  (ADMIN)
10:21:41.014014 2016-09-13T10:21:41.014+05:30 Bucket: Incr("_sync:seq", 3, 3, 0) [251.375µs]
10:21:41.015413 2016-09-13T10:21:41.015+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.332788ms]
10:21:41.015440 2016-09-13T10:21:41.015+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:41.016738 2016-09-13T10:21:41.016+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.270621ms]
10:21:41.016757 2016-09-13T10:21:41.016+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:41.017991 2016-09-13T10:21:41.017+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.208694ms]
10:21:41.018023 2016-09-13T10:21:41.018+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:41.018065 2016-09-13T10:21:41.018+05:30 HTTP+: #139:     --> 201   (4.4 ms)
10:21:41.994359 2016-09-13T10:21:41.994+05:30 HTTP:  #140: PUT /pttdata/126  (ADMIN)
10:21:41.995784 2016-09-13T10:21:41.995+05:30 Bucket: WriteUpdate("126", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.274669ms]
10:21:41.995833 2016-09-13T10:21:41.995+05:30 HTTP: #140:     --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused  (1.5 ms)
10:21:42.019356 2016-09-13T10:21:42.019+05:30 HTTP:  #141: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:42.019576 2016-09-13T10:21:42.019+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [200.788µs]
10:21:42.019618 2016-09-13T10:21:42.019+05:30 HTTP+: #141:     --> 200   (0.3 ms)
10:21:42.023279 2016-09-13T10:21:42.023+05:30 HTTP:  #142: POST /pttdata/_revs_diff  (ADMIN)
10:21:42.024244 2016-09-13T10:21:42.024+05:30 Bucket: Get("115") [342.738µs]
10:21:42.024601 2016-09-13T10:21:42.024+05:30 Bucket: Get("116") [338.927µs]
10:21:42.025923 2016-09-13T10:21:42.025+05:30 Bucket: Get("117") [1.289903ms]
10:21:42.025949 2016-09-13T10:21:42.025+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:42.027243 2016-09-13T10:21:42.027+05:30 Bucket: Get("118") [1.256648ms]
10:21:42.027286 2016-09-13T10:21:42.027+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:42.027625 2016-09-13T10:21:42.027+05:30 Bucket: Get("119") [308.585µs]
10:21:42.028907 2016-09-13T10:21:42.028+05:30 Bucket: Get("120") [1.264213ms]
10:21:42.028955 2016-09-13T10:21:42.028+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:42.029055 2016-09-13T10:21:42.029+05:30 HTTP+: #142:     --> 200   (5.8 ms)
10:21:42.032569 2016-09-13T10:21:42.032+05:30 HTTP:  #143: POST /pttdata/_bulk_docs  (ADMIN)
10:21:42.034000 2016-09-13T10:21:42.033+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.266504ms]
10:21:42.034029 2016-09-13T10:21:42.034+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:42.035342 2016-09-13T10:21:42.035+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.275495ms]
10:21:42.035360 2016-09-13T10:21:42.035+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:42.036651 2016-09-13T10:21:42.036+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.240446ms]
10:21:42.036679 2016-09-13T10:21:42.036+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:42.036724 2016-09-13T10:21:42.036+05:30 HTTP+: #143:     --> 201   (4.2 ms)
10:21:42.742895 2016-09-13T10:21:42.742+05:30 HTTP:  #144: GET /
10:21:42.742950 2016-09-13T10:21:42.742+05:30 HTTP+: #144:     --> 200   (0.1 ms)
10:21:42.897581 2016-09-13T10:21:42.897+05:30 HTTP:  #145: GET /pttdata/  (ADMIN)
10:21:42.897882 2016-09-13T10:21:42.897+05:30 Bucket: Incr("_sync:seq", 0, 0, 0) [276.638µs]
10:21:42.897936 2016-09-13T10:21:42.897+05:30 HTTP+: #145:     --> 200   (0.4 ms)
10:21:42.998156 2016-09-13T10:21:42.998+05:30 HTTP:  #146: PUT /pttdata/127  (ADMIN)
10:21:42.998513 2016-09-13T10:21:42.998+05:30 CRUD+: Invoking sync on doc "127" rev 1-c7562aaa3d0b6135a5b49b7407458f9d
10:21:42.998800 2016-09-13T10:21:42.998+05:30 CRUD: 	Doc "127" in channels "{channel2-pool-1-thread-1-1}"
10:21:42.998889 2016-09-13T10:21:42.998+05:30 Cache: SAVING #91
10:21:42.999091 2016-09-13T10:21:42.999+05:30 Bucket: WriteUpdate("127", 0, ...) --> <nil> [826.595µs]
10:21:42.999166 2016-09-13T10:21:42.999+05:30 CRUD: Stored doc "127" / "1-c7562aaa3d0b6135a5b49b7407458f9d"
10:21:42.999205 2016-09-13T10:21:42.999+05:30 HTTP+: #146:     --> 201   (1.1 ms)
10:21:42.999288 2016-09-13T10:21:42.999+05:30 Events+: Event queue worker sending event Document change event for doc id: 127 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:42.999298 2016-09-13T10:21:42.999+05:30 Events+: Event queue worker sending event Document change event for doc id: 127 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:42.999304 2016-09-13T10:21:42.999+05:30 Events+: Event queue worker sending event Document change event for doc id: 127 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:43.037977 2016-09-13T10:21:43.037+05:30 HTTP:  #147: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:43.038183 2016-09-13T10:21:43.038+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [188.631µs]
10:21:43.038213 2016-09-13T10:21:43.038+05:30 HTTP+: #147:     --> 200   (0.2 ms)
10:21:43.041624 2016-09-13T10:21:43.041+05:30 HTTP:  #148: POST /pttdata/_revs_diff  (ADMIN)
10:21:43.043211 2016-09-13T10:21:43.043+05:30 Bucket: Get("120") [1.330251ms]
10:21:43.043281 2016-09-13T10:21:43.043+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:43.043627 2016-09-13T10:21:43.043+05:30 Bucket: Get("115") [309.78µs]
10:21:43.043961 2016-09-13T10:21:43.043+05:30 Bucket: Get("116") [317.596µs]
10:21:43.045339 2016-09-13T10:21:43.045+05:30 Bucket: Get("117") [1.341142ms]
10:21:43.045362 2016-09-13T10:21:43.045+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:43.046582 2016-09-13T10:21:43.046+05:30 Bucket: Get("118") [1.200363ms]
10:21:43.046599 2016-09-13T10:21:43.046+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:43.046898 2016-09-13T10:21:43.046+05:30 Bucket: Get("119") [272.702µs]
10:21:43.046954 2016-09-13T10:21:43.046+05:30 HTTP+: #148:     --> 200   (5.3 ms)
10:21:43.050478 2016-09-13T10:21:43.050+05:30 HTTP:  #149: POST /pttdata/_bulk_docs  (ADMIN)
10:21:43.051928 2016-09-13T10:21:43.051+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.293892ms]
10:21:43.051975 2016-09-13T10:21:43.051+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:43.052322 2016-09-13T10:21:43.052+05:30 HTTP:  #150: GET /ptxdata/  (ADMIN)
10:21:43.052638 2016-09-13T10:21:43.052+05:30 Bucket: Incr("_sync:seq", 0, 0, 0) [289.093µs]
10:21:43.052722 2016-09-13T10:21:43.052+05:30 HTTP+: #150:     --> 200   (0.4 ms)
10:21:43.053348 2016-09-13T10:21:43.053+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.317336ms]
10:21:43.053377 2016-09-13T10:21:43.053+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:43.054704 2016-09-13T10:21:43.054+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.27725ms]
10:21:43.054724 2016-09-13T10:21:43.054+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:43.054756 2016-09-13T10:21:43.054+05:30 HTTP+: #149:     --> 201   (4.3 ms)
10:21:44.001663 2016-09-13T10:21:44.001+05:30 HTTP:  #151: PUT /pttdata/128  (ADMIN)
10:21:44.002030 2016-09-13T10:21:44.002+05:30 CRUD+: Invoking sync on doc "128" rev 1-98b084f3e4d2c12e9280ec3902b812bd
10:21:44.002276 2016-09-13T10:21:44.002+05:30 CRUD: 	Doc "128" in channels "{channel2-pool-1-thread-1-1}"
10:21:44.002359 2016-09-13T10:21:44.002+05:30 Cache: SAVING #92
10:21:44.002597 2016-09-13T10:21:44.002+05:30 Bucket: WriteUpdate("128", 0, ...) --> <nil> [810.915µs]
10:21:44.002652 2016-09-13T10:21:44.002+05:30 CRUD: Stored doc "128" / "1-98b084f3e4d2c12e9280ec3902b812bd"
10:21:44.002693 2016-09-13T10:21:44.002+05:30 HTTP+: #151:     --> 201   (1.1 ms)
10:21:44.002790 2016-09-13T10:21:44.002+05:30 Events+: Event queue worker sending event Document change event for doc id: 128 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:44.002799 2016-09-13T10:21:44.002+05:30 Events+: Event queue worker sending event Document change event for doc id: 128 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:44.002807 2016-09-13T10:21:44.002+05:30 Events+: Event queue worker sending event Document change event for doc id: 128 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:44.056054 2016-09-13T10:21:44.056+05:30 HTTP:  #152: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:44.056296 2016-09-13T10:21:44.056+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [212.741µs]
10:21:44.056345 2016-09-13T10:21:44.056+05:30 HTTP+: #152:     --> 200   (0.3 ms)
10:21:44.059870 2016-09-13T10:21:44.059+05:30 HTTP:  #153: POST /pttdata/_revs_diff  (ADMIN)
10:21:44.060420 2016-09-13T10:21:44.060+05:30 Bucket: Get("119") [296.424µs]
10:21:44.061800 2016-09-13T10:21:44.061+05:30 Bucket: Get("120") [1.351639ms]
10:21:44.061853 2016-09-13T10:21:44.061+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:44.062282 2016-09-13T10:21:44.062+05:30 Bucket: Get("115") [386.935µs]
10:21:44.062572 2016-09-13T10:21:44.062+05:30 Bucket: Get("116") [266.497µs]
10:21:44.063858 2016-09-13T10:21:44.063+05:30 Bucket: Get("117") [1.26715ms]
10:21:44.063885 2016-09-13T10:21:44.063+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:44.065124 2016-09-13T10:21:44.065+05:30 Bucket: Get("118") [1.211968ms]
10:21:44.065162 2016-09-13T10:21:44.065+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:44.065218 2016-09-13T10:21:44.065+05:30 HTTP+: #153:     --> 200   (5.4 ms)
10:21:44.068692 2016-09-13T10:21:44.068+05:30 HTTP:  #154: POST /pttdata/_bulk_docs  (ADMIN)
10:21:44.070116 2016-09-13T10:21:44.070+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.261073ms]
10:21:44.070173 2016-09-13T10:21:44.070+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:44.071528 2016-09-13T10:21:44.071+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.314397ms]
10:21:44.071556 2016-09-13T10:21:44.071+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:44.072868 2016-09-13T10:21:44.072+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.272936ms]
10:21:44.072886 2016-09-13T10:21:44.072+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:44.072915 2016-09-13T10:21:44.072+05:30 HTTP+: #154:     --> 201   (4.2 ms)
10:21:45.005395 2016-09-13T10:21:45.005+05:30 HTTP:  #155: PUT /pttdata/129  (ADMIN)
10:21:45.006782 2016-09-13T10:21:45.006+05:30 Bucket: WriteUpdate("129", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.289745ms]
10:21:45.006837 2016-09-13T10:21:45.006+05:30 HTTP: #155:     --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused  (1.4 ms)
10:21:45.074273 2016-09-13T10:21:45.074+05:30 HTTP:  #156: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:45.074495 2016-09-13T10:21:45.074+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [191.851µs]
10:21:45.074526 2016-09-13T10:21:45.074+05:30 HTTP+: #156:     --> 200   (0.3 ms)
10:21:45.078153 2016-09-13T10:21:45.078+05:30 HTTP:  #157: POST /pttdata/_revs_diff  (ADMIN)
10:21:45.079707 2016-09-13T10:21:45.079+05:30 Bucket: Get("118") [1.315518ms]
10:21:45.079757 2016-09-13T10:21:45.079+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:45.080160 2016-09-13T10:21:45.080+05:30 Bucket: Get("119") [361µs]
10:21:45.081396 2016-09-13T10:21:45.081+05:30 Bucket: Get("120") [1.219956ms]
10:21:45.081412 2016-09-13T10:21:45.081+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:45.081751 2016-09-13T10:21:45.081+05:30 Bucket: Get("115") [303.103µs]
10:21:45.082064 2016-09-13T10:21:45.082+05:30 Bucket: Get("116") [298.228µs]
10:21:45.083351 2016-09-13T10:21:45.083+05:30 Bucket: Get("117") [1.269948ms]
10:21:45.083381 2016-09-13T10:21:45.083+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:45.083463 2016-09-13T10:21:45.083+05:30 HTTP+: #157:     --> 200   (5.3 ms)
10:21:45.086952 2016-09-13T10:21:45.086+05:30 HTTP:  #158: POST /pttdata/_bulk_docs  (ADMIN)
10:21:45.088540 2016-09-13T10:21:45.088+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.283092ms]
10:21:45.088569 2016-09-13T10:21:45.088+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:45.089854 2016-09-13T10:21:45.089+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.250341ms]
10:21:45.089881 2016-09-13T10:21:45.089+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:45.091234 2016-09-13T10:21:45.091+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.302373ms]
10:21:45.091252 2016-09-13T10:21:45.091+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:45.091304 2016-09-13T10:21:45.091+05:30 HTTP+: #158:     --> 201   (4.4 ms)
10:21:46.009116 2016-09-13T10:21:46.009+05:30 HTTP:  #159: PUT /pttdata/130  (ADMIN)
10:21:46.010568 2016-09-13T10:21:46.010+05:30 Bucket: WriteUpdate("130", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.337186ms]
10:21:46.010651 2016-09-13T10:21:46.010+05:30 HTTP: #159:     --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused  (1.5 ms)
10:21:46.092588 2016-09-13T10:21:46.092+05:30 HTTP:  #160: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:46.092759 2016-09-13T10:21:46.092+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [153.569µs]
10:21:46.092801 2016-09-13T10:21:46.092+05:30 HTTP+: #160:     --> 200   (0.2 ms)
10:21:46.096532 2016-09-13T10:21:46.096+05:30 HTTP:  #161: POST /pttdata/_revs_diff  (ADMIN)
10:21:46.097109 2016-09-13T10:21:46.097+05:30 Bucket: Get("115") [298.679µs]
10:21:46.097382 2016-09-13T10:21:46.097+05:30 Bucket: Get("116") [257.13µs]
10:21:46.098700 2016-09-13T10:21:46.098+05:30 Bucket: Get("117") [1.301298ms]
10:21:46.098739 2016-09-13T10:21:46.098+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:46.100099 2016-09-13T10:21:46.100+05:30 Bucket: Get("118") [1.336856ms]
10:21:46.100129 2016-09-13T10:21:46.100+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:46.100528 2016-09-13T10:21:46.100+05:30 Bucket: Get("119") [335.523µs]
10:21:46.101881 2016-09-13T10:21:46.101+05:30 Bucket: Get("120") [1.324559ms]
10:21:46.101927 2016-09-13T10:21:46.101+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:46.102064 2016-09-13T10:21:46.102+05:30 HTTP+: #161:     --> 200   (5.5 ms)
10:21:46.105427 2016-09-13T10:21:46.105+05:30 HTTP:  #162: POST /pttdata/_bulk_docs  (ADMIN)
10:21:46.106860 2016-09-13T10:21:46.106+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.284078ms]
10:21:46.106889 2016-09-13T10:21:46.106+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:46.108277 2016-09-13T10:21:46.108+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.337535ms]
10:21:46.108317 2016-09-13T10:21:46.108+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:46.109600 2016-09-13T10:21:46.109+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.244372ms]
10:21:46.109627 2016-09-13T10:21:46.109+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:46.109669 2016-09-13T10:21:46.109+05:30 HTTP+: #162:     --> 201   (4.2 ms)
10:21:47.013228 2016-09-13T10:21:47.013+05:30 HTTP:  #163: PUT /pttdata/131  (ADMIN)
10:21:47.013604 2016-09-13T10:21:47.013+05:30 CRUD+: Invoking sync on doc "131" rev 1-eba3e101c075c8109bc017c2bfbad72f
10:21:47.013814 2016-09-13T10:21:47.013+05:30 CRUD: 	Doc "131" in channels "{channel2-pool-1-thread-1-1}"
10:21:47.013901 2016-09-13T10:21:47.013+05:30 Cache: SAVING #93
10:21:47.014079 2016-09-13T10:21:47.014+05:30 Bucket: WriteUpdate("131", 0, ...) --> <nil> [740.201µs]
10:21:47.014152 2016-09-13T10:21:47.014+05:30 CRUD: Stored doc "131" / "1-eba3e101c075c8109bc017c2bfbad72f"
10:21:47.014182 2016-09-13T10:21:47.014+05:30 HTTP+: #163:     --> 201   (1.0 ms)
10:21:47.014302 2016-09-13T10:21:47.014+05:30 Events+: Event queue worker sending event Document change event for doc id: 131 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:47.014324 2016-09-13T10:21:47.014+05:30 Events+: Event queue worker sending event Document change event for doc id: 131 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:47.014330 2016-09-13T10:21:47.014+05:30 Events+: Event queue worker sending event Document change event for doc id: 131 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:47.110911 2016-09-13T10:21:47.110+05:30 HTTP:  #164: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:47.111069 2016-09-13T10:21:47.111+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [139.736µs]
10:21:47.111099 2016-09-13T10:21:47.111+05:30 HTTP+: #164:     --> 200   (0.2 ms)
10:21:47.114545 2016-09-13T10:21:47.114+05:30 HTTP:  #165: POST /pttdata/_revs_diff  (ADMIN)
10:21:47.115159 2016-09-13T10:21:47.115+05:30 Bucket: Get("116") [272.24µs]
10:21:47.116461 2016-09-13T10:21:47.116+05:30 Bucket: Get("117") [1.27138ms]
10:21:47.116501 2016-09-13T10:21:47.116+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:47.117857 2016-09-13T10:21:47.117+05:30 Bucket: Get("118") [1.312008ms]
10:21:47.117901 2016-09-13T10:21:47.117+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:47.118217 2016-09-13T10:21:47.118+05:30 Bucket: Get("119") [280.916µs]
10:21:47.119559 2016-09-13T10:21:47.119+05:30 Bucket: Get("120") [1.324353ms]
10:21:47.119578 2016-09-13T10:21:47.119+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:47.119889 2016-09-13T10:21:47.119+05:30 Bucket: Get("115") [282.406µs]
10:21:47.119941 2016-09-13T10:21:47.119+05:30 HTTP+: #165:     --> 200   (5.4 ms)
10:21:47.123419 2016-09-13T10:21:47.123+05:30 HTTP:  #166: POST /pttdata/_bulk_docs  (ADMIN)
10:21:47.123906 2016-09-13T10:21:47.123+05:30 Bucket: Incr("_sync:seq", 3, 3, 0) [203.917µs]
10:21:47.125198 2016-09-13T10:21:47.125+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.23114ms]
10:21:47.125258 2016-09-13T10:21:47.125+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:47.126519 2016-09-13T10:21:47.126+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.223093ms]
10:21:47.126547 2016-09-13T10:21:47.126+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:47.127795 2016-09-13T10:21:47.127+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.222235ms]
10:21:47.127823 2016-09-13T10:21:47.127+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:47.127853 2016-09-13T10:21:47.127+05:30 HTTP+: #166:     --> 201   (4.5 ms)
10:21:48.036265 2016-09-13T10:21:48.036+05:30 HTTP:  #167: PUT /pttdata/132  (ADMIN)
10:21:48.036650 2016-09-13T10:21:48.036+05:30 CRUD+: Invoking sync on doc "132" rev 1-d94ed3b15165c56b395f70206fd2e079
10:21:48.036831 2016-09-13T10:21:48.036+05:30 CRUD: 	Doc "132" in channels "{channel2-pool-1-thread-1-1}"
10:21:48.036917 2016-09-13T10:21:48.036+05:30 Cache: SAVING #94
10:21:48.037136 2016-09-13T10:21:48.037+05:30 Bucket: WriteUpdate("132", 0, ...) --> <nil> [743.311µs]
10:21:48.037216 2016-09-13T10:21:48.037+05:30 CRUD: Stored doc "132" / "1-d94ed3b15165c56b395f70206fd2e079"
10:21:48.037288 2016-09-13T10:21:48.037+05:30 HTTP+: #167:     --> 201   (1.0 ms)
10:21:48.037435 2016-09-13T10:21:48.037+05:30 Events+: Event queue worker sending event Document change event for doc id: 132 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:48.037445 2016-09-13T10:21:48.037+05:30 Events+: Event queue worker sending event Document change event for doc id: 132 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:48.037451 2016-09-13T10:21:48.037+05:30 Events+: Event queue worker sending event Document change event for doc id: 132 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:48.129219 2016-09-13T10:21:48.129+05:30 HTTP:  #168: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:48.129539 2016-09-13T10:21:48.129+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [278.289µs]
10:21:48.129569 2016-09-13T10:21:48.129+05:30 HTTP+: #168:     --> 200   (0.4 ms)
10:21:48.132708 2016-09-13T10:21:48.132+05:30 HTTP:  #169: POST /pttdata/_revs_diff  (ADMIN)
10:21:48.133453 2016-09-13T10:21:48.133+05:30 Bucket: Get("115") [347.429µs]
10:21:48.133879 2016-09-13T10:21:48.133+05:30 Bucket: Get("116") [402.693µs]
10:21:48.135134 2016-09-13T10:21:48.135+05:30 Bucket: Get("117") [1.230406ms]
10:21:48.135174 2016-09-13T10:21:48.135+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:48.136391 2016-09-13T10:21:48.136+05:30 Bucket: Get("118") [1.181931ms]
10:21:48.136412 2016-09-13T10:21:48.136+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:48.136682 2016-09-13T10:21:48.136+05:30 Bucket: Get("119") [247.889µs]
10:21:48.137924 2016-09-13T10:21:48.137+05:30 Bucket: Get("120") [1.213302ms]
10:21:48.137952 2016-09-13T10:21:48.137+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:48.138007 2016-09-13T10:21:48.138+05:30 HTTP+: #169:     --> 200   (5.3 ms)
10:21:48.141872 2016-09-13T10:21:48.141+05:30 HTTP:  #170: POST /pttdata/_bulk_docs  (ADMIN)
10:21:48.143254 2016-09-13T10:21:48.143+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.226568ms]
10:21:48.143297 2016-09-13T10:21:48.143+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:48.144545 2016-09-13T10:21:48.144+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.222789ms]
10:21:48.144574 2016-09-13T10:21:48.144+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:48.145844 2016-09-13T10:21:48.145+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.234756ms]
10:21:48.145871 2016-09-13T10:21:48.145+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:48.145903 2016-09-13T10:21:48.145+05:30 HTTP+: #170:     --> 201   (4.1 ms)
10:21:49.039589 2016-09-13T10:21:49.039+05:30 HTTP:  #171: PUT /pttdata/133  (ADMIN)
10:21:49.041078 2016-09-13T10:21:49.041+05:30 Bucket: WriteUpdate("133", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.355355ms]
10:21:49.041129 2016-09-13T10:21:49.041+05:30 HTTP: #171:     --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused  (1.6 ms)
10:21:49.147194 2016-09-13T10:21:49.147+05:30 HTTP:  #172: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:49.147413 2016-09-13T10:21:49.147+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [199.218µs]
10:21:49.147454 2016-09-13T10:21:49.147+05:30 HTTP+: #172:     --> 200   (0.3 ms)
10:21:49.150939 2016-09-13T10:21:49.150+05:30 HTTP:  #173: POST /pttdata/_revs_diff  (ADMIN)
10:21:49.151587 2016-09-13T10:21:49.151+05:30 Bucket: Get("119") [321.798µs]
10:21:49.152903 2016-09-13T10:21:49.152+05:30 Bucket: Get("120") [1.295753ms]
10:21:49.152946 2016-09-13T10:21:49.152+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:49.153353 2016-09-13T10:21:49.153+05:30 Bucket: Get("115") [372.717µs]
10:21:49.153680 2016-09-13T10:21:49.153+05:30 Bucket: Get("116") [310.9µs]
10:21:49.154955 2016-09-13T10:21:49.154+05:30 Bucket: Get("117") [1.257028ms]
10:21:49.154988 2016-09-13T10:21:49.154+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:49.156279 2016-09-13T10:21:49.156+05:30 Bucket: Get("118") [1.259869ms]
10:21:49.156300 2016-09-13T10:21:49.156+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:49.156367 2016-09-13T10:21:49.156+05:30 HTTP+: #173:     --> 200   (5.4 ms)
10:21:49.159937 2016-09-13T10:21:49.159+05:30 HTTP:  #174: POST /pttdata/_bulk_docs  (ADMIN)
10:21:49.161304 2016-09-13T10:21:49.161+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.211016ms]
10:21:49.161326 2016-09-13T10:21:49.161+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:49.162549 2016-09-13T10:21:49.162+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.172463ms]
10:21:49.162581 2016-09-13T10:21:49.162+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:49.163871 2016-09-13T10:21:49.163+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.261598ms]
10:21:49.163891 2016-09-13T10:21:49.163+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:49.163977 2016-09-13T10:21:49.163+05:30 HTTP+: #174:     --> 201   (4.1 ms)
10:21:50.043599 2016-09-13T10:21:50.043+05:30 HTTP:  #175: PUT /pttdata/134  (ADMIN)
10:21:50.043973 2016-09-13T10:21:50.043+05:30 CRUD+: Invoking sync on doc "134" rev 1-d243de6306935e63509111742e0d0220
10:21:50.044165 2016-09-13T10:21:50.044+05:30 CRUD: 	Doc "134" in channels "{channel2-pool-1-thread-1-1}"
10:21:50.044246 2016-09-13T10:21:50.044+05:30 Cache: SAVING #95
10:21:50.044443 2016-09-13T10:21:50.044+05:30 Bucket: WriteUpdate("134", 0, ...) --> <nil> [726.209µs]
10:21:50.044499 2016-09-13T10:21:50.044+05:30 CRUD: Stored doc "134" / "1-d243de6306935e63509111742e0d0220"
10:21:50.044537 2016-09-13T10:21:50.044+05:30 HTTP+: #175:     --> 201   (1.0 ms)
10:21:50.044637 2016-09-13T10:21:50.044+05:30 Events+: Event queue worker sending event Document change event for doc id: 134 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:50.044645 2016-09-13T10:21:50.044+05:30 Events+: Event queue worker sending event Document change event for doc id: 134 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:50.044651 2016-09-13T10:21:50.044+05:30 Events+: Event queue worker sending event Document change event for doc id: 134 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:50.165243 2016-09-13T10:21:50.165+05:30 HTTP:  #176: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:50.165450 2016-09-13T10:21:50.165+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [188.341µs]
10:21:50.165480 2016-09-13T10:21:50.165+05:30 HTTP+: #176:     --> 200   (0.2 ms)
10:21:50.168915 2016-09-13T10:21:50.168+05:30 HTTP:  #177: POST /pttdata/_revs_diff  (ADMIN)
10:21:50.169566 2016-09-13T10:21:50.169+05:30 Bucket: Get("115") [360.598µs]
10:21:50.169949 2016-09-13T10:21:50.169+05:30 Bucket: Get("116") [366.242µs]
10:21:50.171312 2016-09-13T10:21:50.171+05:30 Bucket: Get("117") [1.332981ms]
10:21:50.171363 2016-09-13T10:21:50.171+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:50.172733 2016-09-13T10:21:50.172+05:30 Bucket: Get("118") [1.319799ms]
10:21:50.172766 2016-09-13T10:21:50.172+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:50.173119 2016-09-13T10:21:50.173+05:30 Bucket: Get("119") [320.945µs]
10:21:50.174482 2016-09-13T10:21:50.174+05:30 Bucket: Get("120") [1.333071ms]
10:21:50.174503 2016-09-13T10:21:50.174+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:50.174571 2016-09-13T10:21:50.174+05:30 HTTP+: #177:     --> 200   (5.7 ms)
10:21:50.177976 2016-09-13T10:21:50.177+05:30 HTTP:  #178: POST /pttdata/_bulk_docs  (ADMIN)
10:21:50.179412 2016-09-13T10:21:50.179+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.264087ms]
10:21:50.179445 2016-09-13T10:21:50.179+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:50.180748 2016-09-13T10:21:50.180+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.265815ms]
10:21:50.180788 2016-09-13T10:21:50.180+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:50.182183 2016-09-13T10:21:50.182+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.323945ms]
10:21:50.182212 2016-09-13T10:21:50.182+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:50.182253 2016-09-13T10:21:50.182+05:30 HTTP+: #178:     --> 201   (4.3 ms)
10:21:51.046709 2016-09-13T10:21:51.046+05:30 HTTP:  #179: PUT /pttdata/135  (ADMIN)
10:21:51.048089 2016-09-13T10:21:51.048+05:30 Bucket: WriteUpdate("135", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.290471ms]
10:21:51.048134 2016-09-13T10:21:51.048+05:30 HTTP: #179:     --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused  (1.4 ms)
10:21:51.183491 2016-09-13T10:21:51.183+05:30 HTTP:  #180: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:51.183671 2016-09-13T10:21:51.183+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [161.914µs]
10:21:51.183699 2016-09-13T10:21:51.183+05:30 HTTP+: #180:     --> 200   (0.2 ms)
10:21:51.187109 2016-09-13T10:21:51.187+05:30 HTTP:  #181: POST /pttdata/_revs_diff  (ADMIN)
10:21:51.187708 2016-09-13T10:21:51.187+05:30 Bucket: Get("115") [337.79µs]
10:21:51.188014 2016-09-13T10:21:51.188+05:30 Bucket: Get("116") [289.894µs]
10:21:51.189322 2016-09-13T10:21:51.189+05:30 Bucket: Get("117") [1.291149ms]
10:21:51.189367 2016-09-13T10:21:51.189+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:51.190703 2016-09-13T10:21:51.190+05:30 Bucket: Get("118") [1.315407ms]
10:21:51.190724 2016-09-13T10:21:51.190+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:51.191061 2016-09-13T10:21:51.191+05:30 Bucket: Get("119") [297.535µs]
10:21:51.192340 2016-09-13T10:21:51.192+05:30 Bucket: Get("120") [1.261727ms]
10:21:51.192381 2016-09-13T10:21:51.192+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:51.192448 2016-09-13T10:21:51.192+05:30 HTTP+: #181:     --> 200   (5.3 ms)
10:21:51.195817 2016-09-13T10:21:51.195+05:30 HTTP:  #182: POST /pttdata/_bulk_docs  (ADMIN)
10:21:51.197318 2016-09-13T10:21:51.197+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.335291ms]
10:21:51.197358 2016-09-13T10:21:51.197+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:51.198722 2016-09-13T10:21:51.198+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.325437ms]
10:21:51.198750 2016-09-13T10:21:51.198+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:51.200118 2016-09-13T10:21:51.200+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.318792ms]
10:21:51.200170 2016-09-13T10:21:51.200+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:51.200239 2016-09-13T10:21:51.200+05:30 HTTP+: #182:     --> 201   (4.4 ms)
10:21:52.051229 2016-09-13T10:21:52.051+05:30 HTTP:  #183: PUT /pttdata/136  (ADMIN)
10:21:52.052763 2016-09-13T10:21:52.052+05:30 Bucket: WriteUpdate("136", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.399876ms]
10:21:52.052830 2016-09-13T10:21:52.052+05:30 HTTP: #183:     --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused  (1.6 ms)
10:21:52.201674 2016-09-13T10:21:52.201+05:30 HTTP:  #184: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:52.201928 2016-09-13T10:21:52.201+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [223.213µs]
10:21:52.201968 2016-09-13T10:21:52.201+05:30 HTTP+: #184:     --> 200   (0.3 ms)
10:21:52.205601 2016-09-13T10:21:52.205+05:30 HTTP:  #185: POST /pttdata/_revs_diff  (ADMIN)
10:21:52.206200 2016-09-13T10:21:52.206+05:30 Bucket: Get("115") [303.648µs]
10:21:52.206481 2016-09-13T10:21:52.206+05:30 Bucket: Get("116") [264.464µs]
10:21:52.207853 2016-09-13T10:21:52.207+05:30 Bucket: Get("117") [1.343705ms]
10:21:52.207910 2016-09-13T10:21:52.207+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:52.209265 2016-09-13T10:21:52.209+05:30 Bucket: Get("118") [1.310268ms]
10:21:52.209314 2016-09-13T10:21:52.209+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:52.209695 2016-09-13T10:21:52.209+05:30 Bucket: Get("119") [347.699µs]
10:21:52.211007 2016-09-13T10:21:52.210+05:30 Bucket: Get("120") [1.289081ms]
10:21:52.211067 2016-09-13T10:21:52.211+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:52.211136 2016-09-13T10:21:52.211+05:30 HTTP+: #185:     --> 200   (5.6 ms)
10:21:52.216356 2016-09-13T10:21:52.216+05:30 HTTP:  #186: POST /pttdata/_bulk_docs  (ADMIN)
10:21:52.217857 2016-09-13T10:21:52.217+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.328567ms]
10:21:52.217875 2016-09-13T10:21:52.217+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:52.219116 2016-09-13T10:21:52.219+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.208193ms]
10:21:52.219134 2016-09-13T10:21:52.219+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:52.220453 2016-09-13T10:21:52.220+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.286595ms]
10:21:52.220484 2016-09-13T10:21:52.220+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:52.220559 2016-09-13T10:21:52.220+05:30 HTTP+: #186:     --> 201   (4.2 ms)
10:21:53.086725 2016-09-13T10:21:53.086+05:30 HTTP:  #187: PUT /pttdata/137  (ADMIN)
10:21:53.087073 2016-09-13T10:21:53.087+05:30 CRUD+: Invoking sync on doc "137" rev 1-57ff41b11696c07be2b8e3957d9c64a2
10:21:53.087268 2016-09-13T10:21:53.087+05:30 CRUD: 	Doc "137" in channels "{channel2-pool-1-thread-1-1}"
10:21:53.087350 2016-09-13T10:21:53.087+05:30 Cache: SAVING #96
10:21:53.087555 2016-09-13T10:21:53.087+05:30 Bucket: WriteUpdate("137", 0, ...) --> <nil> [742.285µs]
10:21:53.087609 2016-09-13T10:21:53.087+05:30 CRUD: Stored doc "137" / "1-57ff41b11696c07be2b8e3957d9c64a2"
10:21:53.087659 2016-09-13T10:21:53.087+05:30 HTTP+: #187:     --> 201   (0.9 ms)
10:21:53.087769 2016-09-13T10:21:53.087+05:30 Events+: Event queue worker sending event Document change event for doc id: 137 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:53.087778 2016-09-13T10:21:53.087+05:30 Events+: Event queue worker sending event Document change event for doc id: 137 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:53.087784 2016-09-13T10:21:53.087+05:30 Events+: Event queue worker sending event Document change event for doc id: 137 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:53.222020 2016-09-13T10:21:53.222+05:30 HTTP:  #188: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:53.222284 2016-09-13T10:21:53.222+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [192.463µs]
10:21:53.222317 2016-09-13T10:21:53.222+05:30 HTTP+: #188:     --> 200   (0.3 ms)
10:21:53.225880 2016-09-13T10:21:53.225+05:30 HTTP:  #189: POST /pttdata/_revs_diff  (ADMIN)
10:21:53.227457 2016-09-13T10:21:53.227+05:30 Bucket: Get("120") [1.266645ms]
10:21:53.227507 2016-09-13T10:21:53.227+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:53.227844 2016-09-13T10:21:53.227+05:30 Bucket: Get("115") [314.704µs]
10:21:53.228223 2016-09-13T10:21:53.228+05:30 Bucket: Get("116") [348.646µs]
10:21:53.229575 2016-09-13T10:21:53.229+05:30 Bucket: Get("117") [1.334973ms]
10:21:53.229631 2016-09-13T10:21:53.229+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:53.230851 2016-09-13T10:21:53.230+05:30 Bucket: Get("118") [1.200591ms]
10:21:53.230882 2016-09-13T10:21:53.230+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:53.231238 2016-09-13T10:21:53.231+05:30 Bucket: Get("119") [326.306µs]
10:21:53.231303 2016-09-13T10:21:53.231+05:30 HTTP+: #189:     --> 200   (5.4 ms)
10:21:53.234945 2016-09-13T10:21:53.234+05:30 HTTP:  #190: POST /pttdata/_bulk_docs  (ADMIN)
10:21:53.235242 2016-09-13T10:21:53.235+05:30 Bucket: Incr("_sync:seq", 3, 3, 0) [162.18µs]
10:21:53.236505 2016-09-13T10:21:53.236+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.224255ms]
10:21:53.236523 2016-09-13T10:21:53.236+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:53.237784 2016-09-13T10:21:53.237+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.234974ms]
10:21:53.237813 2016-09-13T10:21:53.237+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:53.239068 2016-09-13T10:21:53.239+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.232136ms]
10:21:53.239096 2016-09-13T10:21:53.239+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:53.239129 2016-09-13T10:21:53.239+05:30 HTTP+: #190:     --> 201   (4.2 ms)
10:21:54.089797 2016-09-13T10:21:54.089+05:30 HTTP:  #191: PUT /pttdata/138  (ADMIN)
10:21:54.090081 2016-09-13T10:21:54.090+05:30 CRUD+: Invoking sync on doc "138" rev 1-087bc93597d7ee313527c6a6bd3c222a
10:21:54.090285 2016-09-13T10:21:54.090+05:30 CRUD: 	Doc "138" in channels "{channel2-pool-1-thread-1-1}"
10:21:54.090377 2016-09-13T10:21:54.090+05:30 Cache: SAVING #97
10:21:54.090569 2016-09-13T10:21:54.090+05:30 Bucket: WriteUpdate("138", 0, ...) --> <nil> [682.413µs]
10:21:54.090612 2016-09-13T10:21:54.090+05:30 CRUD: Stored doc "138" / "1-087bc93597d7ee313527c6a6bd3c222a"
10:21:54.090661 2016-09-13T10:21:54.090+05:30 HTTP+: #191:     --> 201   (0.9 ms)
10:21:54.090747 2016-09-13T10:21:54.090+05:30 Events+: Event queue worker sending event Document change event for doc id: 138 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:54.090756 2016-09-13T10:21:54.090+05:30 Events+: Event queue worker sending event Document change event for doc id: 138 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:54.090761 2016-09-13T10:21:54.090+05:30 Events+: Event queue worker sending event Document change event for doc id: 138 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:54.240407 2016-09-13T10:21:54.240+05:30 HTTP:  #192: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:54.240599 2016-09-13T10:21:54.240+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [160.45µs]
10:21:54.240625 2016-09-13T10:21:54.240+05:30 HTTP+: #192:     --> 200   (0.2 ms)
10:21:54.256745 2016-09-13T10:21:54.256+05:30 HTTP:  #193: POST /pttdata/_revs_diff  (ADMIN)
10:21:54.257434 2016-09-13T10:21:54.257+05:30 Bucket: Get("115") [314.643µs]
10:21:54.257688 2016-09-13T10:21:54.257+05:30 Bucket: Get("116") [237.538µs]
10:21:54.259066 2016-09-13T10:21:54.259+05:30 Bucket: Get("117") [1.349892ms]
10:21:54.259118 2016-09-13T10:21:54.259+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:54.260429 2016-09-13T10:21:54.260+05:30 Bucket: Get("118") [1.238625ms]
10:21:54.260458 2016-09-13T10:21:54.260+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:54.260796 2016-09-13T10:21:54.260+05:30 Bucket: Get("119") [320.237µs]
10:21:54.262019 2016-09-13T10:21:54.262+05:30 Bucket: Get("120") [1.207952ms]
10:21:54.262037 2016-09-13T10:21:54.262+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:54.262091 2016-09-13T10:21:54.262+05:30 HTTP+: #193:     --> 200   (5.4 ms)
10:21:54.266423 2016-09-13T10:21:54.266+05:30 HTTP:  #194: POST /pttdata/_bulk_docs  (ADMIN)
10:21:54.267802 2016-09-13T10:21:54.267+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.226777ms]
10:21:54.267822 2016-09-13T10:21:54.267+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:54.269144 2016-09-13T10:21:54.269+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.285024ms]
10:21:54.269166 2016-09-13T10:21:54.269+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:54.270446 2016-09-13T10:21:54.270+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.241665ms]
10:21:54.270464 2016-09-13T10:21:54.270+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:54.270494 2016-09-13T10:21:54.270+05:30 HTTP+: #194:     --> 201   (4.1 ms)
10:21:55.092977 2016-09-13T10:21:55.092+05:30 HTTP:  #195: PUT /pttdata/139  (ADMIN)
10:21:55.093720 2016-09-13T10:21:55.093+05:30 CRUD+: Invoking sync on doc "139" rev 1-e90e2121b4d52a6b6ca3c2b417307b16
10:21:55.093913 2016-09-13T10:21:55.093+05:30 CRUD: 	Doc "139" in channels "{channel2-pool-1-thread-1-1}"
10:21:55.093995 2016-09-13T10:21:55.093+05:30 Cache: SAVING #98
10:21:55.094308 2016-09-13T10:21:55.094+05:30 Bucket: WriteUpdate("139", 0, ...) --> <nil> [1.100359ms]
10:21:55.094354 2016-09-13T10:21:55.094+05:30 CRUD: Stored doc "139" / "1-e90e2121b4d52a6b6ca3c2b417307b16"
10:21:55.094406 2016-09-13T10:21:55.094+05:30 HTTP+: #195:     --> 201   (1.4 ms)
10:21:55.094507 2016-09-13T10:21:55.094+05:30 Events+: Event queue worker sending event Document change event for doc id: 139 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:55.094529 2016-09-13T10:21:55.094+05:30 Events+: Event queue worker sending event Document change event for doc id: 139 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:55.094535 2016-09-13T10:21:55.094+05:30 Events+: Event queue worker sending event Document change event for doc id: 139 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:55.271814 2016-09-13T10:21:55.271+05:30 HTTP:  #196: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:55.271998 2016-09-13T10:21:55.271+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [165.232µs]
10:21:55.272024 2016-09-13T10:21:55.272+05:30 HTTP+: #196:     --> 200   (0.2 ms)
10:21:55.275422 2016-09-13T10:21:55.275+05:30 HTTP:  #197: POST /pttdata/_revs_diff  (ADMIN)
10:21:55.276168 2016-09-13T10:21:55.276+05:30 Bucket: Get("119") [337.03µs]
10:21:55.277458 2016-09-13T10:21:55.277+05:30 Bucket: Get("120") [1.272425ms]
10:21:55.277509 2016-09-13T10:21:55.277+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:55.277792 2016-09-13T10:21:55.277+05:30 Bucket: Get("115") [261.568µs]
10:21:55.278091 2016-09-13T10:21:55.278+05:30 Bucket: Get("116") [283.244µs]
10:21:55.279324 2016-09-13T10:21:55.279+05:30 Bucket: Get("117") [1.2171ms]
10:21:55.279345 2016-09-13T10:21:55.279+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:55.280658 2016-09-13T10:21:55.280+05:30 Bucket: Get("118") [1.287384ms]
10:21:55.280703 2016-09-13T10:21:55.280+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:55.280835 2016-09-13T10:21:55.280+05:30 HTTP+: #197:     --> 200   (5.4 ms)
10:21:55.283989 2016-09-13T10:21:55.283+05:30 HTTP:  #198: POST /pttdata/_bulk_docs  (ADMIN)
10:21:55.285462 2016-09-13T10:21:55.285+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.318066ms]
10:21:55.285508 2016-09-13T10:21:55.285+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:55.286869 2016-09-13T10:21:55.286+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.308311ms]
10:21:55.286886 2016-09-13T10:21:55.286+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:55.288170 2016-09-13T10:21:55.288+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.248338ms]
10:21:55.288189 2016-09-13T10:21:55.288+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:55.288221 2016-09-13T10:21:55.288+05:30 HTTP+: #198:     --> 201   (4.2 ms)
10:21:56.096524 2016-09-13T10:21:56.096+05:30 HTTP:  #199: PUT /pttdata/140  (ADMIN)
10:21:56.096912 2016-09-13T10:21:56.096+05:30 CRUD+: Invoking sync on doc "140" rev 1-a965cbc91458f3e58d911230954a665b
10:21:56.097097 2016-09-13T10:21:56.097+05:30 CRUD: 	Doc "140" in channels "{channel2-pool-1-thread-1-1}"
10:21:56.097198 2016-09-13T10:21:56.097+05:30 Cache: SAVING #99
10:21:56.097414 2016-09-13T10:21:56.097+05:30 Bucket: WriteUpdate("140", 0, ...) --> <nil> [766.884µs]
10:21:56.097467 2016-09-13T10:21:56.097+05:30 CRUD: Stored doc "140" / "1-a965cbc91458f3e58d911230954a665b"
10:21:56.097511 2016-09-13T10:21:56.097+05:30 HTTP+: #199:     --> 201   (1.0 ms)
10:21:56.097608 2016-09-13T10:21:56.097+05:30 Events+: Event queue worker sending event Document change event for doc id: 140 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Presence]
10:21:56.097616 2016-09-13T10:21:56.097+05:30 Events+: Event queue worker sending event Document change event for doc id: 140 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/Location]
10:21:56.097622 2016-09-13T10:21:56.097+05:30 Events+: Event queue worker sending event Document change event for doc id: 140 to: Webhook handler [http://prod-C1-AMS-V1.service.kodiakptt.com:8080/kodiakams/changesFeed/eXDM]
10:21:56.289447 2016-09-13T10:21:56.289+05:30 HTTP:  #200: GET /pttdata/_local/1848934e156c210fcc71803c0f68680a590a2b73  (ADMIN)
10:21:56.289609 2016-09-13T10:21:56.289+05:30 Bucket: Get("_sync:local:1848934e156c210fcc71803c0f68680a590a2b73") [141.787µs]
10:21:56.289649 2016-09-13T10:21:56.289+05:30 HTTP+: #200:     --> 200   (0.2 ms)
10:21:56.293299 2016-09-13T10:21:56.293+05:30 HTTP:  #201: POST /pttdata/_revs_diff  (ADMIN)
10:21:56.293892 2016-09-13T10:21:56.293+05:30 Bucket: Get("116") [290.992µs]
10:21:56.295205 2016-09-13T10:21:56.295+05:30 Bucket: Get("117") [1.282755ms]
10:21:56.295261 2016-09-13T10:21:56.295+05:30 WARNING: RevDiff("117") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:56.296553 2016-09-13T10:21:56.296+05:30 Bucket: Get("118") [1.244478ms]
10:21:56.296587 2016-09-13T10:21:56.296+05:30 WARNING: RevDiff("118") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:56.296888 2016-09-13T10:21:56.296+05:30 Bucket: Get("119") [271.833µs]
10:21:56.298163 2016-09-13T10:21:56.298+05:30 Bucket: Get("120") [1.240762ms]
10:21:56.298184 2016-09-13T10:21:56.298+05:30 WARNING: RevDiff("120") --> *net.OpError dial tcp 10.2.0.202:11210: getsockopt: connection refused -- db.(*Database).RevDiff() at crud.go:1025
10:21:56.298544 2016-09-13T10:21:56.298+05:30 Bucket: Get("115") [338.042µs]
10:21:56.298601 2016-09-13T10:21:56.298+05:30 HTTP+: #201:     --> 200   (5.3 ms)
10:21:56.302233 2016-09-13T10:21:56.302+05:30 HTTP:  #202: POST /pttdata/_bulk_docs  (ADMIN)
10:21:56.302636 2016-09-13T10:21:56.302+05:30 Bucket: Incr("_sync:seq", 3, 3, 0) [257.239µs]
10:21:56.303932 2016-09-13T10:21:56.303+05:30 Bucket: WriteUpdate("117", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.24666ms]
10:21:56.303970 2016-09-13T10:21:56.303+05:30 	BulkDocs: Doc "117" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:56.305282 2016-09-13T10:21:56.305+05:30 Bucket: WriteUpdate("118", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.261952ms]
10:21:56.305301 2016-09-13T10:21:56.305+05:30 	BulkDocs: Doc "118" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:56.306603 2016-09-13T10:21:56.306+05:30 Bucket: WriteUpdate("120", 0, ...) --> dial tcp 10.2.0.202:11210: getsockopt: connection refused [1.265388ms]
10:21:56.306637 2016-09-13T10:21:56.306+05:30 	BulkDocs: Doc "120" --> 500 Internal error: dial tcp 10.2.0.202:11210: getsockopt: connection refused (dial tcp 10.2.0.202:11210: getsockopt: connection refused)
10:21:56.306668 2016-09-13T10:21:56.306+05:30 HTTP+: #202:     --> 201   (4.5 ms)
10:21:57.099709 2016-09-13T10:21:57.099+05:30 HTTP:  #203: PUT /pttdata/141  (ADMIN)