Skip to content

Instantly share code, notes, and snippets.

@amclay

amclay/alpha.txt Secret

Created December 20, 2018 02:11
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 amclay/e52123e323b59c1e5e987b370ac2462d to your computer and use it in GitHub Desktop.
Save amclay/e52123e323b59c1e5e987b370ac2462d to your computer and use it in GitHub Desktop.
Download ZIP
alpha.txt
Raw
alpha.txt
++ hostname -f
+ dgraph alpha --my=dgraph-alpha-0.dgraph-alpha.dgraph.svc.cluster.local:7080 --lru_mb 2048 --zero dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080
I1220 01:52:44.787787 1 init.go:88]
Dgraph version : v1.0.11
Commit SHA-1 : b2a09c5b
Commit timestamp : 2018-12-17 09:50:56 -0800
Branch : HEAD
Go version : go1.11.1
For Dgraph official documentation, visit https://docs.dgraph.io.
For discussions about Dgraph , visit https://discuss.dgraph.io.
To say hi to the community , visit https://dgraph.slack.com.
Licensed variously under the Apache Public License 2.0 and Dgraph Community License.
Copyright 2015-2018 Dgraph Labs, Inc.
I1220 01:52:44.790727 1 server.go:113] Setting Badger table load option: mmap
I1220 01:52:44.790746 1 server.go:125] Setting Badger value log load option: mmap
I1220 01:52:44.790752 1 server.go:153] Opening write-ahead log BadgerDB with options: {Dir:w ValueDir:w SyncWrites:true TableLoadingMode:1 ValueLogLoadingMode:2 NumVersionsToKeep:1 MaxTableSize:67108864 LevelSizeMultiplier:10 MaxLevels:7 ValueThreshold:65500 NumMemtables:5 NumLevelZeroTables:5 NumLevelZeroTablesStall:10 LevelOneSize:268435456 ValueLogFileSize:1073741823 ValueLogMaxEntries:10000 NumCompactors:3 managedTxns:false DoNotCompact:false maxBatchCount:0 maxBatchSize:0 ReadOnly:false Truncate:true}
I1220 01:52:44.802374 1 server.go:113] Setting Badger table load option: mmap
I1220 01:52:44.802397 1 server.go:125] Setting Badger value log load option: mmap
I1220 01:52:44.802403 1 server.go:167] Opening postings BadgerDB with options: {Dir:p ValueDir:p SyncWrites:true TableLoadingMode:2 ValueLogLoadingMode:2 NumVersionsToKeep:2147483647 MaxTableSize:67108864 LevelSizeMultiplier:10 MaxLevels:7 ValueThreshold:1024 NumMemtables:5 NumLevelZeroTables:5 NumLevelZeroTablesStall:10 LevelOneSize:268435456 ValueLogFileSize:1073741823 ValueLogMaxEntries:1000000 NumCompactors:3 managedTxns:false DoNotCompact:false maxBatchCount:0 maxBatchSize:0 ReadOnly:false Truncate:true}
I1220 01:52:44.818241 1 run.go:385] gRPC server started. Listening on port 9080
I1220 01:52:44.818264 1 run.go:386] HTTP server started. Listening on port 8080
I1220 01:52:44.818350 1 groups.go:89] Current Raft Id: 0
I1220 01:52:44.818337 1 worker.go:79] Worker listening at address: [::]:7080
I1220 01:52:44.928187 1 pool.go:140] CONNECTED to dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080
I1220 01:52:44.949982 1 groups.go:112] Connected to group zero. Assigned group: 1
I1220 01:52:44.954292 1 draft.go:72] Node ID: 1 with GroupID: 1
I1220 01:52:44.954349 1 node.go:151] Setting raft.Config to: &{ID:1 peers:[] learners:[] ElectionTick:100 HeartbeatTick:1 Storage:0xc00ac940f0 Applied:0 MaxSizePerMsg:1048576 MaxInflightMsgs:256 CheckQuorum:false PreVote:true ReadOnlyOption:0 Logger:0x1f94370 DisableProposalForwarding:false}
I1220 01:52:44.954448 1 node.go:290] Group 1 found 1 entries
I1220 01:52:44.954468 1 draft.go:1117] New Node for group: 1
I1220 01:52:44.954502 1 node.go:83] 1 became follower at term 0
I1220 01:52:44.954533 1 node.go:83] newRaft 1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]
I1220 01:52:44.954540 1 node.go:83] 1 became follower at term 1
I1220 01:52:44.954683 1 groups.go:695] Got address of a Zero leader: dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080
I1220 01:52:44.954764 1 groups.go:708] Starting a new membership stream receive from dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080.
I1220 01:52:44.956874 1 node.go:173] Setting conf state to nodes:1
I1220 01:52:44.957067 1 node.go:83] 1 is starting a new election at term 1
I1220 01:52:44.957084 1 node.go:83] 1 became pre-candidate at term 1
I1220 01:52:44.957091 1 node.go:83] 1 received MsgPreVoteResp from 1 at term 1
I1220 01:52:44.957114 1 node.go:83] 1 became candidate at term 2
I1220 01:52:44.957123 1 node.go:83] 1 received MsgVoteResp from 1 at term 2
I1220 01:52:44.957151 1 node.go:83] 1 became leader at term 2
I1220 01:52:44.957158 1 node.go:83] raft.node: 1 elected leader 1 at term 2
I1220 01:52:44.958260 1 groups.go:388] Serving tablet for: _predicate_
I1220 01:52:44.958243 1 groups.go:725] Received first state update from Zero: counter:5 groups:<key:1 value:<members:<key:1 value:<id:1 group_id:1 addr:"dgraph-alpha-0.dgraph-alpha.dgraph.svc.cluster.local:7080" > > tablets:<key:"_predicate_" value:<group_id:1 predicate:"_predicate_" > > > > zeros:<key:1 value:<id:1 addr:"dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080" leader:true > > maxRaftId:1 cid:"76d0c365-7a59-4384-bc5e-562cd63bc5c5"
I1220 01:52:44.967459 1 mutation.go:158] Done schema update predicate:"_predicate_" value_type:STRING list:true
I1220 01:52:44.973289 1 groups.go:388] Serving tablet for: dgraph.xid
I1220 01:52:44.975351 1 index.go:33] Deleting index for dgraph.xid
I1220 01:52:44.975383 1 index.go:38] Rebuilding index for dgraph.xid
I1220 01:52:44.975417 1 mutation.go:158] Done schema update predicate:"dgraph.xid" value_type:STRING directive:INDEX tokenizer:"exact"
I1220 01:52:44.980827 1 groups.go:388] Serving tablet for: dgraph.password
I1220 01:52:44.982841 1 mutation.go:158] Done schema update predicate:"dgraph.password" value_type:PASSWORD
I1220 01:52:44.988089 1 groups.go:388] Serving tablet for: dgraph.user.group
I1220 01:52:44.990132 1 index.go:48] Deleting reverse index for dgraph.user.group
I1220 01:52:44.990167 1 index.go:54] Rebuilding reverse index for dgraph.user.group
I1220 01:52:44.990212 1 mutation.go:158] Done schema update predicate:"dgraph.user.group" value_type:UID directive:REVERSE
I1220 01:52:44.995335 1 groups.go:388] Serving tablet for: dgraph.group.acl
I1220 01:52:44.997378 1 mutation.go:158] Done schema update predicate:"dgraph.group.acl" value_type:STRING
I1220 01:52:45.954940 1 groups.go:850] Leader idx=1 of group=1 is connecting to Zero for txn updates
I1220 01:52:45.954969 1 groups.go:859] Got Zero leader: dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080
E1220 01:52:59.626397 1 groups.go:889] Error in oracle delta stream. Error: rpc error: code = Unknown desc = Node is no longer leader.
I1220 01:52:59.954935 1 groups.go:850] Leader idx=1 of group=1 is connecting to Zero for txn updates
I1220 01:52:59.954962 1 groups.go:859] Got Zero leader: dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080
I1220 01:53:00.653999 1 pool.go:140] CONNECTED to dgraph-zero-1.dgraph-zero.dgraph.svc.cluster.local:5080
I1220 01:53:21.462296 1 pool.go:140] CONNECTED to dgraph-alpha-1.dgraph-alpha.dgraph.svc.cluster.local:7080
I1220 01:53:21.462317 1 node.go:473] Trying to add 2 to cluster. Addr: dgraph-alpha-1.dgraph-alpha.dgraph.svc.cluster.local:7080
I1220 01:53:21.462323 1 node.go:474] Current confstate at 1: nodes:1
I1220 01:53:21.465358 1 node.go:173] Setting conf state to nodes:1 nodes:2
I1220 01:53:21.465412 1 raft_server.go:185] [2] Done joining cluster with err: <nil>
E1220 01:53:33.712408 1 groups.go:889] Error in oracle delta stream. Error: rpc error: code = Unknown desc = Node is no longer leader.
I1220 01:53:33.954863 1 groups.go:850] Leader idx=1 of group=1 is connecting to Zero for txn updates
I1220 01:53:33.954906 1 groups.go:859] Got Zero leader: dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080
E1220 01:53:33.979948 1 pool.go:206] Echo error from dgraph-zero-2.dgraph-zero.dgraph.svc.cluster.local:5080. Err: rpc error: code = Unavailable desc = all SubConns are in TransientFailure, latest connection error: connection error: desc = "transport: Error while dialing dial tcp: lookup dgraph-zero-2.dgraph-zero.dgraph.svc.cluster.local: no such host"
I1220 01:53:33.979972 1 pool.go:140] CONNECTED to dgraph-zero-2.dgraph-zero.dgraph.svc.cluster.local:5080
E1220 01:53:59.420970 1 pool.go:206] Echo error from dgraph-alpha-2.dgraph-alpha.dgraph.svc.cluster.local:7080. Err: rpc error: code = Unavailable desc = all SubConns are in TransientFailure, latest connection error: connection error: desc = "transport: Error while dialing dial tcp: lookup dgraph-alpha-2.dgraph-alpha.dgraph.svc.cluster.local: no such host"
I1220 01:53:59.421033 1 pool.go:140] CONNECTED to dgraph-alpha-2.dgraph-alpha.dgraph.svc.cluster.local:7080
I1220 01:53:59.421061 1 node.go:473] Trying to add 3 to cluster. Addr: dgraph-alpha-2.dgraph-alpha.dgraph.svc.cluster.local:7080
I1220 01:53:59.421066 1 node.go:474] Current confstate at 1: nodes:1 nodes:2
I1220 01:53:59.426124 1 node.go:173] Setting conf state to nodes:1 nodes:2 nodes:3
I1220 01:53:59.426174 1 raft_server.go:185] [3] Done joining cluster with err: <nil>
W1220 01:53:59.435078 1 node.go:382] Reporting node: 3 addr: dgraph-alpha-2.dgraph-alpha.dgraph.svc.cluster.local:7080 as unreachable.
W1220 01:53:59.454885 1 node.go:347] No healthy connection to node Id: 3 addr: [dgraph-alpha-2.dgraph-alpha.dgraph.svc.cluster.local:7080], err: Unhealthy connection
I1220 01:59:21.340255 1 groups.go:388] Serving tablet for: friends_with
I1220 01:59:21.342436 1 groups.go:388] Serving tablet for: friends_with
I1220 02:00:16.600390 1 draft.go:323] Creating snapshot at index: 2167. ReadTs: 3803.
I1220 02:00:45.716073 1 draft.go:323] Creating snapshot at index: 3300. ReadTs: 5850.
I1220 02:01:15.862063 1 draft.go:323] Creating snapshot at index: 4455. ReadTs: 7882.
I1220 02:01:45.773083 1 draft.go:323] Creating snapshot at index: 5569. ReadTs: 9889.
I1220 02:02:15.926307 1 draft.go:323] Creating snapshot at index: 6673. ReadTs: 11825.
I1220 02:02:47.053240 1 draft.go:323] Creating snapshot at index: 7844. ReadTs: 13911.
I1220 02:03:15.758376 1 draft.go:323] Creating snapshot at index: 8197. ReadTs: 14552.
I1220 02:03:16.397131 1 stream.go:240] Rolling up Time elapsed: 31s, bytes sent: 103 MB, speed: 3.3 MB/sec
I1220 02:03:24.028837 1 stream.go:240] Rolling up Time elapsed: 39s, bytes sent: 128 MB, speed: 3.3 MB/sec
I1220 02:03:41.325273 1 stream.go:240] Rolling up Time elapsed: 56s, bytes sent: 180 MB, speed: 3.2 MB/sec
I1220 02:03:56.824432 1 stream.go:240] Rolling up Time elapsed: 01m11s, bytes sent: 227 MB, speed: 3.2 MB/sec
I1220 02:03:57.593144 1 stream.go:240] Rolling up Time elapsed: 01m12s, bytes sent: 231 MB, speed: 3.2 MB/sec
I1220 02:03:57.593166 1 stream.go:255] Rolling up Sent 3160208 keys
I1220 02:03:57.680455 1 draft.go:836] Rollup on disk done. Rolling up 3160208 keys in LRU cache now...
I1220 02:04:07.779277 1 draft.go:846] Rollup in LRU cache done.
I1220 02:04:07.779303 1 draft.go:364] List rollup at Ts 11825: OK.
I1220 02:04:46.252427 1 draft.go:323] Creating snapshot at index: 9859. ReadTs: 17551.
I1220 02:05:45.950615 1 draft.go:323] Creating snapshot at index: 11461. ReadTs: 20479.
I1220 02:07:46.579573 1 stream.go:240] Rolling up Time elapsed: 01s, bytes sent: 13 MB, speed: 13 MB/sec
I1220 02:07:50.704418 1 stream.go:240] Rolling up Time elapsed: 05s, bytes sent: 39 MB, speed: 7.7 MB/sec
I1220 02:07:53.354276 1 stream.go:240] Rolling up Time elapsed: 08s, bytes sent: 63 MB, speed: 7.9 MB/sec
I1220 02:08:05.172027 1 stream.go:240] Rolling up Time elapsed: 20s, bytes sent: 131 MB, speed: 6.5 MB/sec
I1220 02:08:07.680955 1 stream.go:240] Rolling up Time elapsed: 22s, bytes sent: 152 MB, speed: 6.9 MB/sec
I1220 02:08:09.676172 1 stream.go:240] Rolling up Time elapsed: 24s, bytes sent: 172 MB, speed: 7.2 MB/sec
I1220 02:08:09.676204 1 stream.go:255] Rolling up Sent 2313608 keys
I1220 02:08:09.698237 1 draft.go:836] Rollup on disk done. Rolling up 2313608 keys in LRU cache now...
I1220 02:08:15.300426 1 draft.go:323] Creating snapshot at index: 12297. ReadTs: 21982.
I1220 02:08:17.412499 1 draft.go:846] Rollup in LRU cache done.
I1220 02:08:17.412552 1 draft.go:364] List rollup at Ts 20479: OK.
++ hostname -f
+ dgraph alpha --my=dgraph-alpha-1.dgraph-alpha.dgraph.svc.cluster.local:7080 --lru_mb 2048 --zero dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080
I1220 01:53:21.199152 1 init.go:88]
Dgraph version : v1.0.11
Commit SHA-1 : b2a09c5b
Commit timestamp : 2018-12-17 09:50:56 -0800
Branch : HEAD
Go version : go1.11.1
For Dgraph official documentation, visit https://docs.dgraph.io.
For discussions about Dgraph , visit https://discuss.dgraph.io.
To say hi to the community , visit https://dgraph.slack.com.
Licensed variously under the Apache Public License 2.0 and Dgraph Community License.
Copyright 2015-2018 Dgraph Labs, Inc.
I1220 01:53:21.200351 1 server.go:113] Setting Badger table load option: mmap
I1220 01:53:21.200369 1 server.go:125] Setting Badger value log load option: mmap
I1220 01:53:21.200374 1 server.go:153] Opening write-ahead log BadgerDB with options: {Dir:w ValueDir:w SyncWrites:true TableLoadingMode:1 ValueLogLoadingMode:2 NumVersionsToKeep:1 MaxTableSize:67108864 LevelSizeMultiplier:10 MaxLevels:7 ValueThreshold:65500 NumMemtables:5 NumLevelZeroTables:5 NumLevelZeroTablesStall:10 LevelOneSize:268435456 ValueLogFileSize:1073741823 ValueLogMaxEntries:10000 NumCompactors:3 managedTxns:false DoNotCompact:false maxBatchCount:0 maxBatchSize:0 ReadOnly:false Truncate:true}
I1220 01:53:21.212407 1 server.go:113] Setting Badger table load option: mmap
I1220 01:53:21.212429 1 server.go:125] Setting Badger value log load option: mmap
I1220 01:53:21.212435 1 server.go:167] Opening postings BadgerDB with options: {Dir:p ValueDir:p SyncWrites:true TableLoadingMode:2 ValueLogLoadingMode:2 NumVersionsToKeep:2147483647 MaxTableSize:67108864 LevelSizeMultiplier:10 MaxLevels:7 ValueThreshold:1024 NumMemtables:5 NumLevelZeroTables:5 NumLevelZeroTablesStall:10 LevelOneSize:268435456 ValueLogFileSize:1073741823 ValueLogMaxEntries:1000000 NumCompactors:3 managedTxns:false DoNotCompact:false maxBatchCount:0 maxBatchSize:0 ReadOnly:false Truncate:true}
I1220 01:53:21.223149 1 groups.go:89] Current Raft Id: 0
I1220 01:53:21.223250 1 run.go:385] gRPC server started. Listening on port 9080
I1220 01:53:21.223267 1 run.go:386] HTTP server started. Listening on port 8080
I1220 01:53:21.224740 1 worker.go:79] Worker listening at address: [::]:7080
I1220 01:53:21.416548 1 pool.go:140] CONNECTED to dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080
I1220 01:53:21.447163 1 groups.go:112] Connected to group zero. Assigned group: 1
I1220 01:53:21.452772 1 pool.go:140] CONNECTED to dgraph-alpha-0.dgraph-alpha.dgraph.svc.cluster.local:7080
I1220 01:53:21.454957 1 pool.go:140] CONNECTED to dgraph-zero-1.dgraph-zero.dgraph.svc.cluster.local:5080
I1220 01:53:21.459048 1 draft.go:72] Node ID: 2 with GroupID: 1
I1220 01:53:21.459101 1 node.go:151] Setting raft.Config to: &{ID:2 peers:[] learners:[] ElectionTick:100 HeartbeatTick:1 Storage:0xc00022e2d0 Applied:0 MaxSizePerMsg:1048576 MaxInflightMsgs:256 CheckQuorum:false PreVote:true ReadOnlyOption:0 Logger:0x1f94370 DisableProposalForwarding:false}
I1220 01:53:21.459180 1 node.go:290] Group 1 found 1 entries
I1220 01:53:21.459192 1 draft.go:1055] Calling IsPeer
I1220 01:53:21.459644 1 draft.go:1060] Done with IsPeer call
I1220 01:53:21.459662 1 draft.go:1117] New Node for group: 1
I1220 01:53:21.459672 1 draft.go:1124] Trying to join peers.
I1220 01:53:21.459684 1 draft.go:1038] Calling JoinCluster via leader: dgraph-alpha-0.dgraph-alpha.dgraph.svc.cluster.local:7080
I1220 01:53:21.465772 1 draft.go:1042] Done with JoinCluster call
I1220 01:53:21.465850 1 node.go:83] 2 became follower at term 0
I1220 01:53:21.467456 1 node.go:83] newRaft 2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]
I1220 01:53:21.467485 1 node.go:83] 2 became follower at term 1
I1220 01:53:21.467604 1 groups.go:695] Got address of a Zero leader: dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080
I1220 01:53:21.467727 1 groups.go:708] Starting a new membership stream receive from dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080.
I1220 01:53:21.470280 1 groups.go:725] Received first state update from Zero: counter:12 groups:<key:1 value:<members:<key:1 value:<id:1 group_id:1 addr:"dgraph-alpha-0.dgraph-alpha.dgraph.svc.cluster.local:7080" leader:true last_update:1545270764 > > members:<key:2 value:<id:2 group_id:1 addr:"dgraph-alpha-1.dgraph-alpha.dgraph.svc.cluster.local:7080" > > tablets:<key:"_predicate_" value:<group_id:1 predicate:"_predicate_" > > tablets:<key:"dgraph.group.acl" value:<group_id:1 predicate:"dgraph.group.acl" > > tablets:<key:"dgraph.password" value:<group_id:1 predicate:"dgraph.password" > > tablets:<key:"dgraph.user.group" value:<group_id:1 predicate:"dgraph.user.group" > > tablets:<key:"dgraph.xid" value:<group_id:1 predicate:"dgraph.xid" > > > > zeros:<key:1 value:<id:1 addr:"dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080" leader:true > > zeros:<key:2 value:<id:2 addr:"dgraph-zero-1.dgraph-zero.dgraph.svc.cluster.local:5080" > > maxRaftId:2 cid:"76d0c365-7a59-4384-bc5e-562cd63bc5c5"
I1220 01:53:21.475258 1 node.go:83] 2 [term: 1] received a MsgHeartbeat message with higher term from 1 [term: 2]
I1220 01:53:21.475288 1 node.go:83] 2 became follower at term 2
I1220 01:53:21.475319 1 node.go:83] raft.node: 2 elected leader 1 at term 2
I1220 01:53:21.480577 1 node.go:173] Setting conf state to nodes:1
I1220 01:53:21.480698 1 node.go:173] Setting conf state to nodes:1 nodes:2
I1220 01:53:21.480862 1 mutation.go:158] Done schema update predicate:"_predicate_" value_type:STRING list:true
I1220 01:53:21.483071 1 index.go:33] Deleting index for dgraph.xid
I1220 01:53:21.483105 1 index.go:38] Rebuilding index for dgraph.xid
I1220 01:53:21.483132 1 mutation.go:158] Done schema update predicate:"dgraph.xid" value_type:STRING directive:INDEX tokenizer:"exact"
I1220 01:53:21.484991 1 mutation.go:158] Done schema update predicate:"dgraph.password" value_type:PASSWORD
I1220 01:53:21.486834 1 index.go:48] Deleting reverse index for dgraph.user.group
I1220 01:53:21.486863 1 index.go:54] Rebuilding reverse index for dgraph.user.group
I1220 01:53:21.486891 1 mutation.go:158] Done schema update predicate:"dgraph.user.group" value_type:UID directive:REVERSE
I1220 01:53:21.488769 1 mutation.go:158] Done schema update predicate:"dgraph.group.acl" value_type:STRING
E1220 01:53:34.492312 1 pool.go:206] Echo error from dgraph-zero-2.dgraph-zero.dgraph.svc.cluster.local:5080. Err: rpc error: code = Unavailable desc = all SubConns are in TransientFailure, latest connection error: connection error: desc = "transport: Error while dialing dial tcp: lookup dgraph-zero-2.dgraph-zero.dgraph.svc.cluster.local: no such host"
I1220 01:53:34.492640 1 pool.go:140] CONNECTED to dgraph-zero-2.dgraph-zero.dgraph.svc.cluster.local:5080
E1220 01:53:59.448497 1 pool.go:206] Echo error from dgraph-alpha-2.dgraph-alpha.dgraph.svc.cluster.local:7080. Err: rpc error: code = Unavailable desc = all SubConns are in TransientFailure, latest connection error: connection error: desc = "transport: Error while dialing dial tcp: lookup dgraph-alpha-2.dgraph-alpha.dgraph.svc.cluster.local: no such host"
I1220 01:53:59.448526 1 pool.go:140] CONNECTED to dgraph-alpha-2.dgraph-alpha.dgraph.svc.cluster.local:7080
I1220 01:53:59.448555 1 node.go:173] Setting conf state to nodes:1 nodes:2 nodes:3
I1220 01:59:21.352809 1 groups.go:388] Serving tablet for: friends_with
I1220 02:00:16.555394 1 draft.go:323] Creating snapshot at index: 2167. ReadTs: 3803.
I1220 02:00:45.705238 1 draft.go:323] Creating snapshot at index: 3300. ReadTs: 5850.
I1220 02:01:15.850344 1 draft.go:323] Creating snapshot at index: 4455. ReadTs: 7882.
I1220 02:01:45.735735 1 draft.go:323] Creating snapshot at index: 5569. ReadTs: 9889.
I1220 02:02:15.902962 1 draft.go:323] Creating snapshot at index: 6673. ReadTs: 11825.
I1220 02:02:46.390113 1 draft.go:323] Creating snapshot at index: 7844. ReadTs: 13911.
I1220 02:03:15.182651 1 draft.go:323] Creating snapshot at index: 8197. ReadTs: 14552.
I1220 02:03:30.857011 1 stream.go:240] Rolling up Time elapsed: 09s, bytes sent: 30 MB, speed: 3.4 MB/sec
I1220 02:03:46.866997 1 stream.go:240] Rolling up Time elapsed: 25s, bytes sent: 90 MB, speed: 3.6 MB/sec
I1220 02:03:54.933855 1 stream.go:240] Rolling up Time elapsed: 33s, bytes sent: 121 MB, speed: 3.7 MB/sec
I1220 02:04:42.889286 1 stream.go:255] Rolling up Sent 3888684 keys
I1220 02:04:43.249086 1 draft.go:836] Rollup on disk done. Rolling up 3888684 keys in LRU cache now...
I1220 02:04:55.224600 1 draft.go:846] Rollup in LRU cache done.
I1220 02:04:55.316360 1 draft.go:364] List rollup at Ts 14552: OK.
I1220 02:05:06.117157 1 draft.go:323] Creating snapshot at index: 9859. ReadTs: 17551.
I1220 02:06:01.357147 1 draft.go:323] Creating snapshot at index: 11461. ReadTs: 20479.
I1220 02:08:15.301755 1 draft.go:323] Creating snapshot at index: 12297. ReadTs: 21982.
I1220 02:08:27.868563 1 stream.go:240] Rolling up Time elapsed: 06s, bytes sent: 53 MB, speed: 8.9 MB/sec
I1220 02:08:32.681961 1 stream.go:240] Rolling up Time elapsed: 11s, bytes sent: 108 MB, speed: 9.8 MB/sec
I1220 02:08:37.807465 1 stream.go:255] Rolling up Sent 1990834 keys
I1220 02:08:37.822005 1 draft.go:836] Rollup on disk done. Rolling up 1990834 keys in LRU cache now...
I1220 02:08:44.097836 1 draft.go:846] Rollup in LRU cache done.
I1220 02:08:44.097863 1 draft.go:364] List rollup at Ts 21982: OK.
++ hostname -f
+ dgraph alpha --my=dgraph-alpha-2.dgraph-alpha.dgraph.svc.cluster.local:7080 --lru_mb 2048 --zero dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080
I1220 01:53:59.231145 1 init.go:88]
Dgraph version : v1.0.11
Commit SHA-1 : b2a09c5b
Commit timestamp : 2018-12-17 09:50:56 -0800
Branch : HEAD
Go version : go1.11.1
For Dgraph official documentation, visit https://docs.dgraph.io.
For discussions about Dgraph , visit https://discuss.dgraph.io.
To say hi to the community , visit https://dgraph.slack.com.
Licensed variously under the Apache Public License 2.0 and Dgraph Community License.
Copyright 2015-2018 Dgraph Labs, Inc.
I1220 01:53:59.234310 1 server.go:113] Setting Badger table load option: mmap
I1220 01:53:59.234328 1 server.go:125] Setting Badger value log load option: mmap
I1220 01:53:59.234334 1 server.go:153] Opening write-ahead log BadgerDB with options: {Dir:w ValueDir:w SyncWrites:true TableLoadingMode:1 ValueLogLoadingMode:2 NumVersionsToKeep:1 MaxTableSize:67108864 LevelSizeMultiplier:10 MaxLevels:7 ValueThreshold:65500 NumMemtables:5 NumLevelZeroTables:5 NumLevelZeroTablesStall:10 LevelOneSize:268435456 ValueLogFileSize:1073741823 ValueLogMaxEntries:10000 NumCompactors:3 managedTxns:false DoNotCompact:false maxBatchCount:0 maxBatchSize:0 ReadOnly:false Truncate:true}
I1220 01:53:59.244377 1 server.go:113] Setting Badger table load option: mmap
I1220 01:53:59.244398 1 server.go:125] Setting Badger value log load option: mmap
I1220 01:53:59.244403 1 server.go:167] Opening postings BadgerDB with options: {Dir:p ValueDir:p SyncWrites:true TableLoadingMode:2 ValueLogLoadingMode:2 NumVersionsToKeep:2147483647 MaxTableSize:67108864 LevelSizeMultiplier:10 MaxLevels:7 ValueThreshold:1024 NumMemtables:5 NumLevelZeroTables:5 NumLevelZeroTablesStall:10 LevelOneSize:268435456 ValueLogFileSize:1073741823 ValueLogMaxEntries:1000000 NumCompactors:3 managedTxns:false DoNotCompact:false maxBatchCount:0 maxBatchSize:0 ReadOnly:false Truncate:true}
I1220 01:53:59.252721 1 run.go:385] gRPC server started. Listening on port 9080
I1220 01:53:59.252739 1 groups.go:89] Current Raft Id: 0
I1220 01:53:59.252747 1 run.go:386] HTTP server started. Listening on port 8080
I1220 01:53:59.252793 1 worker.go:79] Worker listening at address: [::]:7080
I1220 01:53:59.355037 1 pool.go:140] CONNECTED to dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080
I1220 01:53:59.384985 1 groups.go:112] Connected to group zero. Assigned group: 1
I1220 01:53:59.388053 1 pool.go:140] CONNECTED to dgraph-alpha-0.dgraph-alpha.dgraph.svc.cluster.local:7080
I1220 01:53:59.390345 1 pool.go:140] CONNECTED to dgraph-alpha-1.dgraph-alpha.dgraph.svc.cluster.local:7080
I1220 01:53:59.393397 1 pool.go:140] CONNECTED to dgraph-zero-1.dgraph-zero.dgraph.svc.cluster.local:5080
I1220 01:53:59.395461 1 pool.go:140] CONNECTED to dgraph-zero-2.dgraph-zero.dgraph.svc.cluster.local:5080
I1220 01:53:59.399501 1 draft.go:72] Node ID: 3 with GroupID: 1
I1220 01:53:59.399575 1 node.go:151] Setting raft.Config to: &{ID:3 peers:[] learners:[] ElectionTick:100 HeartbeatTick:1 Storage:0xc0006c4960 Applied:0 MaxSizePerMsg:1048576 MaxInflightMsgs:256 CheckQuorum:false PreVote:true ReadOnlyOption:0 Logger:0x1f94370 DisableProposalForwarding:false}
I1220 01:53:59.399681 1 node.go:290] Group 1 found 1 entries
I1220 01:53:59.399701 1 draft.go:1055] Calling IsPeer
I1220 01:53:59.401006 1 draft.go:1060] Done with IsPeer call
I1220 01:53:59.401033 1 draft.go:1117] New Node for group: 1
I1220 01:53:59.401044 1 draft.go:1124] Trying to join peers.
I1220 01:53:59.401056 1 draft.go:1038] Calling JoinCluster via leader: dgraph-alpha-0.dgraph-alpha.dgraph.svc.cluster.local:7080
I1220 01:53:59.426988 1 draft.go:1042] Done with JoinCluster call
I1220 01:53:59.427075 1 node.go:83] 3 became follower at term 0
I1220 01:53:59.427172 1 node.go:83] newRaft 3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]
I1220 01:53:59.427188 1 node.go:83] 3 became follower at term 1
I1220 01:53:59.427316 1 groups.go:695] Got address of a Zero leader: dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080
I1220 01:53:59.427406 1 groups.go:708] Starting a new membership stream receive from dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080.
I1220 01:53:59.429175 1 groups.go:725] Received first state update from Zero: counter:14 groups:<key:1 value:<members:<key:1 value:<id:1 group_id:1 addr:"dgraph-alpha-0.dgraph-alpha.dgraph.svc.cluster.local:7080" leader:true last_update:1545270764 > > members:<key:2 value:<id:2 group_id:1 addr:"dgraph-alpha-1.dgraph-alpha.dgraph.svc.cluster.local:7080" > > members:<key:3 value:<id:3 group_id:1 addr:"dgraph-alpha-2.dgraph-alpha.dgraph.svc.cluster.local:7080" > > tablets:<key:"_predicate_" value:<group_id:1 predicate:"_predicate_" > > tablets:<key:"dgraph.group.acl" value:<group_id:1 predicate:"dgraph.group.acl" > > tablets:<key:"dgraph.password" value:<group_id:1 predicate:"dgraph.password" > > tablets:<key:"dgraph.user.group" value:<group_id:1 predicate:"dgraph.user.group" > > tablets:<key:"dgraph.xid" value:<group_id:1 predicate:"dgraph.xid" > > > > zeros:<key:1 value:<id:1 addr:"dgraph-zero-0.dgraph-zero.dgraph.svc.cluster.local:5080" leader:true > > zeros:<key:2 value:<id:2 addr:"dgraph-zero-1.dgraph-zero.dgraph.svc.cluster.local:5080" > > zeros:<key:3 value:<id:3 addr:"dgraph-zero-2.dgraph-zero.dgraph.svc.cluster.local:5080" > > maxRaftId:3 cid:"76d0c365-7a59-4384-bc5e-562cd63bc5c5"
I1220 01:54:00.435687 1 node.go:83] 3 [term: 1] received a MsgHeartbeat message with higher term from 1 [term: 2]
I1220 01:54:00.435722 1 node.go:83] 3 became follower at term 2
I1220 01:54:00.435751 1 node.go:83] raft.node: 3 elected leader 1 at term 2
I1220 01:54:00.444515 1 node.go:173] Setting conf state to nodes:1
I1220 01:54:00.444618 1 node.go:173] Setting conf state to nodes:1 nodes:2
I1220 01:54:00.444642 1 node.go:173] Setting conf state to nodes:1 nodes:2 nodes:3
I1220 01:54:00.444841 1 mutation.go:158] Done schema update predicate:"_predicate_" value_type:STRING list:true
I1220 01:54:00.454346 1 index.go:33] Deleting index for dgraph.xid
I1220 01:54:00.454379 1 index.go:38] Rebuilding index for dgraph.xid
I1220 01:54:00.454415 1 mutation.go:158] Done schema update predicate:"dgraph.xid" value_type:STRING directive:INDEX tokenizer:"exact"
I1220 01:54:00.456244 1 mutation.go:158] Done schema update predicate:"dgraph.password" value_type:PASSWORD
I1220 01:54:00.458074 1 index.go:48] Deleting reverse index for dgraph.user.group
I1220 01:54:00.458098 1 index.go:54] Rebuilding reverse index for dgraph.user.group
I1220 01:54:00.458136 1 mutation.go:158] Done schema update predicate:"dgraph.user.group" value_type:UID directive:REVERSE
I1220 01:54:00.459934 1 mutation.go:158] Done schema update predicate:"dgraph.group.acl" value_type:STRING
I1220 01:59:21.354541 1 groups.go:388] Serving tablet for: friends_with
I1220 02:00:16.581779 1 draft.go:323] Creating snapshot at index: 2167. ReadTs: 3803.
I1220 02:00:45.714893 1 draft.go:323] Creating snapshot at index: 3300. ReadTs: 5850.
I1220 02:01:15.869831 1 draft.go:323] Creating snapshot at index: 4455. ReadTs: 7882.
I1220 02:01:45.754702 1 draft.go:323] Creating snapshot at index: 5569. ReadTs: 9889.
I1220 02:02:15.893936 1 draft.go:323] Creating snapshot at index: 6673. ReadTs: 11825.
I1220 02:02:46.387172 1 draft.go:323] Creating snapshot at index: 7844. ReadTs: 13911.
I1220 02:03:15.183072 1 draft.go:323] Creating snapshot at index: 8197. ReadTs: 14552.
I1220 02:04:06.467110 1 stream.go:240] Rolling up Time elapsed: 07s, bytes sent: 47 MB, speed: 6.8 MB/sec
I1220 02:04:27.321566 1 stream.go:240] Rolling up Time elapsed: 27s, bytes sent: 187 MB, speed: 6.9 MB/sec
I1220 02:04:36.935886 1 stream.go:240] Rolling up Time elapsed: 37s, bytes sent: 258 MB, speed: 7.0 MB/sec
I1220 02:04:38.727573 1 stream.go:240] Rolling up Time elapsed: 39s, bytes sent: 275 MB, speed: 7.1 MB/sec
I1220 02:04:41.688247 1 stream.go:240] Rolling up Time elapsed: 42s, bytes sent: 284 MB, speed: 6.8 MB/sec
I1220 02:04:41.688274 1 stream.go:255] Rolling up Sent 3888684 keys
I1220 02:04:41.726461 1 draft.go:836] Rollup on disk done. Rolling up 3888684 keys in LRU cache now...
I1220 02:04:51.286941 1 draft.go:846] Rollup in LRU cache done.
I1220 02:04:51.286962 1 draft.go:364] List rollup at Ts 14552: OK.
I1220 02:04:51.442594 1 draft.go:323] Creating snapshot at index: 9859. ReadTs: 17551.
I1220 02:05:46.711106 1 draft.go:323] Creating snapshot at index: 11461. ReadTs: 20479.
I1220 02:08:15.301352 1 draft.go:323] Creating snapshot at index: 12297. ReadTs: 21982.
I1220 02:09:06.228595 1 stream.go:240] Rolling up Time elapsed: 06s, bytes sent: 56 MB, speed: 9.3 MB/sec
I1220 02:09:15.361241 1 stream.go:240] Rolling up Time elapsed: 15s, bytes sent: 144 MB, speed: 9.6 MB/sec
I1220 02:09:15.829276 1 stream.go:240] Rolling up Time elapsed: 16s, bytes sent: 149 MB, speed: 9.3 MB/sec
I1220 02:09:15.829301 1 stream.go:255] Rolling up Sent 1990834 keys
I1220 02:09:15.839208 1 draft.go:836] Rollup on disk done. Rolling up 1990834 keys in LRU cache now...
I1220 02:09:21.310341 1 draft.go:846] Rollup in LRU cache done.
I1220 02:09:21.310365 1 draft.go:364] List rollup at Ts 21982: OK.
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment