Skip to content

Instantly share code, notes, and snippets.

@johnou
Created April 6, 2018 14:42
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save johnou/b7076ea5e213120f922f4e317a3eb5c4 to your computer and use it in GitHub Desktop.
Save johnou/b7076ea5e213120f922f4e317a3eb5c4 to your computer and use it in GitHub Desktop.
io.atomix.core.tree.impl.DocumentTreeTest#testNotifications
16:40:15.161 [Time-limited test] WARN i.a.m.impl.NettyMessagingService - Disabling TLS for intra-cluster messaging; Could not load cluster key store: ../config/atomix.jks (No such file or directory)
16:40:15.179 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615128, session=5004, node=12, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=35, hash=-2058303996}}}, ExecuteOperation{index=2, timestamp=1523025615133, session=5004, node=12, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=39, hash=1197501253}}}, ExecuteOperation{index=3, timestamp=1523025615142, session=5004, node=12, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=39, hash=743356487}}}, ExecuteOperation{index=4, timestamp=1523025615144, session=5004, node=12, operation=PrimitiveOperation{id=DefaultOperationId{id=CLEAR, type=COMMAND}, value=byte[]{length=0, hash=1}}}]} to 2
16:40:15.184 [raft-client-system-partition-1-1] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-1}{type=DOCUMENT_TREE, name=4062affa-d1cc-4833-b38c-ec508e705846} - Term changed: PrimaryTerm{term=2, primary=Member{nodeId=3, groupId=3}, candidates=[Member{nodeId=3, groupId=3}, Member{nodeId=2, groupId=2}]}
16:40:15.184 [raft-client-system-partition-1-1] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-1}{type=DOCUMENT_TREE, name=4062affa-d1cc-4833-b38c-ec508e705846} - 2 transitioning to BACKUP
16:40:15.184 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615128, session=5004, node=12, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=35, hash=-2058303996}}}, ExecuteOperation{index=2, timestamp=1523025615133, session=5004, node=12, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=39, hash=1197501253}}}, ExecuteOperation{index=3, timestamp=1523025615142, session=5004, node=12, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=39, hash=743356487}}}, ExecuteOperation{index=4, timestamp=1523025615144, session=5004, node=12, operation=PrimitiveOperation{id=DefaultOperationId{id=CLEAR, type=COMMAND}, value=byte[]{length=0, hash=1}}}]}
16:40:15.184 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:15.184 [netty-messaging-event-epoll-server-0] INFO i.a.m.impl.NettyMessagingService - localhost/127.0.0.1 accepting incoming connections on port 5013
16:40:15.185 [netty-messaging-event-epoll-server-0] INFO i.a.m.impl.NettyMessagingService - Started
16:40:15.195 [atomix-0] INFO i.a.c.i.DefaultCoreMetadataService - Started
16:40:15.200 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615149, session=5005, node=12, operation=PrimitiveOperation{id=DefaultOperationId{id=CLEAR, type=COMMAND}, value=byte[]{length=0, hash=1}}}]} to 3
16:40:15.200 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615149, session=5006, node=12, operation=PrimitiveOperation{id=DefaultOperationId{id=CLEAR, type=COMMAND}, value=byte[]{length=0, hash=1}}}]} to 2
16:40:15.200 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615149, session=5006, node=12, operation=PrimitiveOperation{id=DefaultOperationId{id=CLEAR, type=COMMAND}, value=byte[]{length=0, hash=1}}}]} to 3
16:40:15.204 [atomix-0] INFO i.a.c.impl.DefaultClusterService - Started
16:40:15.204 [atomix-0] INFO i.a.c.m.i.DefaultClusterMessagingService - Started
16:40:15.205 [raft-client-system-partition-1-1] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-2}{type=DOCUMENT_TREE, name=4062affa-d1cc-4833-b38c-ec508e705846} - Term changed: PrimaryTerm{term=1, primary=Member{nodeId=1, groupId=1}, candidates=[Member{nodeId=1, groupId=1}, Member{nodeId=2, groupId=2}, Member{nodeId=3, groupId=3}]}
16:40:15.205 [raft-client-system-partition-1-2] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-2}{type=DOCUMENT_TREE, name=4062affa-d1cc-4833-b38c-ec508e705846} - Term changed: PrimaryTerm{term=1, primary=Member{nodeId=1, groupId=1}, candidates=[Member{nodeId=1, groupId=1}, Member{nodeId=2, groupId=2}, Member{nodeId=3, groupId=3}]}
16:40:15.205 [raft-client-system-partition-1-1] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-2}{type=DOCUMENT_TREE, name=4062affa-d1cc-4833-b38c-ec508e705846} - 3 transitioning to BACKUP
16:40:15.205 [raft-client-system-partition-1-2] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-2}{type=DOCUMENT_TREE, name=4062affa-d1cc-4833-b38c-ec508e705846} - 2 transitioning to BACKUP
16:40:15.205 [raft-client-system-partition-1-1] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-3}{type=DOCUMENT_TREE, name=4062affa-d1cc-4833-b38c-ec508e705846} - Term changed: PrimaryTerm{term=2, primary=Member{nodeId=2, groupId=2}, candidates=[Member{nodeId=2, groupId=2}, Member{nodeId=3, groupId=3}]}
16:40:15.205 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615149, session=5006, node=12, operation=PrimitiveOperation{id=DefaultOperationId{id=CLEAR, type=COMMAND}, value=byte[]{length=0, hash=1}}}]}
16:40:15.205 [raft-client-system-partition-1-1] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-3}{type=DOCUMENT_TREE, name=4062affa-d1cc-4833-b38c-ec508e705846} - 3 transitioning to BACKUP
16:40:15.205 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:15.205 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615149, session=5006, node=12, operation=PrimitiveOperation{id=DefaultOperationId{id=CLEAR, type=COMMAND}, value=byte[]{length=0, hash=1}}}]}
16:40:15.206 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:15.206 [atomix-data-0] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615149, session=5005, node=12, operation=PrimitiveOperation{id=DefaultOperationId{id=CLEAR, type=COMMAND}, value=byte[]{length=0, hash=1}}}]}
16:40:15.206 [atomix-data-0] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:15.208 [atomix-0] INFO i.a.c.m.i.DefaultClusterEventingService - Started
16:40:15.215 [raft-client-system-partition-1-0] INFO i.a.p.r.p.impl.RaftPartitionClient - Successfully started client for partition PartitionId{id=1, group=system}
16:40:15.215 [raft-client-system-partition-1-0] INFO i.a.p.r.partition.RaftPartitionGroup - Started
16:40:15.330 [atomix-0] INFO i.a.p.b.p.i.PrimaryBackupPartitionClient - Successfully started client for PartitionId{id=1, group=data}
16:40:15.330 [atomix-0] INFO i.a.p.b.p.i.PrimaryBackupPartitionClient - Successfully started client for PartitionId{id=3, group=data}
16:40:15.331 [atomix-0] INFO i.a.p.b.p.i.PrimaryBackupPartitionClient - Successfully started client for PartitionId{id=2, group=data}
16:40:15.331 [atomix-0] INFO i.a.p.b.p.PrimaryBackupPartitionGroup - Started
16:40:15.333 [raft-client-core-partition-3-0] INFO i.a.p.r.p.impl.RaftPartitionClient - Successfully started client for partition PartitionId{id=3, group=core}
16:40:15.337 [raft-client-core-partition-2-0] INFO i.a.p.r.p.impl.RaftPartitionClient - Successfully started client for partition PartitionId{id=2, group=core}
16:40:15.337 [raft-client-core-partition-1-0] INFO i.a.p.r.p.impl.RaftPartitionClient - Successfully started client for partition PartitionId{id=1, group=core}
16:40:15.338 [raft-client-core-partition-1-0] INFO i.a.p.r.partition.RaftPartitionGroup - Started
16:40:15.338 [raft-client-core-partition-1-0] INFO i.a.p.p.impl.DefaultPartitionService - Started
16:40:15.384 [atomix-0] INFO io.atomix.core.Atomix - Started
16:40:15.413 [atomix-data-1] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Sending ExecuteRequest{session=6004, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=ADD_LISTENER, type=COMMAND}, value=byte[]{length=15, hash=1090526897}}} to Member{nodeId=3, groupId=3}
16:40:15.416 [atomix-data-3] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-2}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Sending ExecuteRequest{session=6006, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=ADD_LISTENER, type=COMMAND}, value=byte[]{length=15, hash=1090526897}}} to Member{nodeId=1, groupId=1}
16:40:15.417 [atomix-data-2] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-3}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Sending ExecuteRequest{session=6005, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=ADD_LISTENER, type=COMMAND}, value=byte[]{length=15, hash=1090526897}}} to Member{nodeId=2, groupId=2}
16:40:15.421 [raft-client-system-partition-1-7] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-2}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Term changed: PrimaryTerm{term=1, primary=Member{nodeId=1, groupId=1}, candidates=[Member{nodeId=1, groupId=1}, Member{nodeId=2, groupId=2}, Member{nodeId=3, groupId=3}]}
16:40:15.421 [raft-client-system-partition-1-7] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-2}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - 1 transitioning to PRIMARY
16:40:15.422 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Received ExecuteRequest{session=6006, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=ADD_LISTENER, type=COMMAND}, value=byte[]{length=15, hash=1090526897}}}
16:40:15.422 [raft-client-system-partition-1-0] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Term changed: PrimaryTerm{term=2, primary=Member{nodeId=3, groupId=3}, candidates=[Member{nodeId=3, groupId=3}, Member{nodeId=2, groupId=2}]}
16:40:15.422 [raft-client-system-partition-1-0] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - 3 transitioning to PRIMARY
16:40:15.422 [atomix-data-10] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Received ExecuteRequest{session=6004, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=ADD_LISTENER, type=COMMAND}, value=byte[]{length=15, hash=1090526897}}}
16:40:15.433 [atomix-data-10] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending ExecuteResponse{status=OK, result=byte[]{length=0, hash=1}}
16:40:15.433 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending ExecuteResponse{status=OK, result=byte[]{length=0, hash=1}}
16:40:15.437 [raft-client-system-partition-1-6] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-3}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Term changed: PrimaryTerm{term=2, primary=Member{nodeId=2, groupId=2}, candidates=[Member{nodeId=2, groupId=2}, Member{nodeId=3, groupId=3}]}
16:40:15.437 [raft-client-system-partition-1-6] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-3}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - 2 transitioning to PRIMARY
16:40:15.438 [atomix-data-4] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Received ExecuteRequest{session=6005, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=ADD_LISTENER, type=COMMAND}, value=byte[]{length=15, hash=1090526897}}}
16:40:15.439 [atomix-data-4] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending ExecuteResponse{status=OK, result=byte[]{length=0, hash=1}}
16:40:15.446 [atomix-data-7] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Received ExecuteResponse{status=OK, result=byte[]{length=0, hash=1}}
16:40:15.464 [atomix-data-8] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-2}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Received ExecuteResponse{status=OK, result=byte[]{length=0, hash=1}}
16:40:15.465 [atomix-data-9] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-3}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Received ExecuteResponse{status=OK, result=byte[]{length=0, hash=1}}
16:40:15.470 [atomix-data-9] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Sending ExecuteRequest{session=6004, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=32, hash=-1073702780}}} to Member{nodeId=3, groupId=3}
16:40:15.470 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Received ExecuteRequest{session=6004, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=32, hash=-1073702780}}}
16:40:15.472 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615422, session=6006, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=ADD_LISTENER, type=COMMAND}, value=byte[]{length=15, hash=1090526897}}}]} to 2
16:40:15.472 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending ExecuteResponse{status=OK, result=byte[]{length=22, hash=161401059}}
16:40:15.472 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615422, session=6006, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=ADD_LISTENER, type=COMMAND}, value=byte[]{length=15, hash=1090526897}}}]} to 3
16:40:15.472 [atomix-data-8] TRACE i.a.p.b.impl.PrimaryBackupSession - PrimaryBackupSession{data-partition-1}{session=6004} - Sending PrimitiveEvent{type=change, value=byte[]{length=44, hash=-967088608}} to 13
16:40:15.474 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=2, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615423, session=6004, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=ADD_LISTENER, type=COMMAND}, value=byte[]{length=15, hash=1090526897}}}, ExecuteOperation{index=2, timestamp=1523025615471, session=6004, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=32, hash=-1073702780}}}]} to 2
16:40:15.476 [atomix-data-11] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Received ExecuteResponse{status=OK, result=byte[]{length=22, hash=161401059}}
16:40:15.477 [atomix-data-11] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Received PrimitiveEvent{type=change, value=byte[]{length=44, hash=-967088608}}
16:40:15.478 [raft-client-system-partition-1-3] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-2}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Term changed: PrimaryTerm{term=1, primary=Member{nodeId=1, groupId=1}, candidates=[Member{nodeId=1, groupId=1}, Member{nodeId=2, groupId=2}, Member{nodeId=3, groupId=3}]}
16:40:15.478 [raft-client-system-partition-1-6] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-2}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Term changed: PrimaryTerm{term=1, primary=Member{nodeId=1, groupId=1}, candidates=[Member{nodeId=1, groupId=1}, Member{nodeId=2, groupId=2}, Member{nodeId=3, groupId=3}]}
16:40:15.478 [raft-client-system-partition-1-6] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-2}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - 2 transitioning to BACKUP
16:40:15.478 [raft-client-system-partition-1-3] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-2}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - 3 transitioning to BACKUP
16:40:15.478 [raft-client-system-partition-1-6] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Term changed: PrimaryTerm{term=2, primary=Member{nodeId=3, groupId=3}, candidates=[Member{nodeId=3, groupId=3}, Member{nodeId=2, groupId=2}]}
16:40:15.478 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615422, session=6006, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=ADD_LISTENER, type=COMMAND}, value=byte[]{length=15, hash=1090526897}}}]}
16:40:15.478 [raft-client-system-partition-1-6] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - 2 transitioning to BACKUP
16:40:15.478 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:15.478 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615422, session=6006, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=ADD_LISTENER, type=COMMAND}, value=byte[]{length=15, hash=1090526897}}}]}
16:40:15.479 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=2, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615423, session=6004, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=ADD_LISTENER, type=COMMAND}, value=byte[]{length=15, hash=1090526897}}}, ExecuteOperation{index=2, timestamp=1523025615471, session=6004, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=32, hash=-1073702780}}}]}
16:40:15.479 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:15.479 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:15.483 [atomix-data-12] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Sending ExecuteRequest{session=6004, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=34, hash=355626240}}} to Member{nodeId=3, groupId=3}
16:40:15.483 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Received ExecuteRequest{session=6004, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=34, hash=355626240}}}
16:40:15.484 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending ExecuteResponse{status=OK, result=byte[]{length=24, hash=-843218425}}
16:40:15.485 [atomix-data-0] TRACE i.a.p.b.impl.PrimaryBackupSession - PrimaryBackupSession{data-partition-1}{session=6004} - Sending PrimitiveEvent{type=change, value=byte[]{length=62, hash=-1252480918}} to 13
16:40:15.485 [atomix-data-1] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Received ExecuteResponse{status=OK, result=byte[]{length=24, hash=-843218425}}
16:40:15.485 [atomix-data-3] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Received PrimitiveEvent{type=change, value=byte[]{length=62, hash=-1252480918}}
16:40:15.485 [atomix-data-2] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Sending ExecuteRequest{session=6004, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=28, hash=-383421429}}} to Member{nodeId=3, groupId=3}
16:40:15.486 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Received ExecuteRequest{session=6004, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=28, hash=-383421429}}}
16:40:15.486 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending ExecuteResponse{status=OK, result=byte[]{length=24, hash=-843218425}}
16:40:15.486 [atomix-data-3] TRACE i.a.p.b.impl.PrimaryBackupSession - PrimaryBackupSession{data-partition-1}{session=6004} - Sending PrimitiveEvent{type=change, value=byte[]{length=46, hash=1829967366}} to 13
16:40:15.486 [atomix-data-14] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Received ExecuteResponse{status=OK, result=byte[]{length=24, hash=-843218425}}
16:40:15.487 [atomix-data-14] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Received PrimitiveEvent{type=change, value=byte[]{length=46, hash=1829967366}}
16:40:15.487 [atomix-data-6] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Sending ExecuteRequest{session=6004, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=39, hash=-316633389}}} to Member{nodeId=3, groupId=3}
16:40:15.487 [atomix-data-9] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Received ExecuteRequest{session=6004, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=39, hash=-316633389}}}
16:40:15.487 [atomix-data-9] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending ExecuteResponse{status=OK, result=byte[]{length=6, hash=1693438466}}
16:40:15.488 [atomix-data-15] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Received ExecuteResponse{status=OK, result=byte[]{length=6, hash=1693438466}}
16:40:15.488 [atomix-data-1] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615438, session=6005, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=ADD_LISTENER, type=COMMAND}, value=byte[]{length=15, hash=1090526897}}}]} to 3
16:40:15.488 [atomix-data-15] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Sending ExecuteRequest{session=6004, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=29, hash=821211944}}} to Member{nodeId=3, groupId=3}
16:40:15.488 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Received ExecuteRequest{session=6004, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=29, hash=821211944}}}
16:40:15.488 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending ExecuteResponse{status=OK, result=byte[]{length=16, hash=-382316903}}
16:40:15.489 [atomix-data-7] TRACE i.a.p.b.impl.PrimaryBackupSession - PrimaryBackupSession{data-partition-1}{session=6004} - Sending PrimitiveEvent{type=change, value=byte[]{length=38, hash=-1831647507}} to 13
16:40:15.489 [atomix-data-8] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Received ExecuteResponse{status=OK, result=byte[]{length=16, hash=-382316903}}
16:40:15.489 [atomix-data-8] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Sending ExecuteRequest{session=6004, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=39, hash=-316633389}}} to Member{nodeId=3, groupId=3}
16:40:15.490 [atomix-data-8] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Received PrimitiveEvent{type=change, value=byte[]{length=38, hash=-1831647507}}
16:40:15.490 [atomix-data-5] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Received ExecuteRequest{session=6004, node=13, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=39, hash=-316633389}}}
16:40:15.491 [atomix-data-5] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending ExecuteResponse{status=OK, result=byte[]{length=22, hash=-424586144}}
16:40:15.491 [atomix-data-5] TRACE i.a.p.b.impl.PrimaryBackupSession - PrimaryBackupSession{data-partition-1}{session=6004} - Sending PrimitiveEvent{type=change, value=byte[]{length=48, hash=-528033910}} to 13
16:40:15.492 [atomix-data-10] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Received PrimitiveEvent{type=change, value=byte[]{length=48, hash=-528033910}}
16:40:15.492 [raft-client-system-partition-1-5] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-3}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Term changed: PrimaryTerm{term=2, primary=Member{nodeId=2, groupId=2}, candidates=[Member{nodeId=2, groupId=2}, Member{nodeId=3, groupId=3}]}
16:40:15.492 [raft-client-system-partition-1-5] DEBUG i.a.p.b.s.i.PrimaryBackupServiceContext - PrimitiveService{data-partition-3}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - 3 transitioning to BACKUP
16:40:15.492 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=1, timestamp=1523025615438, session=6005, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=ADD_LISTENER, type=COMMAND}, value=byte[]{length=15, hash=1090526897}}}]}
16:40:15.492 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:15.492 [atomix-data-11] TRACE i.a.p.b.proxy.PrimaryBackupProxy - PrimitiveProxy{data-partition-1}{type=DOCUMENT_TREE, name=b0c35332-1577-4d14-bf8b-4e9bba587b76} - Received ExecuteResponse{status=OK, result=byte[]{length=22, hash=-424586144}}
16:40:15.623 [atomix-data-11] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=3, timestamp=1523025615483, session=6004, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=34, hash=355626240}}}, ExecuteOperation{index=4, timestamp=1523025615486, session=6004, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=28, hash=-383421429}}}, ExecuteOperation{index=5, timestamp=1523025615487, session=6004, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=39, hash=-316633389}}}, ExecuteOperation{index=6, timestamp=1523025615488, session=6004, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=29, hash=821211944}}}, ExecuteOperation{index=7, timestamp=1523025615490, session=6004, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=39, hash=-316633389}}}]} to 2
16:40:15.623 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[ExecuteOperation{index=3, timestamp=1523025615483, session=6004, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=34, hash=355626240}}}, ExecuteOperation{index=4, timestamp=1523025615486, session=6004, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=28, hash=-383421429}}}, ExecuteOperation{index=5, timestamp=1523025615487, session=6004, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=39, hash=-316633389}}}, ExecuteOperation{index=6, timestamp=1523025615488, session=6004, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=29, hash=821211944}}}, ExecuteOperation{index=7, timestamp=1523025615490, session=6004, node=13, operation=PrimitiveOperation{id=DefaultOperationId{id=UPDATE, type=COMMAND}, value=byte[]{length=39, hash=-316633389}}}]}
16:40:15.624 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:15.638 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025615631}]} to 2
16:40:15.639 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025615631}]}
16:40:15.639 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:15.835 [atomix-data-1] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025615835}]} to 2
16:40:15.837 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025615835}]}
16:40:15.837 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:15.865 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025615862}]} to 2
16:40:15.865 [atomix-data-14] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025615863}]} to 3
16:40:15.865 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025615863}]}
16:40:15.865 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:15.866 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025615862}]} to 3
16:40:15.866 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025615862}]}
16:40:15.866 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025615862}]}
16:40:15.866 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:15.866 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:16.129 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025616128}]} to 2
16:40:16.129 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025616128}]}
16:40:16.129 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:16.150 [atomix-data-5] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025616149}]} to 3
16:40:16.150 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025616149}]} to 2
16:40:16.150 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025616149}]} to 3
16:40:16.150 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025616149}]}
16:40:16.150 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025616149}]}
16:40:16.150 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025616149}]}
16:40:16.150 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:16.150 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:16.150 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:16.422 [atomix-data-11] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025616421}]} to 2
16:40:16.422 [atomix-data-11] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025616421}]} to 3
16:40:16.422 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025616421}]}
16:40:16.422 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:16.422 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025616421}]}
16:40:16.422 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:16.423 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025616422}]} to 2
16:40:16.423 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025616422}]}
16:40:16.423 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:16.438 [atomix-data-15] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025616438}]} to 3
16:40:16.438 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=2, timestamp=1523025616438}]}
16:40:16.438 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:16.638 [atomix-data-12] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025616631}]} to 2
16:40:16.638 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025616631}]}
16:40:16.638 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:16.835 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025616835}]} to 2
16:40:16.836 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025616835}]}
16:40:16.836 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:16.864 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025616861}]} to 2
16:40:16.865 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025616861}]}
16:40:16.865 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:16.865 [atomix-data-11] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025616863}]} to 3
16:40:16.865 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025616863}]}
16:40:16.865 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:16.866 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025616861}]} to 3
16:40:16.866 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025616861}]}
16:40:16.866 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:17.129 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025617128}]} to 2
16:40:17.129 [atomix-data-0] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025617128}]}
16:40:17.129 [atomix-data-0] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:17.150 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025617149}]} to 2
16:40:17.150 [atomix-data-5] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025617149}]} to 3
16:40:17.150 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025617149}]} to 3
16:40:17.150 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025617149}]}
16:40:17.150 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025617149}]}
16:40:17.150 [atomix-data-0] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025617149}]}
16:40:17.150 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:17.150 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:17.150 [atomix-data-0] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:17.422 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025617422}]} to 2
16:40:17.423 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025617422}]} to 3
16:40:17.423 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025617422}]}
16:40:17.423 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:17.423 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025617422}]} to 2
16:40:17.424 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025617422}]}
16:40:17.424 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:17.424 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025617422}]}
16:40:17.424 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:17.438 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025617438}]} to 3
16:40:17.439 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=3, timestamp=1523025617438}]}
16:40:17.439 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:17.638 [atomix-data-5] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025617631}]} to 2
16:40:17.638 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025617631}]}
16:40:17.638 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:17.835 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025617835}]} to 2
16:40:17.835 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025617835}]}
16:40:17.835 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:17.864 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025617861}]} to 2
16:40:17.865 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025617861}]}
16:40:17.865 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:17.865 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025617863}]} to 3
16:40:17.865 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025617863}]}
16:40:17.865 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:17.866 [atomix-data-9] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025617861}]} to 3
16:40:17.866 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025617861}]}
16:40:17.866 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:18.129 [atomix-data-4] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025618128}]} to 2
16:40:18.129 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025618128}]}
16:40:18.129 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:18.150 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025618149}]} to 2
16:40:18.150 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025618149}]} to 3
16:40:18.150 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025618149}]} to 3
16:40:18.150 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025618149}]}
16:40:18.150 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025618149}]}
16:40:18.150 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025618149}]}
16:40:18.150 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:18.150 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:18.150 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:18.422 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025618421}]} to 2
16:40:18.422 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025618421}]} to 3
16:40:18.422 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025618421}]}
16:40:18.422 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:18.422 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025618421}]}
16:40:18.422 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:18.423 [atomix-data-5] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025618422}]} to 2
16:40:18.423 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025618422}]}
16:40:18.423 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:18.438 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025618437}]} to 3
16:40:18.438 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=4, timestamp=1523025618437}]}
16:40:18.438 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:18.638 [atomix-data-15] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025618631}]} to 2
16:40:18.638 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025618631}]}
16:40:18.639 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:18.835 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025618835}]} to 2
16:40:18.835 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025618835}]}
16:40:18.835 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:18.864 [atomix-data-10] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025618862}]} to 2
16:40:18.865 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025618862}]}
16:40:18.865 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:18.865 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025618863}]} to 3
16:40:18.865 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025618863}]}
16:40:18.865 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:18.866 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025618862}]} to 3
16:40:18.866 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025618862}]}
16:40:18.866 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:19.129 [atomix-data-15] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025619128}]} to 2
16:40:19.129 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025619128}]}
16:40:19.129 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:19.150 [atomix-data-11] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025619149}]} to 3
16:40:19.150 [atomix-data-4] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025619149}]} to 2
16:40:19.150 [atomix-data-4] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025619149}]} to 3
16:40:19.150 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025619149}]}
16:40:19.150 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025619149}]}
16:40:19.150 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:19.150 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025619149}]}
16:40:19.150 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:19.150 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:19.422 [atomix-data-1] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025619421}]} to 2
16:40:19.422 [atomix-data-1] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025619421}]} to 3
16:40:19.422 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025619421}]}
16:40:19.422 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025619421}]}
16:40:19.422 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:19.422 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:19.423 [atomix-data-1] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025619422}]} to 2
16:40:19.423 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025619422}]}
16:40:19.423 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:19.438 [atomix-data-5] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025619438}]} to 3
16:40:19.438 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=5, timestamp=1523025619438}]}
16:40:19.438 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:19.638 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025619631}]} to 2
16:40:19.638 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025619631}]}
16:40:19.638 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:19.835 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025619835}]} to 2
16:40:19.835 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025619835}]}
16:40:19.835 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:19.864 [atomix-data-12] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025619862}]} to 2
16:40:19.865 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025619862}]}
16:40:19.865 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:19.865 [atomix-data-12] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025619863}]} to 3
16:40:19.865 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025619863}]}
16:40:19.865 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:19.866 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025619862}]} to 3
16:40:19.866 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025619862}]}
16:40:19.866 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:20.129 [atomix-data-15] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025620128}]} to 2
16:40:20.129 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025620128}]}
16:40:20.129 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:20.150 [atomix-data-11] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025620149}]} to 3
16:40:20.150 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025620149}]} to 2
16:40:20.150 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025620149}]} to 3
16:40:20.150 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025620149}]}
16:40:20.150 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025620149}]}
16:40:20.150 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025620149}]}
16:40:20.150 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:20.150 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:20.150 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:20.422 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025620421}]} to 2
16:40:20.422 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025620421}]} to 3
16:40:20.422 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025620421}]}
16:40:20.423 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:20.423 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025620421}]}
16:40:20.423 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025620422}]} to 2
16:40:20.423 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:20.423 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025620422}]}
16:40:20.423 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:20.438 [atomix-data-5] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025620438}]} to 3
16:40:20.438 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=6, timestamp=1523025620438}]}
16:40:20.438 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:20.638 [atomix-data-11] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025620631}]} to 2
16:40:20.638 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025620631}]}
16:40:20.638 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:20.835 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025620835}]} to 2
16:40:20.835 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025620835}]}
16:40:20.835 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:20.864 [atomix-data-5] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025620861}]} to 2
16:40:20.865 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025620861}]}
16:40:20.865 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:20.865 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025620863}]} to 3
16:40:20.865 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025620863}]}
16:40:20.865 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:20.866 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025620861}]} to 3
16:40:20.866 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025620861}]}
16:40:20.866 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:21.129 [atomix-data-10] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025621128}]} to 2
16:40:21.129 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025621128}]}
16:40:21.129 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:21.150 [atomix-data-15] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025621149}]} to 2
16:40:21.150 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025621149}]} to 3
16:40:21.150 [atomix-data-15] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025621149}]} to 3
16:40:21.150 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025621149}]}
16:40:21.150 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025621149}]}
16:40:21.150 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025621149}]}
16:40:21.150 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:21.150 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:21.150 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:21.425 [atomix-data-15] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025621425}]} to 2
16:40:21.425 [atomix-data-1] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025621422}]} to 2
16:40:21.425 [atomix-data-1] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025621422}]} to 3
16:40:21.425 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025621422}]}
16:40:21.425 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:21.426 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025621422}]}
16:40:21.426 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:21.426 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025621425}]}
16:40:21.426 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:21.438 [atomix-data-9] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025621438}]} to 3
16:40:21.438 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=7, timestamp=1523025621438}]}
16:40:21.438 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:21.638 [atomix-data-14] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025621631}]} to 2
16:40:21.638 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025621631}]}
16:40:21.638 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:21.835 [atomix-data-9] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025621835}]} to 2
16:40:21.835 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025621835}]}
16:40:21.835 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:21.865 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025621861}]} to 2
16:40:21.865 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025621861}]}
16:40:21.865 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:21.865 [atomix-data-11] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025621863}]} to 3
16:40:21.865 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025621863}]}
16:40:21.865 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:21.866 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025621861}]} to 3
16:40:21.866 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025621861}]}
16:40:21.866 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:22.129 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025622128}]} to 2
16:40:22.129 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025622128}]}
16:40:22.129 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:22.150 [atomix-data-10] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025622149}]} to 3
16:40:22.150 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025622149}]}
16:40:22.150 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:22.154 [atomix-data-4] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025622149}]} to 2
16:40:22.154 [atomix-data-4] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025622149}]} to 3
16:40:22.154 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025622149}]}
16:40:22.154 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:22.155 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025622149}]}
16:40:22.155 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:22.422 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025622421}]} to 2
16:40:22.422 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025622421}]} to 3
16:40:22.422 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025622421}]}
16:40:22.422 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:22.422 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025622421}]}
16:40:22.422 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:22.423 [atomix-data-11] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025622422}]} to 2
16:40:22.423 [atomix-data-0] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025622422}]}
16:40:22.423 [atomix-data-0] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:22.438 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025622438}]} to 3
16:40:22.438 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=8, timestamp=1523025622438}]}
16:40:22.438 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:22.638 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025622631}]} to 2
16:40:22.638 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025622631}]}
16:40:22.638 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:22.835 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025622835}]} to 2
16:40:22.835 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025622835}]}
16:40:22.835 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:22.865 [atomix-data-4] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025622863}]} to 3
16:40:22.865 [atomix-data-12] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025622862}]} to 2
16:40:22.865 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025622863}]}
16:40:22.866 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:22.866 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025622862}]}
16:40:22.866 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:22.866 [atomix-data-14] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025622862}]} to 3
16:40:22.866 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025622862}]}
16:40:22.866 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:23.128 [atomix-data-9] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025623128}]} to 2
16:40:23.129 [atomix-data-0] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025623128}]}
16:40:23.129 [atomix-data-0] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:23.150 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025623149}]} to 2
16:40:23.150 [atomix-data-6] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025623149}]} to 3
16:40:23.150 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025623149}]} to 3
16:40:23.150 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025623149}]}
16:40:23.150 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025623149}]}
16:40:23.150 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025623149}]}
16:40:23.150 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:23.150 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:23.150 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:23.422 [atomix-data-14] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025623421}]} to 2
16:40:23.422 [atomix-data-14] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025623421}]} to 3
16:40:23.422 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025623421}]}
16:40:23.422 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025623421}]}
16:40:23.422 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:23.422 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:23.423 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025623422}]} to 2
16:40:23.423 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025623422}]}
16:40:23.423 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:23.438 [atomix-data-14] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025623438}]} to 3
16:40:23.438 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=9, timestamp=1523025623438}]}
16:40:23.438 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:23.638 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025623631}]} to 2
16:40:23.638 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025623631}]}
16:40:23.638 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:23.835 [atomix-data-14] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025623835}]} to 2
16:40:23.835 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025623835}]}
16:40:23.836 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:23.864 [atomix-data-11] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025623861}]} to 2
16:40:23.865 [atomix-data-0] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025623861}]}
16:40:23.865 [atomix-data-0] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:23.865 [atomix-data-12] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025623863}]} to 3
16:40:23.866 [atomix-data-5] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025623861}]} to 3
16:40:23.866 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025623863}]}
16:40:23.866 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:23.866 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025623861}]}
16:40:23.866 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:24.129 [atomix-data-4] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025624128}]} to 2
16:40:24.129 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025624128}]}
16:40:24.129 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:24.150 [atomix-data-12] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025624149}]} to 2
16:40:24.150 [atomix-data-14] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025624149}]} to 3
16:40:24.150 [atomix-data-12] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025624149}]} to 3
16:40:24.150 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025624149}]}
16:40:24.150 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025624149}]}
16:40:24.150 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025624149}]}
16:40:24.150 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:24.150 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:24.150 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:24.422 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025624421}]} to 2
16:40:24.422 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025624421}]} to 3
16:40:24.422 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025624421}]}
16:40:24.422 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025624421}]}
16:40:24.422 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:24.422 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:24.423 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025624422}]} to 2
16:40:24.423 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025624422}]}
16:40:24.423 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:24.438 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025624438}]} to 3
16:40:24.438 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=10, timestamp=1523025624438}]}
16:40:24.438 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:24.638 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=17, timestamp=1523025624631}]} to 2
16:40:24.638 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=17, timestamp=1523025624631}]}
16:40:24.638 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:24.835 [atomix-data-12] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025624835}]} to 2
16:40:24.835 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025624835}]}
16:40:24.835 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:24.864 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025624861}]} to 2
16:40:24.865 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025624861}]}
16:40:24.865 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:24.865 [atomix-data-14] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025624863}]} to 3
16:40:24.865 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025624863}]}
16:40:24.865 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:24.866 [atomix-data-12] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025624861}]} to 3
16:40:24.866 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025624861}]}
16:40:24.866 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:25.129 [atomix-data-4] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025625128}]} to 2
16:40:25.129 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025625128}]}
16:40:25.129 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:25.150 [atomix-data-4] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025625149}]} to 2
16:40:25.150 [atomix-data-10] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025625149}]} to 3
16:40:25.150 [atomix-data-4] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025625149}]} to 3
16:40:25.150 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025625149}]}
16:40:25.150 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025625149}]}
16:40:25.150 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025625149}]}
16:40:25.150 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:25.150 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:25.150 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:25.422 [atomix-data-1] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025625421}]} to 2
16:40:25.422 [atomix-data-1] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025625421}]} to 3
16:40:25.422 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025625421}]}
16:40:25.422 [atomix-data-8] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:25.422 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025625421}]}
16:40:25.422 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:25.423 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=17, timestamp=1523025625422}]} to 2
16:40:25.423 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=17, timestamp=1523025625422}]}
16:40:25.423 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:25.438 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025625438}]} to 3
16:40:25.438 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=11, timestamp=1523025625438}]}
16:40:25.438 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:25.638 [atomix-data-14] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=18, timestamp=1523025625631}]} to 2
16:40:25.638 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=18, timestamp=1523025625631}]}
16:40:25.638 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:25.835 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025625835}]} to 2
16:40:25.835 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025625835}]}
16:40:25.835 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:25.864 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025625861}]} to 2
16:40:25.865 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025625861}]}
16:40:25.865 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:25.865 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025625863}]} to 3
16:40:25.865 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025625863}]}
16:40:25.865 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:25.866 [atomix-data-14] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025625861}]} to 3
16:40:25.866 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025625861}]}
16:40:25.866 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:26.128 [atomix-data-14] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025626128}]} to 2
16:40:26.129 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025626128}]}
16:40:26.129 [atomix-data-12] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:26.150 [atomix-data-5] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025626149}]} to 3
16:40:26.150 [atomix-data-11] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025626149}]} to 2
16:40:26.150 [atomix-data-11] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025626149}]} to 3
16:40:26.150 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025626149}]}
16:40:26.150 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025626149}]}
16:40:26.150 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025626149}]}
16:40:26.150 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:26.150 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:26.150 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:26.422 [atomix-data-1] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025626421}]} to 2
16:40:26.422 [atomix-data-1] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025626421}]} to 3
16:40:26.422 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025626421}]}
16:40:26.422 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025626421}]}
16:40:26.422 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:26.422 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:26.423 [atomix-data-14] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=18, timestamp=1523025626422}]} to 2
16:40:26.423 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=18, timestamp=1523025626422}]}
16:40:26.423 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:26.438 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025626438}]} to 3
16:40:26.438 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=12, timestamp=1523025626438}]}
16:40:26.438 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:26.638 [atomix-data-12] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=19, timestamp=1523025626631}]} to 2
16:40:26.638 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=19, timestamp=1523025626631}]}
16:40:26.638 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:26.835 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025626835}]} to 2
16:40:26.835 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025626835}]}
16:40:26.836 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:26.864 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025626861}]} to 2
16:40:26.865 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025626861}]}
16:40:26.865 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:26.865 [atomix-data-5] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025626863}]} to 3
16:40:26.865 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025626863}]}
16:40:26.865 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:26.866 [atomix-data-10] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025626861}]} to 3
16:40:26.866 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025626861}]}
16:40:26.866 [atomix-data-4] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:27.129 [atomix-data-1] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025627128}]} to 2
16:40:27.129 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025627128}]}
16:40:27.129 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:27.150 [atomix-data-14] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025627149}]} to 3
16:40:27.150 [atomix-data-11] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025627149}]} to 2
16:40:27.150 [atomix-data-11] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025627149}]} to 3
16:40:27.150 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025627149}]}
16:40:27.150 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025627149}]}
16:40:27.150 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025627149}]}
16:40:27.150 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:27.150 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:27.150 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:27.422 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025627421}]} to 2
16:40:27.422 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025627421}]} to 3
16:40:27.422 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025627421}]}
16:40:27.422 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025627421}]}
16:40:27.422 [atomix-data-1] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:27.422 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:27.423 [atomix-data-6] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=19, timestamp=1523025627422}]} to 2
16:40:27.423 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=19, timestamp=1523025627422}]}
16:40:27.423 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:27.438 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025627438}]} to 3
16:40:27.438 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=13, timestamp=1523025627438}]}
16:40:27.438 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:27.638 [atomix-data-15] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=20, timestamp=1523025627631}]} to 2
16:40:27.638 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=20, timestamp=1523025627631}]}
16:40:27.638 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:27.835 [atomix-data-14] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025627835}]} to 2
16:40:27.835 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025627835}]}
16:40:27.835 [atomix-data-13] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:27.864 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025627861}]} to 2
16:40:27.865 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025627861}]}
16:40:27.865 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:27.865 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025627863}]} to 3
16:40:27.865 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025627863}]}
16:40:27.865 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:27.866 [atomix-data-9] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025627861}]} to 3
16:40:27.866 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025627861}]}
16:40:27.866 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:28.128 [atomix-data-15] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=17, timestamp=1523025628128}]} to 2
16:40:28.130 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=17, timestamp=1523025628128}]}
16:40:28.130 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:28.150 [atomix-data-6] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025628149}]} to 2
16:40:28.150 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025628149}]} to 3
16:40:28.150 [atomix-data-6] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025628149}]} to 3
16:40:28.150 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025628149}]}
16:40:28.150 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025628149}]}
16:40:28.150 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025628149}]}
16:40:28.150 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:28.150 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:28.150 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:28.422 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025628421}]} to 2
16:40:28.422 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025628421}]} to 3
16:40:28.422 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025628421}]}
16:40:28.422 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025628421}]}
16:40:28.422 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:28.422 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:28.423 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=20, timestamp=1523025628422}]} to 2
16:40:28.423 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=20, timestamp=1523025628422}]}
16:40:28.423 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:28.438 [atomix-data-15] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025628438}]} to 3
16:40:28.438 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=14, timestamp=1523025628438}]}
16:40:28.438 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:28.638 [atomix-data-12] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=21, timestamp=1523025628631}]} to 2
16:40:28.638 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=21, timestamp=1523025628631}]}
16:40:28.638 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:28.835 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=17, timestamp=1523025628835}]} to 2
16:40:28.835 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=17, timestamp=1523025628835}]}
16:40:28.835 [atomix-data-11] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:28.864 [atomix-data-3] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025628861}]} to 2
16:40:28.865 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025628861}]}
16:40:28.865 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:28.865 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025628863}]} to 3
16:40:28.865 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025628863}]}
16:40:28.865 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:28.866 [atomix-data-5] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025628861}]} to 3
16:40:28.866 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025628861}]}
16:40:28.866 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:29.128 [atomix-data-12] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=18, timestamp=1523025629128}]} to 2
16:40:29.129 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=18, timestamp=1523025629128}]}
16:40:29.129 [atomix-data-5] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:29.150 [atomix-data-10] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025629149}]} to 2
16:40:29.150 [atomix-data-1] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025629149}]} to 3
16:40:29.150 [atomix-data-10] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025629149}]} to 3
16:40:29.150 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025629149}]}
16:40:29.150 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025629149}]}
16:40:29.150 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025629149}]}
16:40:29.150 [atomix-data-14] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:29.150 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:29.150 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:29.422 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025629421}]} to 2
16:40:29.422 [atomix-data-2] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025629421}]} to 3
16:40:29.422 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025629421}]}
16:40:29.422 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:29.422 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025629421}]}
16:40:29.422 [atomix-data-7] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:29.423 [atomix-data-11] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=21, timestamp=1523025629422}]} to 2
16:40:29.423 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=21, timestamp=1523025629422}]}
16:40:29.423 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:29.438 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025629438}]} to 3
16:40:29.438 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=b0c35332-1577-4d14-bf8b-4e9bba587b76, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=15, timestamp=1523025629438}]}
16:40:29.438 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:29.638 [atomix-data-7] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=22, timestamp=1523025629631}]} to 2
16:40:29.638 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=7, primitive=PrimitiveDescriptor{name=f37cab90-0746-4450-bcf9-51386a75af10, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=22, timestamp=1523025629631}]}
16:40:29.638 [atomix-data-6] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:29.835 [atomix-data-13] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=18, timestamp=1523025629835}]} to 2
16:40:29.835 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=3, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=18, timestamp=1523025629835}]}
16:40:29.835 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:29.864 [atomix-data-0] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025629861}]} to 2
16:40:29.865 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025629861}]}
16:40:29.865 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:29.865 [atomix-data-1] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025629863}]} to 3
16:40:29.865 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025629863}]}
16:40:29.865 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:29.866 [atomix-data-6] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025629861}]} to 3
16:40:29.866 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=96f44f8b-6fe1-43a4-8e68-de843e50c793, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025629861}]}
16:40:29.866 [atomix-data-10] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:30.129 [atomix-data-1] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-1}{role=PRIMARY} - Sending BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=19, timestamp=1523025630128}]} to 2
16:40:30.129 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Received BackupRequest{primary=3, term=2, index=4, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=19, timestamp=1523025630128}]}
16:40:30.129 [atomix-data-15] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-1}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:30.150 [atomix-data-9] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025630149}]} to 2
16:40:30.150 [atomix-data-8] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-3}{role=PRIMARY} - Sending BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025630149}]} to 3
16:40:30.150 [atomix-data-9] TRACE i.a.p.backup.roles.PrimaryRole - PrimaryRole{data-partition-2}{role=PRIMARY} - Sending BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025630149}]} to 3
16:40:30.150 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025630149}]}
16:40:30.150 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Received BackupRequest{primary=2, term=2, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025630149}]}
16:40:30.150 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Received BackupRequest{primary=1, term=1, index=1, primitive=PrimitiveDescriptor{name=4062affa-d1cc-4833-b38c-ec508e705846, type=DOCUMENT_TREE, backups=2, replication=ASYNCHRONOUS}, operations=[HeartbeatOperation{index=16, timestamp=1523025630149}]}
16:40:30.150 [atomix-data-3] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-3}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:30.150 [atomix-data-9] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
16:40:30.150 [atomix-data-2] TRACE i.a.p.backup.roles.BackupRole - BackupRole{data-partition-2}{role=BACKUP} - Sending BackupResponse{status=OK}
Disconnected from the target VM, address: '127.0.0.1:45233', transport: 'socket'
Process finished with exit code 130 (interrupted by signal 2: SIGINT)
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment