Skip to content

Instantly share code, notes, and snippets.

@tbg

tbg/-

Created August 4, 2015 06:00
Show Gist options
  • Save tbg/be8122421d3541e25aa1 to your computer and use it in GitHub Desktop.
Save tbg/be8122421d3541e25aa1 to your computer and use it in GitHub Desktop.
go test -tags '' -i ./storage
go test -tags '' -run TestRaftAfterRemoveRange -cpu 1 ./storage -timeout 10s -v --verbosity=5
=== RUN TestRaftAfterRemoveRange
I0804 02:00:52.359526 93842 storage/engine/rocksdb.go:99 opening in-memory rocksdb instance
I0804 02:00:52.364679 93842 storage/engine/rocksdb/rocksdb.go:43 RocksDB version: 3.10.1
I0804 02:00:52.364692 93842 storage/engine/rocksdb/rocksdb.go:43 Git sha rocksdb_build_git_sha:
I0804 02:00:52.364700 93842 storage/engine/rocksdb/rocksdb.go:43 Compile date Jul 26 2015
I0804 02:00:52.364711 93842 storage/engine/rocksdb/rocksdb.go:43 DB SUMMARY
I0804 02:00:52.364723 93842 storage/engine/rocksdb/rocksdb.go:43 SST files in dir, Total Num: 0, files:
I0804 02:00:52.364730 93842 storage/engine/rocksdb/rocksdb.go:43 Write Ahead Log file in :
I0804 02:00:52.364740 93842 storage/engine/rocksdb/rocksdb.go:43 Options.error_if_exists: 0
I0804 02:00:52.364753 93842 storage/engine/rocksdb/rocksdb.go:43 Options.create_if_missing: 1
I0804 02:00:52.364759 93842 storage/engine/rocksdb/rocksdb.go:43 Options.paranoid_checks: 1
I0804 02:00:52.364765 93842 storage/engine/rocksdb/rocksdb.go:43 Options.env: 0x560e890
I0804 02:00:52.364772 93842 storage/engine/rocksdb/rocksdb.go:43 Options.info_log: 0x5613960
I0804 02:00:52.364777 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_open_files: 5000
I0804 02:00:52.364784 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_total_wal_size: 0
I0804 02:00:52.364790 93842 storage/engine/rocksdb/rocksdb.go:43 Options.disableDataSync: 0
I0804 02:00:52.364797 93842 storage/engine/rocksdb/rocksdb.go:43 Options.use_fsync: 0
I0804 02:00:52.364803 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_log_file_size: 0
I0804 02:00:52.364809 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_manifest_file_size: 18446744073709551615
I0804 02:00:52.364824 93842 storage/engine/rocksdb/rocksdb.go:43 Options.log_file_time_to_roll: 0
I0804 02:00:52.364832 93842 storage/engine/rocksdb/rocksdb.go:43 Options.keep_log_file_num: 1000
I0804 02:00:52.364837 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_os_buffer: 1
I0804 02:00:52.364843 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_reads: 0
I0804 02:00:52.364849 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_writes: 0
I0804 02:00:52.364855 93842 storage/engine/rocksdb/rocksdb.go:43 Options.create_missing_column_families: 0
I0804 02:00:52.364861 93842 storage/engine/rocksdb/rocksdb.go:43 Options.db_log_dir:
I0804 02:00:52.364867 93842 storage/engine/rocksdb/rocksdb.go:43 Options.wal_dir:
I0804 02:00:52.364873 93842 storage/engine/rocksdb/rocksdb.go:43 Options.table_cache_numshardbits: 4
I0804 02:00:52.364903 93842 storage/engine/rocksdb/rocksdb.go:43 Options.delete_obsolete_files_period_micros: 21600000000
I0804 02:00:52.364916 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_background_compactions: 1
I0804 02:00:52.364923 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_background_flushes: 1
I0804 02:00:52.364929 93842 storage/engine/rocksdb/rocksdb.go:43 Options.WAL_ttl_seconds: 0
I0804 02:00:52.364935 93842 storage/engine/rocksdb/rocksdb.go:43 Options.WAL_size_limit_MB: 0
I0804 02:00:52.364941 93842 storage/engine/rocksdb/rocksdb.go:43 Options.manifest_preallocation_size: 4194304
I0804 02:00:52.364947 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_os_buffer: 1
I0804 02:00:52.364953 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_reads: 0
I0804 02:00:52.364959 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_writes: 0
I0804 02:00:52.364965 93842 storage/engine/rocksdb/rocksdb.go:43 Options.is_fd_close_on_exec: 1
I0804 02:00:52.364972 93842 storage/engine/rocksdb/rocksdb.go:43 Options.stats_dump_period_sec: 3600
I0804 02:00:52.364978 93842 storage/engine/rocksdb/rocksdb.go:43 Options.advise_random_on_open: 1
I0804 02:00:52.364984 93842 storage/engine/rocksdb/rocksdb.go:43 Options.db_write_buffer_size: 0
I0804 02:00:52.364995 93842 storage/engine/rocksdb/rocksdb.go:43 Options.access_hint_on_compaction_start: NORMAL
I0804 02:00:52.365009 93842 storage/engine/rocksdb/rocksdb.go:43 Options.use_adaptive_mutex: 0
I0804 02:00:52.365017 93842 storage/engine/rocksdb/rocksdb.go:43 Options.rate_limiter: 0x0
I0804 02:00:52.365023 93842 storage/engine/rocksdb/rocksdb.go:43 Options.bytes_per_sync: 0
I0804 02:00:52.365029 93842 storage/engine/rocksdb/rocksdb.go:43 Options.enable_thread_tracking: 0
I0804 02:00:52.365069 93842 storage/engine/rocksdb/rocksdb.go:43 Creating manifest 1
I0804 02:00:52.365157 93842 storage/engine/rocksdb/rocksdb.go:43 Recovering from manifest file: MANIFEST-000001
I0804 02:00:52.365923 93842 storage/engine/rocksdb/rocksdb.go:43 --------------- Options for column family [default]:
I0804 02:00:52.365933 93842 storage/engine/rocksdb/rocksdb.go:43 Options.error_if_exists: 0
I0804 02:00:52.365939 93842 storage/engine/rocksdb/rocksdb.go:43 Options.create_if_missing: 1
I0804 02:00:52.365944 93842 storage/engine/rocksdb/rocksdb.go:43 Options.paranoid_checks: 1
I0804 02:00:52.365950 93842 storage/engine/rocksdb/rocksdb.go:43 Options.env: 0x560e890
I0804 02:00:52.365956 93842 storage/engine/rocksdb/rocksdb.go:43 Options.info_log: 0x5613960
I0804 02:00:52.365962 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_open_files: 5000
I0804 02:00:52.365968 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_total_wal_size: 0
I0804 02:00:52.365975 93842 storage/engine/rocksdb/rocksdb.go:43 Options.disableDataSync: 0
I0804 02:00:52.365980 93842 storage/engine/rocksdb/rocksdb.go:43 Options.use_fsync: 0
I0804 02:00:52.365987 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_log_file_size: 0
I0804 02:00:52.365992 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_manifest_file_size: 18446744073709551615
I0804 02:00:52.366005 93842 storage/engine/rocksdb/rocksdb.go:43 Options.log_file_time_to_roll: 0
I0804 02:00:52.366012 93842 storage/engine/rocksdb/rocksdb.go:43 Options.keep_log_file_num: 1000
I0804 02:00:52.366018 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_os_buffer: 1
I0804 02:00:52.366024 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_reads: 0
I0804 02:00:52.366031 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_writes: 0
I0804 02:00:52.366036 93842 storage/engine/rocksdb/rocksdb.go:43 Options.create_missing_column_families: 0
I0804 02:00:52.366042 93842 storage/engine/rocksdb/rocksdb.go:43 Options.db_log_dir:
I0804 02:00:52.366074 93842 storage/engine/rocksdb/rocksdb.go:43 Options.wal_dir:
I0804 02:00:52.366086 93842 storage/engine/rocksdb/rocksdb.go:43 Options.table_cache_numshardbits: 4
I0804 02:00:52.366093 93842 storage/engine/rocksdb/rocksdb.go:43 Options.delete_obsolete_files_period_micros: 21600000000
I0804 02:00:52.366099 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_background_compactions: 1
I0804 02:00:52.366106 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_background_flushes: 1
I0804 02:00:52.366112 93842 storage/engine/rocksdb/rocksdb.go:43 Options.WAL_ttl_seconds: 0
I0804 02:00:52.366123 93842 storage/engine/rocksdb/rocksdb.go:43 Options.WAL_size_limit_MB: 0
I0804 02:00:52.366131 93842 storage/engine/rocksdb/rocksdb.go:43 Options.manifest_preallocation_size: 4194304
I0804 02:00:52.366138 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_os_buffer: 1
I0804 02:00:52.366145 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_reads: 0
I0804 02:00:52.366150 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_writes: 0
I0804 02:00:52.366156 93842 storage/engine/rocksdb/rocksdb.go:43 Options.is_fd_close_on_exec: 1
I0804 02:00:52.366162 93842 storage/engine/rocksdb/rocksdb.go:43 Options.stats_dump_period_sec: 3600
I0804 02:00:52.366183 93842 storage/engine/rocksdb/rocksdb.go:43 Options.advise_random_on_open: 1
I0804 02:00:52.366189 93842 storage/engine/rocksdb/rocksdb.go:43 Options.db_write_buffer_size: 0
I0804 02:00:52.366195 93842 storage/engine/rocksdb/rocksdb.go:43 Options.access_hint_on_compaction_start: NORMAL
I0804 02:00:52.366201 93842 storage/engine/rocksdb/rocksdb.go:43 Options.use_adaptive_mutex: 0
I0804 02:00:52.366215 93842 storage/engine/rocksdb/rocksdb.go:43 Options.rate_limiter: 0x0
I0804 02:00:52.366223 93842 storage/engine/rocksdb/rocksdb.go:43 Options.bytes_per_sync: 0
I0804 02:00:52.366229 93842 storage/engine/rocksdb/rocksdb.go:43 Options.enable_thread_tracking: 0
I0804 02:00:52.366240 93842 storage/engine/rocksdb/rocksdb.go:43 Options.comparator: rocksdb.InternalKeyComparator:leveldb.BytewiseComparator
I0804 02:00:52.366247 93842 storage/engine/rocksdb/rocksdb.go:43 Options.merge_operator: cockroach_merge_operator
I0804 02:00:52.366253 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_filter: None
I0804 02:00:52.366260 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_filter_factory: cockroach_compaction_filter_factory
I0804 02:00:52.366266 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_filter_factory_v2: DefaultCompactionFilterFactoryV2
I0804 02:00:52.366273 93842 storage/engine/rocksdb/rocksdb.go:43 Options.memtable_factory: SkipListFactory
I0804 02:00:52.366279 93842 storage/engine/rocksdb/rocksdb.go:43 Options.table_factory: BlockBasedTable
I0804 02:00:52.366300 93842 storage/engine/rocksdb/rocksdb.go:43 table_factory options: flush_block_policy_factory: FlushBlockBySizePolicyFactory (0x56076f0)
cache_index_and_filter_blocks: 0
index_type: 0
hash_index_allow_collision: 1
checksum: 1
no_block_cache: 0
block_cache: 0x5619718
block_cache_size: 1048576
block_cache_compressed: 0x0
block_size: 4096
block_size_deviation: 10
block_restart_interval: 16
filter_policy: nullptr
format_version: 0
I0804 02:00:52.366314 93842 storage/engine/rocksdb/rocksdb.go:43 Options.write_buffer_size: 67108864
I0804 02:00:52.366322 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_write_buffer_number: 2
I0804 02:00:52.366328 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compression: 1
I0804 02:00:52.366336 93842 storage/engine/rocksdb/rocksdb.go:43 Options.prefix_extractor: nullptr
I0804 02:00:52.366341 93842 storage/engine/rocksdb/rocksdb.go:43 Options.num_levels: 7
I0804 02:00:52.366348 93842 storage/engine/rocksdb/rocksdb.go:43 Options.min_write_buffer_number_to_merge: 1
I0804 02:00:52.366355 93842 storage/engine/rocksdb/rocksdb.go:43 Options.purge_redundant_kvs_while_flush: 1
I0804 02:00:52.366361 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compression_opts.window_bits: -14
I0804 02:00:52.366368 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compression_opts.level: -1
I0804 02:00:52.366374 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compression_opts.strategy: 0
I0804 02:00:52.366380 93842 storage/engine/rocksdb/rocksdb.go:43 Options.level0_file_num_compaction_trigger: 4
I0804 02:00:52.366386 93842 storage/engine/rocksdb/rocksdb.go:43 Options.level0_slowdown_writes_trigger: 20
I0804 02:00:52.366392 93842 storage/engine/rocksdb/rocksdb.go:43 Options.level0_stop_writes_trigger: 24
I0804 02:00:52.366397 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_mem_compaction_level: 2
I0804 02:00:52.366403 93842 storage/engine/rocksdb/rocksdb.go:43 Options.target_file_size_base: 67108864
I0804 02:00:52.366410 93842 storage/engine/rocksdb/rocksdb.go:43 Options.target_file_size_multiplier: 1
I0804 02:00:52.366416 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_base: 536870912
I0804 02:00:52.366422 93842 storage/engine/rocksdb/rocksdb.go:43 Options.level_compaction_dynamic_level_bytes: 0
I0804 02:00:52.366429 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier: 10
I0804 02:00:52.366435 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[0]: 1
I0804 02:00:52.366441 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[1]: 1
I0804 02:00:52.366447 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[2]: 1
I0804 02:00:52.366452 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[3]: 1
I0804 02:00:52.366459 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[4]: 1
I0804 02:00:52.366464 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[5]: 1
I0804 02:00:52.366471 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[6]: 1
I0804 02:00:52.366477 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_sequential_skip_in_iterations: 8
I0804 02:00:52.366483 93842 storage/engine/rocksdb/rocksdb.go:43 Options.expanded_compaction_factor: 25
I0804 02:00:52.366490 93842 storage/engine/rocksdb/rocksdb.go:43 Options.source_compaction_factor: 1
I0804 02:00:52.366495 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_grandparent_overlap_factor: 10
I0804 02:00:52.366507 93842 storage/engine/rocksdb/rocksdb.go:43 Options.arena_block_size: 6710886
I0804 02:00:52.366526 93842 storage/engine/rocksdb/rocksdb.go:43 Options.soft_rate_limit: 0.00
I0804 02:00:52.366535 93842 storage/engine/rocksdb/rocksdb.go:43 Options.hard_rate_limit: 0.00
I0804 02:00:52.366541 93842 storage/engine/rocksdb/rocksdb.go:43 Options.rate_limit_delay_max_milliseconds: 1000
I0804 02:00:52.366547 93842 storage/engine/rocksdb/rocksdb.go:43 Options.disable_auto_compactions: 0
I0804 02:00:52.366554 93842 storage/engine/rocksdb/rocksdb.go:43 Options.purge_redundant_kvs_while_flush: 1
I0804 02:00:52.366567 93842 storage/engine/rocksdb/rocksdb.go:43 Options.filter_deletes: 0
I0804 02:00:52.366573 93842 storage/engine/rocksdb/rocksdb.go:43 Options.verify_checksums_in_compaction: 1
I0804 02:00:52.366579 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_style: 0
I0804 02:00:52.366590 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_universal.size_ratio: 1
I0804 02:00:52.366597 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_universal.min_merge_width: 2
I0804 02:00:52.366602 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_universal.max_merge_width: 4294967295
I0804 02:00:52.366609 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_universal.max_size_amplification_percent: 200
I0804 02:00:52.366615 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_universal.compression_size_percent: -1
I0804 02:00:52.366622 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_fifo.max_table_files_size: 1073741824
I0804 02:00:52.366629 93842 storage/engine/rocksdb/rocksdb.go:43 Options.table_properties_collectors: InternalKeyPropertiesCollectorFactory;
I0804 02:00:52.366635 93842 storage/engine/rocksdb/rocksdb.go:43 Options.inplace_update_support: 0
I0804 02:00:52.366641 93842 storage/engine/rocksdb/rocksdb.go:43 Options.inplace_update_num_locks: 10000
I0804 02:00:52.366647 93842 storage/engine/rocksdb/rocksdb.go:43 Options.min_partial_merge_operands: 2
I0804 02:00:52.366653 93842 storage/engine/rocksdb/rocksdb.go:43 Options.memtable_prefix_bloom_bits: 0
I0804 02:00:52.366659 93842 storage/engine/rocksdb/rocksdb.go:43 Options.memtable_prefix_bloom_probes: 6
I0804 02:00:52.366665 93842 storage/engine/rocksdb/rocksdb.go:43 Options.memtable_prefix_bloom_huge_page_tlb_size: 0
I0804 02:00:52.366671 93842 storage/engine/rocksdb/rocksdb.go:43 Options.bloom_locality: 0
I0804 02:00:52.366677 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_successive_merges: 0
I0804 02:00:52.366683 93842 storage/engine/rocksdb/rocksdb.go:43 Options.optimize_fllters_for_hits: 0
I0804 02:00:52.366756 93842 storage/engine/rocksdb/rocksdb.go:43 Recovered from manifest file:/MANIFEST-000001 succeeded,manifest_file_number is 1, next_file_number is 3, last_sequence is 0, log_number is 0,prev_log_number is 0,max_column_family is 0
I0804 02:00:52.366765 93842 storage/engine/rocksdb/rocksdb.go:43 Column family [default] (ID 0), log number is 0
I0804 02:00:52.366846 93842 storage/engine/rocksdb/rocksdb.go:43 DB pointer 0x580e000
W0804 02:00:52.370931 93842 rpc/tls.go:41 listening via tcp to 127.0.0.1:0 without TLS
I0804 02:00:52.372316 93842 multiraft/multiraft.go:454 node 100000001 starting
I0804 02:00:52.372942 93842 storage/range.go:986 gossiping cluster id from store 1, range 1
I0804 02:00:52.373689 93842 multiraft/multiraft.go:665 node 100000001 creating group 1
I0804 02:00:52.374525 93842 raft/raft.go:390 100000001 became follower at term 5
I0804 02:00:52.374589 93842 raft/raft.go:207 newRaft 100000001 [peers: [100000001], term: 5, commit: 10, applied: 10, lastindex: 10, lastterm: 5]
I0804 02:00:52.374640 93842 raft/raft.go:464 100000001 is starting a new election at term 5
I0804 02:00:52.374663 93842 raft/raft.go:403 100000001 became candidate at term 6
I0804 02:00:52.374686 93842 raft/raft.go:447 100000001 received vote from 100000001 at term 6
I0804 02:00:52.374720 93842 raft/raft.go:426 100000001 became leader at term 6
I0804 02:00:52.375458 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.376170 93842 multiraft/multiraft.go:778 SoftState updated: {Lead:4294967297 RaftState:StateLeader}
I0804 02:00:52.376231 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:11 XXX_unrecognized:[]}
I0804 02:00:52.376270 93842 multiraft/multiraft.go:784 New Entry[0]: 6/11 EntryNormal [empty]
I0804 02:00:52.376303 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/11 EntryNormal [empty]
I0804 02:00:52.376446 93842 multiraft/multiraft.go:767 group 1: new proposal 000000000000000078629a0f5f3f164f
I0804 02:00:52.376501 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.376515 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:12 XXX_unrecognized:[]}
I0804 02:00:52.377435 93842 multiraft/multiraft.go:784 New Entry[0]: 6/12 EntryNormal 000000000000000078629a0f5f3f164f: raft_id:1 origin_node_id:100000001 cmd:<internal_lease:<header:<timestamp:<wall_time:0 logical:4 > cmd_id:<wall_time:0 random:8674665223082153551 > k
I0804 02:00:52.377498 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/12 EntryNormal 000000000000000078629a0f5f3f164f: raft_id:1 origin_node_id:100000001 cmd:<internal_lease:<header:<timestamp:<wall_time:0 logical:4 > cmd_id:<wall_time:0 random:8674665223082153551 > k
I0804 02:00:52.377793 93842 storage/range_command.go:932 range 1: new leader lease replica 1:1 19:00:00.000 +1.000s
I0804 02:00:52.377893 93842 storage/range.go:1053 gossiping accounting config from store 1, range 1
I0804 02:00:52.377949 93842 storage/range.go:1053 gossiping permissions config from store 1, range 1
I0804 02:00:52.377992 93842 storage/range.go:1053 gossiping user config from store 1, range 1
I0804 02:00:52.378036 93842 storage/range.go:1053 gossiping zones config from store 1, range 1
I0804 02:00:52.381172 93842 storage/range_command.go:135 executed InternalLeaderLease command header:<timestamp:<wall_time:0 logical:4 > cmd_id:<wall_time:0 random:8674665223082153551 > key:"" user:"" replica:<node_id:0 store_id:0 > raft_id:0 read_consistency:CONSISTENT > lease:<start:<wall_time:0 logical:4 > expiration:<wall_time:1000000000 logical:4 > raft_node_id:100000001 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.381303 93842 storage/range.go:994 gossiping sentinel from store 1, range 1
I0804 02:00:52.381342 93842 storage/range.go:998 gossiping first range from store 1, range 1
I0804 02:00:52.381462 93842 storage/engine/rocksdb.go:99 opening in-memory rocksdb instance
I0804 02:00:52.381559 93842 storage/engine/rocksdb/rocksdb.go:43 RocksDB version: 3.10.1
I0804 02:00:52.381569 93842 storage/engine/rocksdb/rocksdb.go:43 Git sha rocksdb_build_git_sha:
I0804 02:00:52.381575 93842 storage/engine/rocksdb/rocksdb.go:43 Compile date Jul 26 2015
I0804 02:00:52.381582 93842 storage/engine/rocksdb/rocksdb.go:43 DB SUMMARY
I0804 02:00:52.381599 93842 storage/engine/rocksdb/rocksdb.go:43 SST files in dir, Total Num: 0, files:
I0804 02:00:52.381605 93842 storage/engine/rocksdb/rocksdb.go:43 Write Ahead Log file in :
I0804 02:00:52.381613 93842 storage/engine/rocksdb/rocksdb.go:43 Options.error_if_exists: 0
I0804 02:00:52.381620 93842 storage/engine/rocksdb/rocksdb.go:43 Options.create_if_missing: 1
I0804 02:00:52.381625 93842 storage/engine/rocksdb/rocksdb.go:43 Options.paranoid_checks: 1
I0804 02:00:52.381631 93842 storage/engine/rocksdb/rocksdb.go:43 Options.env: 0x561bdf0
I0804 02:00:52.381638 93842 storage/engine/rocksdb/rocksdb.go:43 Options.info_log: 0x5619b40
I0804 02:00:52.381644 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_open_files: 5000
I0804 02:00:52.381649 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_total_wal_size: 0
I0804 02:00:52.381657 93842 storage/engine/rocksdb/rocksdb.go:43 Options.disableDataSync: 0
I0804 02:00:52.381663 93842 storage/engine/rocksdb/rocksdb.go:43 Options.use_fsync: 0
I0804 02:00:52.381669 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_log_file_size: 0
I0804 02:00:52.381675 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_manifest_file_size: 18446744073709551615
I0804 02:00:52.381681 93842 storage/engine/rocksdb/rocksdb.go:43 Options.log_file_time_to_roll: 0
I0804 02:00:52.381688 93842 storage/engine/rocksdb/rocksdb.go:43 Options.keep_log_file_num: 1000
I0804 02:00:52.381698 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_os_buffer: 1
I0804 02:00:52.381704 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_reads: 0
I0804 02:00:52.381711 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_writes: 0
I0804 02:00:52.381717 93842 storage/engine/rocksdb/rocksdb.go:43 Options.create_missing_column_families: 0
I0804 02:00:52.381724 93842 storage/engine/rocksdb/rocksdb.go:43 Options.db_log_dir:
I0804 02:00:52.381731 93842 storage/engine/rocksdb/rocksdb.go:43 Options.wal_dir:
I0804 02:00:52.381736 93842 storage/engine/rocksdb/rocksdb.go:43 Options.table_cache_numshardbits: 4
I0804 02:00:52.381743 93842 storage/engine/rocksdb/rocksdb.go:43 Options.delete_obsolete_files_period_micros: 21600000000
I0804 02:00:52.381749 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_background_compactions: 1
I0804 02:00:52.381755 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_background_flushes: 1
I0804 02:00:52.381762 93842 storage/engine/rocksdb/rocksdb.go:43 Options.WAL_ttl_seconds: 0
I0804 02:00:52.381770 93842 storage/engine/rocksdb/rocksdb.go:43 Options.WAL_size_limit_MB: 0
I0804 02:00:52.381776 93842 storage/engine/rocksdb/rocksdb.go:43 Options.manifest_preallocation_size: 4194304
I0804 02:00:52.381781 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_os_buffer: 1
I0804 02:00:52.381787 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_reads: 0
I0804 02:00:52.381794 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_writes: 0
I0804 02:00:52.381800 93842 storage/engine/rocksdb/rocksdb.go:43 Options.is_fd_close_on_exec: 1
I0804 02:00:52.381811 93842 storage/engine/rocksdb/rocksdb.go:43 Options.stats_dump_period_sec: 3600
I0804 02:00:52.381816 93842 storage/engine/rocksdb/rocksdb.go:43 Options.advise_random_on_open: 1
I0804 02:00:52.381822 93842 storage/engine/rocksdb/rocksdb.go:43 Options.db_write_buffer_size: 0
I0804 02:00:52.381829 93842 storage/engine/rocksdb/rocksdb.go:43 Options.access_hint_on_compaction_start: NORMAL
I0804 02:00:52.381835 93842 storage/engine/rocksdb/rocksdb.go:43 Options.use_adaptive_mutex: 0
I0804 02:00:52.381841 93842 storage/engine/rocksdb/rocksdb.go:43 Options.rate_limiter: 0x0
I0804 02:00:52.381847 93842 storage/engine/rocksdb/rocksdb.go:43 Options.bytes_per_sync: 0
I0804 02:00:52.381853 93842 storage/engine/rocksdb/rocksdb.go:43 Options.enable_thread_tracking: 0
I0804 02:00:52.381867 93842 storage/engine/rocksdb/rocksdb.go:43 Creating manifest 1
I0804 02:00:52.381907 93842 storage/engine/rocksdb/rocksdb.go:43 Recovering from manifest file: MANIFEST-000001
I0804 02:00:52.381961 93842 storage/engine/rocksdb/rocksdb.go:43 --------------- Options for column family [default]:
I0804 02:00:52.381968 93842 storage/engine/rocksdb/rocksdb.go:43 Options.error_if_exists: 0
I0804 02:00:52.381974 93842 storage/engine/rocksdb/rocksdb.go:43 Options.create_if_missing: 1
I0804 02:00:52.381979 93842 storage/engine/rocksdb/rocksdb.go:43 Options.paranoid_checks: 1
I0804 02:00:52.381985 93842 storage/engine/rocksdb/rocksdb.go:43 Options.env: 0x561bdf0
I0804 02:00:52.381990 93842 storage/engine/rocksdb/rocksdb.go:43 Options.info_log: 0x5619b40
I0804 02:00:52.381995 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_open_files: 5000
I0804 02:00:52.382001 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_total_wal_size: 0
I0804 02:00:52.382006 93842 storage/engine/rocksdb/rocksdb.go:43 Options.disableDataSync: 0
I0804 02:00:52.382012 93842 storage/engine/rocksdb/rocksdb.go:43 Options.use_fsync: 0
I0804 02:00:52.382018 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_log_file_size: 0
I0804 02:00:52.382023 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_manifest_file_size: 18446744073709551615
I0804 02:00:52.382028 93842 storage/engine/rocksdb/rocksdb.go:43 Options.log_file_time_to_roll: 0
I0804 02:00:52.382036 93842 storage/engine/rocksdb/rocksdb.go:43 Options.keep_log_file_num: 1000
I0804 02:00:52.382041 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_os_buffer: 1
I0804 02:00:52.382047 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_reads: 0
I0804 02:00:52.382052 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_writes: 0
I0804 02:00:52.382058 93842 storage/engine/rocksdb/rocksdb.go:43 Options.create_missing_column_families: 0
I0804 02:00:52.382063 93842 storage/engine/rocksdb/rocksdb.go:43 Options.db_log_dir:
I0804 02:00:52.382068 93842 storage/engine/rocksdb/rocksdb.go:43 Options.wal_dir:
I0804 02:00:52.382074 93842 storage/engine/rocksdb/rocksdb.go:43 Options.table_cache_numshardbits: 4
I0804 02:00:52.382079 93842 storage/engine/rocksdb/rocksdb.go:43 Options.delete_obsolete_files_period_micros: 21600000000
I0804 02:00:52.382084 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_background_compactions: 1
I0804 02:00:52.382089 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_background_flushes: 1
I0804 02:00:52.382095 93842 storage/engine/rocksdb/rocksdb.go:43 Options.WAL_ttl_seconds: 0
I0804 02:00:52.382100 93842 storage/engine/rocksdb/rocksdb.go:43 Options.WAL_size_limit_MB: 0
I0804 02:00:52.382107 93842 storage/engine/rocksdb/rocksdb.go:43 Options.manifest_preallocation_size: 4194304
I0804 02:00:52.382113 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_os_buffer: 1
I0804 02:00:52.382118 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_reads: 0
I0804 02:00:52.382123 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_writes: 0
I0804 02:00:52.382129 93842 storage/engine/rocksdb/rocksdb.go:43 Options.is_fd_close_on_exec: 1
I0804 02:00:52.382135 93842 storage/engine/rocksdb/rocksdb.go:43 Options.stats_dump_period_sec: 3600
I0804 02:00:52.382140 93842 storage/engine/rocksdb/rocksdb.go:43 Options.advise_random_on_open: 1
I0804 02:00:52.382146 93842 storage/engine/rocksdb/rocksdb.go:43 Options.db_write_buffer_size: 0
I0804 02:00:52.382151 93842 storage/engine/rocksdb/rocksdb.go:43 Options.access_hint_on_compaction_start: NORMAL
I0804 02:00:52.382157 93842 storage/engine/rocksdb/rocksdb.go:43 Options.use_adaptive_mutex: 0
I0804 02:00:52.382162 93842 storage/engine/rocksdb/rocksdb.go:43 Options.rate_limiter: 0x0
I0804 02:00:52.382168 93842 storage/engine/rocksdb/rocksdb.go:43 Options.bytes_per_sync: 0
I0804 02:00:52.382174 93842 storage/engine/rocksdb/rocksdb.go:43 Options.enable_thread_tracking: 0
I0804 02:00:52.382180 93842 storage/engine/rocksdb/rocksdb.go:43 Options.comparator: rocksdb.InternalKeyComparator:leveldb.BytewiseComparator
I0804 02:00:52.382185 93842 storage/engine/rocksdb/rocksdb.go:43 Options.merge_operator: cockroach_merge_operator
I0804 02:00:52.382192 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_filter: None
I0804 02:00:52.382197 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_filter_factory: cockroach_compaction_filter_factory
I0804 02:00:52.382202 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_filter_factory_v2: DefaultCompactionFilterFactoryV2
I0804 02:00:52.382207 93842 storage/engine/rocksdb/rocksdb.go:43 Options.memtable_factory: SkipListFactory
I0804 02:00:52.382213 93842 storage/engine/rocksdb/rocksdb.go:43 Options.table_factory: BlockBasedTable
I0804 02:00:52.382227 93842 storage/engine/rocksdb/rocksdb.go:43 table_factory options: flush_block_policy_factory: FlushBlockBySizePolicyFactory (0x561c860)
cache_index_and_filter_blocks: 0
index_type: 0
hash_index_allow_collision: 1
checksum: 1
no_block_cache: 0
block_cache: 0x561b508
block_cache_size: 1048576
block_cache_compressed: 0x0
block_size: 4096
block_size_deviation: 10
block_restart_interval: 16
filter_policy: nullptr
format_version: 0
I0804 02:00:52.382237 93842 storage/engine/rocksdb/rocksdb.go:43 Options.write_buffer_size: 67108864
I0804 02:00:52.382244 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_write_buffer_number: 2
I0804 02:00:52.382249 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compression: 1
I0804 02:00:52.382254 93842 storage/engine/rocksdb/rocksdb.go:43 Options.prefix_extractor: nullptr
I0804 02:00:52.382260 93842 storage/engine/rocksdb/rocksdb.go:43 Options.num_levels: 7
I0804 02:00:52.382265 93842 storage/engine/rocksdb/rocksdb.go:43 Options.min_write_buffer_number_to_merge: 1
I0804 02:00:52.382270 93842 storage/engine/rocksdb/rocksdb.go:43 Options.purge_redundant_kvs_while_flush: 1
I0804 02:00:52.382275 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compression_opts.window_bits: -14
I0804 02:00:52.382281 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compression_opts.level: -1
I0804 02:00:52.382287 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compression_opts.strategy: 0
I0804 02:00:52.382292 93842 storage/engine/rocksdb/rocksdb.go:43 Options.level0_file_num_compaction_trigger: 4
I0804 02:00:52.382298 93842 storage/engine/rocksdb/rocksdb.go:43 Options.level0_slowdown_writes_trigger: 20
I0804 02:00:52.382303 93842 storage/engine/rocksdb/rocksdb.go:43 Options.level0_stop_writes_trigger: 24
I0804 02:00:52.382308 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_mem_compaction_level: 2
I0804 02:00:52.382314 93842 storage/engine/rocksdb/rocksdb.go:43 Options.target_file_size_base: 67108864
I0804 02:00:52.382320 93842 storage/engine/rocksdb/rocksdb.go:43 Options.target_file_size_multiplier: 1
I0804 02:00:52.382325 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_base: 536870912
I0804 02:00:52.382330 93842 storage/engine/rocksdb/rocksdb.go:43 Options.level_compaction_dynamic_level_bytes: 0
I0804 02:00:52.382336 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier: 10
I0804 02:00:52.382347 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[0]: 1
I0804 02:00:52.382359 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[1]: 1
I0804 02:00:52.382367 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[2]: 1
I0804 02:00:52.382373 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[3]: 1
I0804 02:00:52.382379 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[4]: 1
I0804 02:00:52.382385 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[5]: 1
I0804 02:00:52.382391 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[6]: 1
I0804 02:00:52.382397 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_sequential_skip_in_iterations: 8
I0804 02:00:52.382403 93842 storage/engine/rocksdb/rocksdb.go:43 Options.expanded_compaction_factor: 25
I0804 02:00:52.382408 93842 storage/engine/rocksdb/rocksdb.go:43 Options.source_compaction_factor: 1
I0804 02:00:52.382415 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_grandparent_overlap_factor: 10
I0804 02:00:52.382421 93842 storage/engine/rocksdb/rocksdb.go:43 Options.arena_block_size: 6710886
I0804 02:00:52.382429 93842 storage/engine/rocksdb/rocksdb.go:43 Options.soft_rate_limit: 0.00
I0804 02:00:52.382435 93842 storage/engine/rocksdb/rocksdb.go:43 Options.hard_rate_limit: 0.00
I0804 02:00:52.382442 93842 storage/engine/rocksdb/rocksdb.go:43 Options.rate_limit_delay_max_milliseconds: 1000
I0804 02:00:52.382448 93842 storage/engine/rocksdb/rocksdb.go:43 Options.disable_auto_compactions: 0
I0804 02:00:52.382454 93842 storage/engine/rocksdb/rocksdb.go:43 Options.purge_redundant_kvs_while_flush: 1
I0804 02:00:52.382460 93842 storage/engine/rocksdb/rocksdb.go:43 Options.filter_deletes: 0
I0804 02:00:52.382466 93842 storage/engine/rocksdb/rocksdb.go:43 Options.verify_checksums_in_compaction: 1
I0804 02:00:52.382472 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_style: 0
I0804 02:00:52.382479 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_universal.size_ratio: 1
I0804 02:00:52.382484 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_universal.min_merge_width: 2
I0804 02:00:52.382495 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_universal.max_merge_width: 4294967295
I0804 02:00:52.382528 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_universal.max_size_amplification_percent: 200
I0804 02:00:52.382540 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_universal.compression_size_percent: -1
I0804 02:00:52.382546 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_fifo.max_table_files_size: 1073741824
I0804 02:00:52.382555 93842 storage/engine/rocksdb/rocksdb.go:43 Options.table_properties_collectors: InternalKeyPropertiesCollectorFactory;
I0804 02:00:52.382561 93842 storage/engine/rocksdb/rocksdb.go:43 Options.inplace_update_support: 0
I0804 02:00:52.382567 93842 storage/engine/rocksdb/rocksdb.go:43 Options.inplace_update_num_locks: 10000
I0804 02:00:52.382573 93842 storage/engine/rocksdb/rocksdb.go:43 Options.min_partial_merge_operands: 2
I0804 02:00:52.382579 93842 storage/engine/rocksdb/rocksdb.go:43 Options.memtable_prefix_bloom_bits: 0
I0804 02:00:52.382584 93842 storage/engine/rocksdb/rocksdb.go:43 Options.memtable_prefix_bloom_probes: 6
I0804 02:00:52.382595 93842 storage/engine/rocksdb/rocksdb.go:43 Options.memtable_prefix_bloom_huge_page_tlb_size: 0
I0804 02:00:52.382600 93842 storage/engine/rocksdb/rocksdb.go:43 Options.bloom_locality: 0
I0804 02:00:52.382605 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_successive_merges: 0
I0804 02:00:52.382611 93842 storage/engine/rocksdb/rocksdb.go:43 Options.optimize_fllters_for_hits: 0
I0804 02:00:52.382649 93842 storage/engine/rocksdb/rocksdb.go:43 Recovered from manifest file:/MANIFEST-000001 succeeded,manifest_file_number is 1, next_file_number is 3, last_sequence is 0, log_number is 0,prev_log_number is 0,max_column_family is 0
I0804 02:00:52.382657 93842 storage/engine/rocksdb/rocksdb.go:43 Column family [default] (ID 0), log number is 0
I0804 02:00:52.382693 93842 storage/engine/rocksdb/rocksdb.go:43 DB pointer 0x6016000
W0804 02:00:52.382826 93842 rpc/tls.go:41 listening via tcp to 127.0.0.1:0 without TLS
I0804 02:00:52.382951 93842 multiraft/multiraft.go:454 node 200000002 starting
I0804 02:00:52.382989 93842 storage/engine/rocksdb.go:99 opening in-memory rocksdb instance
I0804 02:00:52.383054 93842 storage/engine/rocksdb/rocksdb.go:43 RocksDB version: 3.10.1
I0804 02:00:52.383062 93842 storage/engine/rocksdb/rocksdb.go:43 Git sha rocksdb_build_git_sha:
I0804 02:00:52.383067 93842 storage/engine/rocksdb/rocksdb.go:43 Compile date Jul 26 2015
I0804 02:00:52.383078 93842 storage/engine/rocksdb/rocksdb.go:43 DB SUMMARY
I0804 02:00:52.383085 93842 storage/engine/rocksdb/rocksdb.go:43 SST files in dir, Total Num: 0, files:
I0804 02:00:52.383090 93842 storage/engine/rocksdb/rocksdb.go:43 Write Ahead Log file in :
I0804 02:00:52.383095 93842 storage/engine/rocksdb/rocksdb.go:43 Options.error_if_exists: 0
I0804 02:00:52.383100 93842 storage/engine/rocksdb/rocksdb.go:43 Options.create_if_missing: 1
I0804 02:00:52.383105 93842 storage/engine/rocksdb/rocksdb.go:43 Options.paranoid_checks: 1
I0804 02:00:52.383110 93842 storage/engine/rocksdb/rocksdb.go:43 Options.env: 0x6a01540
I0804 02:00:52.383157 93842 storage/engine/rocksdb/rocksdb.go:43 Options.info_log: 0x6a00610
I0804 02:00:52.383164 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_open_files: 5000
I0804 02:00:52.383168 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_total_wal_size: 0
I0804 02:00:52.383173 93842 storage/engine/rocksdb/rocksdb.go:43 Options.disableDataSync: 0
I0804 02:00:52.383178 93842 storage/engine/rocksdb/rocksdb.go:43 Options.use_fsync: 0
I0804 02:00:52.383182 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_log_file_size: 0
I0804 02:00:52.383187 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_manifest_file_size: 18446744073709551615
I0804 02:00:52.383192 93842 storage/engine/rocksdb/rocksdb.go:43 Options.log_file_time_to_roll: 0
I0804 02:00:52.383197 93842 storage/engine/rocksdb/rocksdb.go:43 Options.keep_log_file_num: 1000
I0804 02:00:52.383202 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_os_buffer: 1
I0804 02:00:52.383207 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_reads: 0
I0804 02:00:52.383212 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_writes: 0
I0804 02:00:52.383216 93842 storage/engine/rocksdb/rocksdb.go:43 Options.create_missing_column_families: 0
I0804 02:00:52.383221 93842 storage/engine/rocksdb/rocksdb.go:43 Options.db_log_dir:
I0804 02:00:52.383226 93842 storage/engine/rocksdb/rocksdb.go:43 Options.wal_dir:
I0804 02:00:52.383231 93842 storage/engine/rocksdb/rocksdb.go:43 Options.table_cache_numshardbits: 4
I0804 02:00:52.383237 93842 storage/engine/rocksdb/rocksdb.go:43 Options.delete_obsolete_files_period_micros: 21600000000
I0804 02:00:52.383241 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_background_compactions: 1
I0804 02:00:52.383246 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_background_flushes: 1
I0804 02:00:52.383250 93842 storage/engine/rocksdb/rocksdb.go:43 Options.WAL_ttl_seconds: 0
I0804 02:00:52.383255 93842 storage/engine/rocksdb/rocksdb.go:43 Options.WAL_size_limit_MB: 0
I0804 02:00:52.383260 93842 storage/engine/rocksdb/rocksdb.go:43 Options.manifest_preallocation_size: 4194304
I0804 02:00:52.383265 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_os_buffer: 1
I0804 02:00:52.383270 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_reads: 0
I0804 02:00:52.383274 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_writes: 0
I0804 02:00:52.383280 93842 storage/engine/rocksdb/rocksdb.go:43 Options.is_fd_close_on_exec: 1
I0804 02:00:52.383284 93842 storage/engine/rocksdb/rocksdb.go:43 Options.stats_dump_period_sec: 3600
I0804 02:00:52.383293 93842 storage/engine/rocksdb/rocksdb.go:43 Options.advise_random_on_open: 1
I0804 02:00:52.383299 93842 storage/engine/rocksdb/rocksdb.go:43 Options.db_write_buffer_size: 0
I0804 02:00:52.383304 93842 storage/engine/rocksdb/rocksdb.go:43 Options.access_hint_on_compaction_start: NORMAL
I0804 02:00:52.383309 93842 storage/engine/rocksdb/rocksdb.go:43 Options.use_adaptive_mutex: 0
I0804 02:00:52.383314 93842 storage/engine/rocksdb/rocksdb.go:43 Options.rate_limiter: 0x0
I0804 02:00:52.383319 93842 storage/engine/rocksdb/rocksdb.go:43 Options.bytes_per_sync: 0
I0804 02:00:52.383324 93842 storage/engine/rocksdb/rocksdb.go:43 Options.enable_thread_tracking: 0
I0804 02:00:52.383333 93842 storage/engine/rocksdb/rocksdb.go:43 Creating manifest 1
I0804 02:00:52.383364 93842 storage/engine/rocksdb/rocksdb.go:43 Recovering from manifest file: MANIFEST-000001
I0804 02:00:52.383381 93842 storage/engine/rocksdb/rocksdb.go:43 --------------- Options for column family [default]:
I0804 02:00:52.383386 93842 storage/engine/rocksdb/rocksdb.go:43 Options.error_if_exists: 0
I0804 02:00:52.383392 93842 storage/engine/rocksdb/rocksdb.go:43 Options.create_if_missing: 1
I0804 02:00:52.383397 93842 storage/engine/rocksdb/rocksdb.go:43 Options.paranoid_checks: 1
I0804 02:00:52.383410 93842 storage/engine/rocksdb/rocksdb.go:43 Options.env: 0x6a01540
I0804 02:00:52.383415 93842 storage/engine/rocksdb/rocksdb.go:43 Options.info_log: 0x6a00610
I0804 02:00:52.383420 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_open_files: 5000
I0804 02:00:52.383425 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_total_wal_size: 0
I0804 02:00:52.383430 93842 storage/engine/rocksdb/rocksdb.go:43 Options.disableDataSync: 0
I0804 02:00:52.383435 93842 storage/engine/rocksdb/rocksdb.go:43 Options.use_fsync: 0
I0804 02:00:52.383439 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_log_file_size: 0
I0804 02:00:52.383444 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_manifest_file_size: 18446744073709551615
I0804 02:00:52.383450 93842 storage/engine/rocksdb/rocksdb.go:43 Options.log_file_time_to_roll: 0
I0804 02:00:52.383455 93842 storage/engine/rocksdb/rocksdb.go:43 Options.keep_log_file_num: 1000
I0804 02:00:52.383460 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_os_buffer: 1
I0804 02:00:52.383465 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_reads: 0
I0804 02:00:52.383469 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_writes: 0
I0804 02:00:52.383474 93842 storage/engine/rocksdb/rocksdb.go:43 Options.create_missing_column_families: 0
I0804 02:00:52.383479 93842 storage/engine/rocksdb/rocksdb.go:43 Options.db_log_dir:
I0804 02:00:52.383489 93842 storage/engine/rocksdb/rocksdb.go:43 Options.wal_dir:
I0804 02:00:52.383495 93842 storage/engine/rocksdb/rocksdb.go:43 Options.table_cache_numshardbits: 4
I0804 02:00:52.383500 93842 storage/engine/rocksdb/rocksdb.go:43 Options.delete_obsolete_files_period_micros: 21600000000
I0804 02:00:52.383505 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_background_compactions: 1
I0804 02:00:52.383514 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_background_flushes: 1
I0804 02:00:52.383519 93842 storage/engine/rocksdb/rocksdb.go:43 Options.WAL_ttl_seconds: 0
I0804 02:00:52.383524 93842 storage/engine/rocksdb/rocksdb.go:43 Options.WAL_size_limit_MB: 0
I0804 02:00:52.383529 93842 storage/engine/rocksdb/rocksdb.go:43 Options.manifest_preallocation_size: 4194304
I0804 02:00:52.383533 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_os_buffer: 1
I0804 02:00:52.383539 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_reads: 0
I0804 02:00:52.383543 93842 storage/engine/rocksdb/rocksdb.go:43 Options.allow_mmap_writes: 0
I0804 02:00:52.383548 93842 storage/engine/rocksdb/rocksdb.go:43 Options.is_fd_close_on_exec: 1
I0804 02:00:52.383553 93842 storage/engine/rocksdb/rocksdb.go:43 Options.stats_dump_period_sec: 3600
I0804 02:00:52.383558 93842 storage/engine/rocksdb/rocksdb.go:43 Options.advise_random_on_open: 1
I0804 02:00:52.383567 93842 storage/engine/rocksdb/rocksdb.go:43 Options.db_write_buffer_size: 0
I0804 02:00:52.383573 93842 storage/engine/rocksdb/rocksdb.go:43 Options.access_hint_on_compaction_start: NORMAL
I0804 02:00:52.383577 93842 storage/engine/rocksdb/rocksdb.go:43 Options.use_adaptive_mutex: 0
I0804 02:00:52.383582 93842 storage/engine/rocksdb/rocksdb.go:43 Options.rate_limiter: 0x0
I0804 02:00:52.383588 93842 storage/engine/rocksdb/rocksdb.go:43 Options.bytes_per_sync: 0
I0804 02:00:52.383592 93842 storage/engine/rocksdb/rocksdb.go:43 Options.enable_thread_tracking: 0
I0804 02:00:52.383598 93842 storage/engine/rocksdb/rocksdb.go:43 Options.comparator: rocksdb.InternalKeyComparator:leveldb.BytewiseComparator
I0804 02:00:52.383604 93842 storage/engine/rocksdb/rocksdb.go:43 Options.merge_operator: cockroach_merge_operator
I0804 02:00:52.383608 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_filter: None
I0804 02:00:52.383618 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_filter_factory: cockroach_compaction_filter_factory
I0804 02:00:52.383623 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_filter_factory_v2: DefaultCompactionFilterFactoryV2
I0804 02:00:52.383628 93842 storage/engine/rocksdb/rocksdb.go:43 Options.memtable_factory: SkipListFactory
I0804 02:00:52.383634 93842 storage/engine/rocksdb/rocksdb.go:43 Options.table_factory: BlockBasedTable
I0804 02:00:52.383647 93842 storage/engine/rocksdb/rocksdb.go:43 table_factory options: flush_block_policy_factory: FlushBlockBySizePolicyFactory (0x6a01fa0)
cache_index_and_filter_blocks: 0
index_type: 0
hash_index_allow_collision: 1
checksum: 1
no_block_cache: 0
block_cache: 0x6a00dd8
block_cache_size: 1048576
block_cache_compressed: 0x0
block_size: 4096
block_size_deviation: 10
block_restart_interval: 16
filter_policy: nullptr
format_version: 0
I0804 02:00:52.383656 93842 storage/engine/rocksdb/rocksdb.go:43 Options.write_buffer_size: 67108864
I0804 02:00:52.383663 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_write_buffer_number: 2
I0804 02:00:52.383667 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compression: 1
I0804 02:00:52.383672 93842 storage/engine/rocksdb/rocksdb.go:43 Options.prefix_extractor: nullptr
I0804 02:00:52.383678 93842 storage/engine/rocksdb/rocksdb.go:43 Options.num_levels: 7
I0804 02:00:52.383682 93842 storage/engine/rocksdb/rocksdb.go:43 Options.min_write_buffer_number_to_merge: 1
I0804 02:00:52.383688 93842 storage/engine/rocksdb/rocksdb.go:43 Options.purge_redundant_kvs_while_flush: 1
I0804 02:00:52.383693 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compression_opts.window_bits: -14
I0804 02:00:52.383698 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compression_opts.level: -1
I0804 02:00:52.383702 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compression_opts.strategy: 0
I0804 02:00:52.383707 93842 storage/engine/rocksdb/rocksdb.go:43 Options.level0_file_num_compaction_trigger: 4
I0804 02:00:52.383713 93842 storage/engine/rocksdb/rocksdb.go:43 Options.level0_slowdown_writes_trigger: 20
I0804 02:00:52.383717 93842 storage/engine/rocksdb/rocksdb.go:43 Options.level0_stop_writes_trigger: 24
I0804 02:00:52.383722 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_mem_compaction_level: 2
I0804 02:00:52.383727 93842 storage/engine/rocksdb/rocksdb.go:43 Options.target_file_size_base: 67108864
I0804 02:00:52.383732 93842 storage/engine/rocksdb/rocksdb.go:43 Options.target_file_size_multiplier: 1
I0804 02:00:52.383737 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_base: 536870912
I0804 02:00:52.383742 93842 storage/engine/rocksdb/rocksdb.go:43 Options.level_compaction_dynamic_level_bytes: 0
I0804 02:00:52.383747 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier: 10
I0804 02:00:52.383752 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[0]: 1
I0804 02:00:52.383757 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[1]: 1
I0804 02:00:52.383762 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[2]: 1
I0804 02:00:52.383766 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[3]: 1
I0804 02:00:52.383772 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[4]: 1
I0804 02:00:52.383776 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[5]: 1
I0804 02:00:52.383786 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_bytes_for_level_multiplier_addtl[6]: 1
I0804 02:00:52.383791 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_sequential_skip_in_iterations: 8
I0804 02:00:52.383800 93842 storage/engine/rocksdb/rocksdb.go:43 Options.expanded_compaction_factor: 25
I0804 02:00:52.383806 93842 storage/engine/rocksdb/rocksdb.go:43 Options.source_compaction_factor: 1
I0804 02:00:52.383810 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_grandparent_overlap_factor: 10
I0804 02:00:52.383815 93842 storage/engine/rocksdb/rocksdb.go:43 Options.arena_block_size: 6710886
I0804 02:00:52.383822 93842 storage/engine/rocksdb/rocksdb.go:43 Options.soft_rate_limit: 0.00
I0804 02:00:52.383827 93842 storage/engine/rocksdb/rocksdb.go:43 Options.hard_rate_limit: 0.00
I0804 02:00:52.383832 93842 storage/engine/rocksdb/rocksdb.go:43 Options.rate_limit_delay_max_milliseconds: 1000
I0804 02:00:52.383837 93842 storage/engine/rocksdb/rocksdb.go:43 Options.disable_auto_compactions: 0
I0804 02:00:52.383841 93842 storage/engine/rocksdb/rocksdb.go:43 Options.purge_redundant_kvs_while_flush: 1
I0804 02:00:52.383846 93842 storage/engine/rocksdb/rocksdb.go:43 Options.filter_deletes: 0
I0804 02:00:52.383851 93842 storage/engine/rocksdb/rocksdb.go:43 Options.verify_checksums_in_compaction: 1
I0804 02:00:52.383856 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_style: 0
I0804 02:00:52.383861 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_universal.size_ratio: 1
I0804 02:00:52.383865 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_universal.min_merge_width: 2
I0804 02:00:52.383871 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_universal.max_merge_width: 4294967295
I0804 02:00:52.383876 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_universal.max_size_amplification_percent: 200
I0804 02:00:52.383882 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_universal.compression_size_percent: -1
I0804 02:00:52.383886 93842 storage/engine/rocksdb/rocksdb.go:43 Options.compaction_options_fifo.max_table_files_size: 1073741824
I0804 02:00:52.383892 93842 storage/engine/rocksdb/rocksdb.go:43 Options.table_properties_collectors: InternalKeyPropertiesCollectorFactory;
I0804 02:00:52.383897 93842 storage/engine/rocksdb/rocksdb.go:43 Options.inplace_update_support: 0
I0804 02:00:52.383902 93842 storage/engine/rocksdb/rocksdb.go:43 Options.inplace_update_num_locks: 10000
I0804 02:00:52.383907 93842 storage/engine/rocksdb/rocksdb.go:43 Options.min_partial_merge_operands: 2
I0804 02:00:52.383912 93842 storage/engine/rocksdb/rocksdb.go:43 Options.memtable_prefix_bloom_bits: 0
I0804 02:00:52.383917 93842 storage/engine/rocksdb/rocksdb.go:43 Options.memtable_prefix_bloom_probes: 6
I0804 02:00:52.383922 93842 storage/engine/rocksdb/rocksdb.go:43 Options.memtable_prefix_bloom_huge_page_tlb_size: 0
I0804 02:00:52.383927 93842 storage/engine/rocksdb/rocksdb.go:43 Options.bloom_locality: 0
I0804 02:00:52.383932 93842 storage/engine/rocksdb/rocksdb.go:43 Options.max_successive_merges: 0
I0804 02:00:52.383937 93842 storage/engine/rocksdb/rocksdb.go:43 Options.optimize_fllters_for_hits: 0
I0804 02:00:52.383958 93842 storage/engine/rocksdb/rocksdb.go:43 Recovered from manifest file:/MANIFEST-000001 succeeded,manifest_file_number is 1, next_file_number is 3, last_sequence is 0, log_number is 0,prev_log_number is 0,max_column_family is 0
I0804 02:00:52.383964 93842 storage/engine/rocksdb/rocksdb.go:43 Column family [default] (ID 0), log number is 0
I0804 02:00:52.383992 93842 storage/engine/rocksdb/rocksdb.go:43 DB pointer 0x780a400
W0804 02:00:52.384099 93842 rpc/tls.go:41 listening via tcp to 127.0.0.1:0 without TLS
I0804 02:00:52.384224 93842 multiraft/multiraft.go:454 node 300000003 starting
I0804 02:00:52.385160 93842 multiraft/multiraft.go:767 group 1: new proposal 13f72cf8a41acef8365a858149c6e2d1
I0804 02:00:52.385228 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.385272 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:13 XXX_unrecognized:[]}
I0804 02:00:52.385338 93842 multiraft/multiraft.go:784 New Entry[0]: 6/13 EntryNormal 13f72cf8a41acef8365a858149c6e2d1: raft_id:1 origin_node_id:100000001 cmd:<increment:<header:<timestamp:<wall_time:0 logical:17 > cmd_id:<wall_time:1438668052384894712 random:391658961
I0804 02:00:52.385378 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/13 EntryNormal 13f72cf8a41acef8365a858149c6e2d1: raft_id:1 origin_node_id:100000001 cmd:<increment:<header:<timestamp:<wall_time:0 logical:17 > cmd_id:<wall_time:1438668052384894712 random:391658961
I0804 02:00:52.385582 93842 storage/range_command.go:135 executed Increment command header:<timestamp:<wall_time:0 logical:17 > cmd_id:<wall_time:1438668052384894712 random:3916589616287113937 > key:"\000raft-idgen" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 read_consistency:CONSISTENT > increment:10 : header:<timestamp:<wall_time:0 logical:0 > > new_value:10
I0804 02:00:52.385761 93842 storage/range_command.go:994 initiating a split of range=1 ["" - "\xff\xff") at key "b"
I0804 02:00:52.386993 93842 multiraft/multiraft.go:767 group 1: new proposal 00000000000000001408d2ac22c4d294
I0804 02:00:52.387054 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.387071 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:14 XXX_unrecognized:[]}
I0804 02:00:52.387193 93842 multiraft/multiraft.go:784 New Entry[0]: 6/14 EntryNormal 00000000000000001408d2ac22c4d294: raft_id:1 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.387289 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/14 EntryNormal 00000000000000001408d2ac22c4d294: raft_id:1 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.387533 93842 storage/range_command.go:135 executed ConditionalPut command header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000kb\000\001rdsc" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001" checksum:2503404014 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.387813 93842 multiraft/multiraft.go:767 group 1: new proposal 00000000000000000c697f48392907a0
I0804 02:00:52.387856 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.387870 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:15 XXX_unrecognized:[]}
I0804 02:00:52.387960 93842 multiraft/multiraft.go:784 New Entry[0]: 6/15 EntryNormal 00000000000000000c697f48392907a0: raft_id:1 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.388048 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/15 EntryNormal 00000000000000000c697f48392907a0: raft_id:1 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.389265 93842 storage/range_command.go:135 executed ConditionalPut command header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000k\000\001rdsc" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\001\022\000\032\001b\"\004\010\001\020\001" checksum:2733074692 > exp_value:<bytes:"\010\001\022\000\032\002\377\377\"\004\010\001\020\001" checksum:3269897724 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.389420 93842 multiraft/multiraft.go:767 group 1: new proposal 0000000000000000268447a4189deb99
I0804 02:00:52.389463 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.389499 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:16 XXX_unrecognized:[]}
I0804 02:00:52.389590 93842 multiraft/multiraft.go:784 New Entry[0]: 6/16 EntryNormal 0000000000000000268447a4189deb99: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" u
I0804 02:00:52.389665 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/16 EntryNormal 0000000000000000268447a4189deb99: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" u
I0804 02:00:52.389971 93842 storage/range_command.go:135 executed Put command header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001" checksum:647626849 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.390097 93842 multiraft/multiraft.go:767 group 1: new proposal 000000000000000041f27cc6f3875d04
I0804 02:00:52.390148 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.390161 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:17 XXX_unrecognized:[]}
I0804 02:00:52.390239 93842 multiraft/multiraft.go:784 New Entry[0]: 6/17 EntryNormal 000000000000000041f27cc6f3875d04: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2b" user:"ro
I0804 02:00:52.390310 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/17 EntryNormal 000000000000000041f27cc6f3875d04: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2b" user:"ro
I0804 02:00:52.390466 93842 storage/range_command.go:135 executed Put command header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2b" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\001\022\000\032\001b\"\004\010\001\020\001" checksum:261348614 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.390587 93842 multiraft/multiraft.go:767 group 1: new proposal 000000000000000068255aaf95e94627
I0804 02:00:52.390628 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.390641 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:18 XXX_unrecognized:[]}
I0804 02:00:52.390719 93842 multiraft/multiraft.go:784 New Entry[0]: 6/18 EntryNormal 000000000000000068255aaf95e94627: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta1\377\377" u
I0804 02:00:52.390800 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/18 EntryNormal 000000000000000068255aaf95e94627: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta1\377\377" u
I0804 02:00:52.390956 93842 storage/range_command.go:135 executed Put command header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta1\377\377" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\001\022\000\032\001b\"\004\010\001\020\001" checksum:3058978603 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.391236 93842 storage/range_command.go:135 executed Get command header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:1438668052391074212 random:1976235410884491574 > key:"\000range-tree-root" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > : header:<timestamp:<wall_time:0 logical:0 > > value:<bytes:"\n\000" checksum:2561508210 timestamp:<wall_time:0 logical:1 > >
I0804 02:00:52.391403 93842 storage/range_command.go:135 executed Get command header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:1438668052391272905 random:3510942875414458836 > key:"\000\000\000k\000\001rtn-" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > : header:<timestamp:<wall_time:0 logical:0 > > value:<bytes:"\n\000\020\001" checksum:447764753 timestamp:<wall_time:0 logical:1 > >
I0804 02:00:52.391526 93842 multiraft/multiraft.go:767 group 1: new proposal 00000000000000003c04951aa42655d9
I0804 02:00:52.391562 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.391574 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:19 XXX_unrecognized:[]}
I0804 02:00:52.391641 93842 multiraft/multiraft.go:784 New Entry[0]: 6/19 EntryNormal 00000000000000003c04951aa42655d9: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000range-tree-root" use
I0804 02:00:52.391702 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/19 EntryNormal 00000000000000003c04951aa42655d9: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000range-tree-root" use
I0804 02:00:52.391838 93842 storage/range_command.go:135 executed Put command header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000range-tree-root" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\n\001b" checksum:3593888555 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.391945 93842 multiraft/multiraft.go:767 group 1: new proposal 0000000000000000243a768b7c4e0b68
I0804 02:00:52.391979 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.391991 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:20 XXX_unrecognized:[]}
I0804 02:00:52.392058 93842 multiraft/multiraft.go:784 New Entry[0]: 6/20 EntryNormal 0000000000000000243a768b7c4e0b68: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000kb\000\001rt
I0804 02:00:52.392120 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/20 EntryNormal 0000000000000000243a768b7c4e0b68: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000kb\000\001rt
I0804 02:00:52.392266 93842 storage/range_command.go:135 executed Put command header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000kb\000\001rtn-" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\n\001b\020\001\"\000" checksum:3628997524 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.392379 93842 multiraft/multiraft.go:767 group 1: new proposal 000000000000000025845c95d4491d1b
I0804 02:00:52.392413 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.392425 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:21 XXX_unrecognized:[]}
I0804 02:00:52.392503 93842 multiraft/multiraft.go:784 New Entry[0]: 6/21 EntryNormal 000000000000000025845c95d4491d1b: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000k\000\001rtn
I0804 02:00:52.392571 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/21 EntryNormal 000000000000000025845c95d4491d1b: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000k\000\001rtn
I0804 02:00:52.392721 93842 storage/range_command.go:135 executed Put command header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000k\000\001rtn-" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\n\000\020\000" checksum:1840736647 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.392866 93842 multiraft/multiraft.go:767 group 1: new proposal 000000000000000056ec3f2525632186
I0804 02:00:52.392901 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.392918 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:22 XXX_unrecognized:[]}
I0804 02:00:52.393200 93842 multiraft/multiraft.go:784 New Entry[0]: 6/22 EntryNormal 000000000000000056ec3f2525632186: raft_id:1 origin_node_id:100000001 cmd:<end_transaction:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"b" user:"roo
I0804 02:00:52.393422 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/22 EntryNormal 000000000000000056ec3f2525632186: raft_id:1 origin_node_id:100000001 cmd:<end_transaction:<header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"b" user:"roo
W0804 02:00:52.393814 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00\x00k\x00\x01rdsc" "" "range_command.go:1038" id=a40f2d8e key="b" rw=false pri=93.43629810 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,20 orig=0.000000000,20 max=0.000000000,20 }
W0804 02:00:52.393877 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00\x00k\x00\x01rtn-" "" "range_command.go:1038" id=a40f2d8e key="b" rw=false pri=93.43629810 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,20 orig=0.000000000,20 max=0.000000000,20 }
W0804 02:00:52.393913 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00\x00kb\x00\x01rdsc" "" "range_command.go:1038" id=a40f2d8e key="b" rw=false pri=93.43629810 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,20 orig=0.000000000,20 max=0.000000000,20 }
W0804 02:00:52.393944 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00\x00kb\x00\x01rtn-" "" "range_command.go:1038" id=a40f2d8e key="b" rw=false pri=93.43629810 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,20 orig=0.000000000,20 max=0.000000000,20 }
W0804 02:00:52.393974 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00meta1\xff\xff" "" "range_command.go:1038" id=a40f2d8e key="b" rw=false pri=93.43629810 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,20 orig=0.000000000,20 max=0.000000000,20 }
W0804 02:00:52.394009 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00meta2b" "" "range_command.go:1038" id=a40f2d8e key="b" rw=false pri=93.43629810 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,20 orig=0.000000000,20 max=0.000000000,20 }
W0804 02:00:52.394045 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00meta2\xff\xff" "" "range_command.go:1038" id=a40f2d8e key="b" rw=false pri=93.43629810 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,20 orig=0.000000000,20 max=0.000000000,20 }
W0804 02:00:52.394080 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00range-tree-root" "" "range_command.go:1038" id=a40f2d8e key="b" rw=false pri=93.43629810 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,20 orig=0.000000000,20 max=0.000000000,20 }
I0804 02:00:52.394816 93842 storage/range_command.go:135 executed EndTransaction command header:<timestamp:<wall_time:0 logical:20 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > commit:true internal_commit_trigger:<split_trigger:<updated_desc:<raft_id:1 start_key:"" end_key:"b" replicas:<node_id:1 store_id:1 > > new_desc:<raft_id:2 start_key:"b" end_key:"\377\377" replicas:<node_id:1 store_id:1 > > > > intents:<key:"\000\000\000k\000\001rdsc" txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > > intents:<key:"\000\000\000k\000\001rtn-" txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > > intents:<key:"\000\000\000kb\000\001rdsc" txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > > intents:<key:"\000\000\000kb\000\001rtn-" txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > > intents:<key:"\000\000meta1\377\377" txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > > intents:<key:"\000\000meta2b" txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > > intents:<key:"\000\000meta2\377\377" txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > > intents:<key:"\000range-tree-root" txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > > : header:<timestamp:<wall_time:0 logical:0 > txn:<name:"range_command.go:1038" key:"b" id:"\244\017-\216\324\007H\254\257P\032\010?)\000\344" priority:2006529222 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:20 > orig_timestamp:<wall_time:0 logical:20 > max_timestamp:<wall_time:0 logical:20 > certain_nodes:<> Writing:false > > commit_wait:0
I0804 02:00:52.395952 93842 multiraft/multiraft.go:665 node 100000001 creating group 2
I0804 02:00:52.396046 93842 raft/raft.go:390 100000001 became follower at term 5
I0804 02:00:52.396098 93842 raft/raft.go:207 newRaft 100000001 [peers: [100000001], term: 5, commit: 10, applied: 10, lastindex: 10, lastterm: 5]
I0804 02:00:52.396116 93842 raft/raft.go:464 100000001 is starting a new election at term 5
I0804 02:00:52.396123 93842 raft/raft.go:403 100000001 became candidate at term 6
I0804 02:00:52.396129 93842 raft/raft.go:447 100000001 received vote from 100000001 at term 6
I0804 02:00:52.396168 93842 raft/raft.go:426 100000001 became leader at term 6
I0804 02:00:52.396197 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.396213 93842 multiraft/multiraft.go:778 SoftState updated: {Lead:4294967297 RaftState:StateLeader}
I0804 02:00:52.396223 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:11 XXX_unrecognized:[]}
I0804 02:00:52.396232 93842 multiraft/multiraft.go:784 New Entry[0]: 6/11 EntryNormal [empty]
I0804 02:00:52.396240 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/11 EntryNormal [empty]
I0804 02:00:52.396298 93842 multiraft/multiraft.go:767 group 2: new proposal 00000000000000002e3108dabb158644
I0804 02:00:52.396332 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.396342 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:12 XXX_unrecognized:[]}
I0804 02:00:52.396396 93842 multiraft/multiraft.go:784 New Entry[0]: 6/12 EntryNormal 00000000000000002e3108dabb158644: raft_id:2 origin_node_id:100000001 cmd:<internal_lease:<header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:3328451335138149956 >
I0804 02:00:52.396437 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/12 EntryNormal 00000000000000002e3108dabb158644: raft_id:2 origin_node_id:100000001 cmd:<internal_lease:<header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:3328451335138149956 >
I0804 02:00:52.396513 93842 storage/range_command.go:932 range 2: new leader lease replica 1:1 19:00:00.000 +1.000s
I0804 02:00:52.396566 93842 storage/range_command.go:135 executed InternalLeaderLease command header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:3328451335138149956 > key:"b" user:"" replica:<node_id:0 store_id:0 > raft_id:0 read_consistency:CONSISTENT > lease:<start:<wall_time:0 logical:44 > expiration:<wall_time:1000000000 logical:44 > raft_node_id:100000001 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.396637 93842 multiraft/multiraft.go:767 group 2: new proposal 0000000000000000490bd268b68e6a3f
I0804 02:00:52.396667 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.396677 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:13 XXX_unrecognized:[]}
I0804 02:00:52.396753 93842 multiraft/multiraft.go:784 New Entry[0]: 6/13 EntryNormal 0000000000000000490bd268b68e6a3f: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.396821 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/13 EntryNormal 0000000000000000490bd268b68e6a3f: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.396966 93842 storage/range_command.go:135 executed ConditionalPut command header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000kb\000\001rdsc" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002" checksum:1271410328 > exp_value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001" checksum:2503404014 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.397102 93842 multiraft/multiraft.go:767 group 1: new proposal 00000000000000006e661e92759805f5
I0804 02:00:52.397135 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.397146 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:23 XXX_unrecognized:[]}
I0804 02:00:52.397212 93842 multiraft/multiraft.go:784 New Entry[0]: 6/23 EntryNormal 00000000000000006e661e92759805f5: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" u
I0804 02:00:52.397270 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/23 EntryNormal 00000000000000006e661e92759805f5: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" u
I0804 02:00:52.397403 93842 storage/range_command.go:135 executed Put command header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002" checksum:1095748559 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.397518 93842 multiraft/multiraft.go:767 group 2: new proposal 00000000000000002584c47f2cdf5b8a
I0804 02:00:52.397551 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.397573 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:14 XXX_unrecognized:[]}
I0804 02:00:52.397600 93842 multiraft/multiraft.go:784 New Entry[0]: 6/14 EntryConfChange "\b\x00\x10\x00\x18\x82\x80\x80\x80 \"\x88\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00%\x84\xc4\u007f,\xdf[\x8a\b\x02\x10\x81\x80\x80\x80\x10\x1a\xec\x01J\xe9\x01\no\n\x04\b\x00\x10,\
I0804 02:00:52.397637 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/14 EntryConfChange "\b\x00\x10\x00\x18\x82\x80\x80\x80 \"\x88\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00%\x84\xc4\u007f,\xdf[\x8a\b\x02\x10\x81\x80\x80\x80\x10\x1a\xec\x01J\xe9\x01\no\n\x04\b\x00\x10,\
W0804 02:00:52.397735 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00\x00kb\x00\x01rdsc" "" "range_command.go:1344" id=fbb45b7c key="b" rw=false pri=79.68131233 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,44 orig=0.000000000,44 max=0.000000000,44 }
W0804 02:00:52.397773 93842 storage/range_command.go:1264 TODO(tschottdorf): changeReplicasTrigger
I0804 02:00:52.397920 93842 storage/range_command.go:135 executed EndTransaction command header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > commit:true internal_commit_trigger:<change_replicas_trigger:<node_id:2 store_id:2 change_type:ADD_REPLICA updated_replicas:<node_id:1 store_id:1 > updated_replicas:<node_id:2 store_id:2 > > > intents:<key:"\000\000\000kb\000\001rdsc" txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false > > intents:<key:"\000\000meta2\377\377" txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false > > : header:<timestamp:<wall_time:0 logical:0 > txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false > > commit_wait:0
I0804 02:00:52.398238 93842 multiraft/multiraft.go:871 node 100000001 applying configuration change {0 ConfChangeAddNode 8589934594 [0 0 0 0 0 0 0 0 0 37 132 196 127 44 223 91 138 8 2 16 129 128 128 128 16 26 236 1 74 233 1 10 111 10 4 8 0 16 44 18 4 8 0 16 0 26 1 98 42 4 114 111 111 116 50 4 8 1 16 1 56 2 74 78 10 21 114 97 110 103 101 95 99 111 109 109 97 110 100 46 103 111 58 49 51 52 52 18 1 98 26 16 251 180 91 124 186 117 76 209 136 157 96 54 31 42 157 235 32 240 241 247 175 6 40 0 48 0 56 0 74 4 8 0 16 44 82 4 8 0 16 44 90 4 8 0 16 44 98 0 104 0 80 0 16 1 26 20 26 18 8 2 16 2 24 0 34 4 8 1 16 1 34 4 8 2 16 2 34 47 10 11 0 0 0 107 98 0 1 114 100 115 99 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0 34 45 10 9 0 0 109 101 116 97 50 255 255 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0] []}
I0804 02:00:52.398290 93842 multiraft/multiraft.go:767 group 2: new proposal 00000000000000001a714cf86b83d0e2
I0804 02:00:52.398301 93842 multiraft/multiraft.go:767 group 2: new proposal 0000000000000000592e17f7b068d9db
I0804 02:00:52.398358 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.398435 93842 multiraft/multiraft.go:784 New Entry[0]: 6/15 EntryNormal 00000000000000001a714cf86b83d0e2: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.398510 93842 multiraft/multiraft.go:784 New Entry[1]: 6/16 EntryNormal 0000000000000000592e17f7b068d9db: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.398596 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/14 Commit:14 Entries:[6/15 EntryNormal 00000000000000001a714cf86b83d0e2: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:
W0804 02:00:52.398660 93842 rpc/tls.go:57 connecting via tcp to 127.0.0.1:49261 without TLS
I0804 02:00:52.398980 93842 security/auth.go:48 RPC: no TLS
I0804 02:00:52.399267 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/14 Commit:14 Entries:[6/15 EntryNormal 00000000000000001a714cf86b83d0e2: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:
I0804 02:00:52.399295 93842 multiraft/multiraft.go:513 node 200000002: got message for unknown group 2; creating it
I0804 02:00:52.399304 93842 multiraft/multiraft.go:665 node 200000002 creating group 2
I0804 02:00:52.399374 93842 raft/raft.go:390 200000002 became follower at term 0
I0804 02:00:52.399407 93842 raft/raft.go:207 newRaft 200000002 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]
I0804 02:00:52.399414 93842 raft/raft.go:390 200000002 became follower at term 1
I0804 02:00:52.399443 93842 raft/raft.go:479 200000002 [term: 1] received a MsgApp message with higher term from 100000001 [term: 6]
I0804 02:00:52.399449 93842 raft/raft.go:390 200000002 became follower at term 6
I0804 02:00:52.399475 93842 raft/raft.go:661 200000002 [logterm: 0, index: 14] rejected msgApp [logterm: 6, index: 14] from 100000001
I0804 02:00:52.399498 93842 multiraft/multiraft.go:776 node 200000002: group 2 raft ready
I0804 02:00:52.399511 93842 multiraft/multiraft.go:778 SoftState updated: {Lead:4294967297 RaftState:StateFollower}
I0804 02:00:52.399519 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:0 Commit:0 XXX_unrecognized:[]}
I0804 02:00:52.399529 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 200000002->100000001 MsgAppResp Term:6 Log:0/14 Rejected
I0804 02:00:52.399586 93842 multiraft/multiraft.go:919 node 200000002: connecting to new node 100000001
W0804 02:00:52.399597 93842 rpc/tls.go:57 connecting via tcp to 127.0.0.1:49260 without TLS
I0804 02:00:52.400490 93842 security/auth.go:48 RPC: no TLS
I0804 02:00:52.400612 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/14 Rejected
I0804 02:00:52.400662 93842 raft/raft.go:517 100000001 received msgApp rejection(lastindex: 0) from 200000002 for index 14
I0804 02:00:52.400687 93842 raft/raft.go:519 100000001 decreased progress of 200000002 to [next = 1, match = 0, state = ProgressStateProbe, waiting = false, pendingSnapshot = 0]
I0804 02:00:52.400836 93842 raft/raft.go:258 100000001 [firstindex: 11, commit: 14] sent snapshot[index: 14, term: 6] to 200000002 [next = 1, match = 0, state = ProgressStateProbe, waiting = false, pendingSnapshot = 0]
I0804 02:00:52.400860 93842 raft/raft.go:260 100000001 paused sending replication messages to 200000002 [next = 1, match = 0, state = ProgressStateSnapshot, waiting = true, pendingSnapshot = 14]
I0804 02:00:52.400883 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.401230 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgSnap Term:6 Log:0/0 Snapshot:{[10 21 8 2 18 1 98 26 2 255 255 34 4 8 1 16 1 34 4 8 2 16 2 18 60 10 24 0 255 0 255 0 255 105 9 2 114 101 115 45 8 46 49 8 218 187 21 134 68 0 1 1
I0804 02:00:52.401321 93842 raft/raft.go:565 100000001 snapshot succeeded, resumed sending replication messages to 200000002 [next = 15, match = 0, state = ProgressStateProbe, waiting = false, pendingSnapshot = 0]
I0804 02:00:52.401707 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgSnap Term:6 Log:0/0 Snapshot:{[10 21 8 2 18 1 98 26 2 255 255 34 4 8 1 16 1 34 4 8 2 16 2 18 60 10 24 0 255 0 255 0 255 105 9 2 114 101 115 45 8 46 49 8 218 187 21 134 68 0 1 1
I0804 02:00:52.401768 93842 raft/raft.go:698 200000002 [commit: 0, lastindex: 0, lastterm: 0] starts to restore snapshot [index: 14, term: 6]
I0804 02:00:52.401794 93842 raft/log.go:250 log [committed=0, applied=0, unstable.offset=1, len(unstable.Entries)=0] starts to restore snapshot [index: 14, term: 6]
I0804 02:00:52.401814 93842 raft/raft.go:710 200000002 restored progress of 100000001 [next = 15, match = 0, state = ProgressStateProbe, waiting = false, pendingSnapshot = 0]
I0804 02:00:52.401822 93842 raft/raft.go:710 200000002 restored progress of 200000002 [next = 15, match = 14, state = ProgressStateProbe, waiting = false, pendingSnapshot = 0]
I0804 02:00:52.401838 93842 raft/raft.go:675 200000002 [commit: 0] restored snapshot [index: 14, term: 6]
I0804 02:00:52.401858 93842 multiraft/multiraft.go:776 node 200000002: group 2 raft ready
I0804 02:00:52.401869 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:0 Commit:14 XXX_unrecognized:[]}
I0804 02:00:52.403462 93842 multiraft/multiraft.go:790 Snapshot updated: data:"\n\025\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002\022<\n\030\000\377\000\377\000\377i\t\002res-\010.1\010\332\273\025\206D\000\001\022 \022\004\010\000\020\000\
I0804 02:00:52.403481 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 200000002->100000001 MsgAppResp Term:6 Log:0/14
I0804 02:00:52.403827 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/14
I0804 02:00:52.403908 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.404064 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/14 Commit:14 Entries:[6/15 EntryNormal 00000000000000001a714cf86b83d0e2: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:
I0804 02:00:52.404257 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/14 Commit:14 Entries:[6/15 EntryNormal 00000000000000001a714cf86b83d0e2: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:
I0804 02:00:52.404315 93842 multiraft/multiraft.go:776 node 200000002: group 2 raft ready
I0804 02:00:52.404387 93842 multiraft/multiraft.go:784 New Entry[0]: 6/15 EntryNormal 00000000000000001a714cf86b83d0e2: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.404455 93842 multiraft/multiraft.go:784 New Entry[1]: 6/16 EntryNormal 0000000000000000592e17f7b068d9db: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.404464 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 200000002->100000001 MsgAppResp Term:6 Log:0/16
I0804 02:00:52.404587 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/16
I0804 02:00:52.404672 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.404683 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:16 XXX_unrecognized:[]}
I0804 02:00:52.404762 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/15 EntryNormal 00000000000000001a714cf86b83d0e2: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.404849 93842 multiraft/multiraft.go:787 Committed Entry[1]: 6/16 EntryNormal 0000000000000000592e17f7b068d9db: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.404859 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/16 Commit:16
I0804 02:00:52.405126 93842 storage/range_command.go:135 executed ConditionalPut command header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000kb\000\001rdsc" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002\"\004\010\003\020\003" checksum:1525536640 > exp_value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002" checksum:1271410328 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.405359 93842 storage/range_command.go:135 executed InternalPushTxn command header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > pushee_txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false > now:<wall_time:0 logical:56 > push_type:CLEANUP_TXN range_lookup:false : header:<timestamp:<wall_time:0 logical:0 > > pushee_txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false >
I0804 02:00:52.405581 93842 multiraft/multiraft.go:767 group 1: new proposal 0000000000000000430c8b35bb9457d8
I0804 02:00:52.405637 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.405647 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:24 XXX_unrecognized:[]}
I0804 02:00:52.405733 93842 multiraft/multiraft.go:784 New Entry[0]: 6/24 EntryNormal 0000000000000000430c8b35bb9457d8: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" u
I0804 02:00:52.405803 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/24 EntryNormal 0000000000000000430c8b35bb9457d8: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" u
I0804 02:00:52.405935 93842 storage/range_command.go:135 executed Put command header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002\"\004\010\003\020\003" checksum:3595283508 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.406052 93842 multiraft/multiraft.go:767 group 2: new proposal 00000000000000004dba7b0f9da1d7eb
I0804 02:00:52.406065 93842 multiraft/multiraft.go:767 group 1: new proposal 00000000000000007cd4b7a55a25e0cb
I0804 02:00:52.406125 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.406199 93842 multiraft/multiraft.go:784 New Entry[0]: 6/17 EntryNormal 00000000000000004dba7b0f9da1d7eb: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.406271 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/16 Commit:16 Entries:[6/17 EntryNormal 00000000000000004dba7b0f9da1d7eb: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_tim
I0804 02:00:52.406281 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.406291 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:25 XXX_unrecognized:[]}
I0804 02:00:52.406349 93842 multiraft/multiraft.go:784 New Entry[0]: 6/25 EntryNormal 00000000000000007cd4b7a55a25e0cb: raft_id:1 origin_node_id:100000001 cmd:<internal_resolve_intent:<header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"\000
I0804 02:00:52.406400 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/25 EntryNormal 00000000000000007cd4b7a55a25e0cb: raft_id:1 origin_node_id:100000001 cmd:<internal_resolve_intent:<header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"\000
I0804 02:00:52.406578 93842 storage/range_command.go:135 executed InternalResolveIntent command header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.406682 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/16 Commit:16
I0804 02:00:52.406765 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/16 Commit:16 Entries:[6/17 EntryNormal 00000000000000004dba7b0f9da1d7eb: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_tim
I0804 02:00:52.406879 93842 multiraft/multiraft.go:776 node 200000002: group 2 raft ready
I0804 02:00:52.406891 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:0 Commit:16 XXX_unrecognized:[]}
I0804 02:00:52.406964 93842 multiraft/multiraft.go:784 New Entry[0]: 6/17 EntryNormal 00000000000000004dba7b0f9da1d7eb: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.407032 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/15 EntryNormal 00000000000000001a714cf86b83d0e2: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.407101 93842 multiraft/multiraft.go:787 Committed Entry[1]: 6/16 EntryNormal 0000000000000000592e17f7b068d9db: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.407111 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 200000002->100000001 MsgAppResp Term:6 Log:0/16
I0804 02:00:52.407119 93842 multiraft/multiraft.go:793 Outgoing Message[1]: 200000002->100000001 MsgAppResp Term:6 Log:0/17
I0804 02:00:52.407725 93842 storage/range_command.go:135 executed ConditionalPut command header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000kb\000\001rdsc" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002\"\004\010\003\020\003" checksum:1525536640 > exp_value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002" checksum:1271410328 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.407902 93842 storage/range_command.go:135 executed InternalPushTxn command header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > pushee_txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false > now:<wall_time:0 logical:56 > push_type:CLEANUP_TXN range_lookup:false : header:<timestamp:<wall_time:0 logical:0 > > pushee_txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false >
I0804 02:00:52.407994 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/16
I0804 02:00:52.408022 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/17
I0804 02:00:52.408140 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.408152 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:17 XXX_unrecognized:[]}
I0804 02:00:52.408227 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/17 EntryNormal 00000000000000004dba7b0f9da1d7eb: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.408237 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/17 Commit:17
I0804 02:00:52.408415 93842 storage/range_command.go:135 executed InternalPushTxn command header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > pushee_txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false > now:<wall_time:0 logical:65 > push_type:ABORT_TXN range_lookup:false : header:<timestamp:<wall_time:0 logical:0 > > pushee_txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false >
I0804 02:00:52.408563 93842 multiraft/multiraft.go:767 group 1: new proposal 00000000000000000a2b894cf840ec4b
W0804 02:00:52.408622 93842 storage/store.go:1291 conflicting intents on ["\x00\x00meta2\xff\xff"]: resolved? true
I0804 02:00:52.408664 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.408675 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:26 XXX_unrecognized:[]}
I0804 02:00:52.408734 93842 multiraft/multiraft.go:784 New Entry[0]: 6/26 EntryNormal 00000000000000000a2b894cf840ec4b: raft_id:1 origin_node_id:100000001 cmd:<internal_resolve_intent:<header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"\000
I0804 02:00:52.408785 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/26 EntryNormal 00000000000000000a2b894cf840ec4b: raft_id:1 origin_node_id:100000001 cmd:<internal_resolve_intent:<header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"\000
I0804 02:00:52.408899 93842 storage/range_command.go:135 executed InternalResolveIntent command header:<timestamp:<wall_time:0 logical:44 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" user:"root" replica:<node_id:0 store_id:0 > raft_id:0 txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.408965 93842 multiraft/multiraft.go:767 group 1: new proposal 00000000000000004c22b02936d4ff9b
I0804 02:00:52.409001 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.409015 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:27 XXX_unrecognized:[]}
I0804 02:00:52.409078 93842 multiraft/multiraft.go:784 New Entry[0]: 6/27 EntryNormal 00000000000000004c22b02936d4ff9b: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" u
I0804 02:00:52.409136 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/27 EntryNormal 00000000000000004c22b02936d4ff9b: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" u
I0804 02:00:52.409268 93842 storage/range_command.go:135 executed Put command header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002\"\004\010\003\020\003" checksum:3595283508 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.409375 93842 multiraft/multiraft.go:767 group 2: new proposal 0000000000000000079143f7f4a5ee3b
I0804 02:00:52.409433 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.409458 93842 multiraft/multiraft.go:784 New Entry[0]: 6/18 EntryConfChange "\b\x00\x10\x00\x18\x83\x80\x80\x800\"\x8e\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00\a\x91C\xf7\xf4\xa5\xee;\b\x02\x10\x81\x80\x80\x80\x10\x1a\xf2\x01J\xef\x01\no\n\x04\b\x00\x106\x
I0804 02:00:52.409482 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/17 Commit:17 Entries:[6/18 EntryConfChange "\b\x00\x10\x00\x18\x83\x80\x80\x800\"\x8e\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00\a\x91C\xf7\xf4\xa5\xee;\b\x02\x10
I0804 02:00:52.409583 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/17 Commit:17
I0804 02:00:52.409615 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/17 Commit:17 Entries:[6/18 EntryConfChange "\b\x00\x10\x00\x18\x83\x80\x80\x800\"\x8e\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00\a\x91C\xf7\xf4\xa5\xee;\b\x02\x10
I0804 02:00:52.409727 93842 multiraft/multiraft.go:776 node 200000002: group 2 raft ready
I0804 02:00:52.409738 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:0 Commit:17 XXX_unrecognized:[]}
I0804 02:00:52.409765 93842 multiraft/multiraft.go:784 New Entry[0]: 6/18 EntryConfChange "\b\x00\x10\x00\x18\x83\x80\x80\x800\"\x8e\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00\a\x91C\xf7\xf4\xa5\xee;\b\x02\x10\x81\x80\x80\x80\x10\x1a\xf2\x01J\xef\x01\no\n\x04\b\x00\x106\x
I0804 02:00:52.409840 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/17 EntryNormal 00000000000000004dba7b0f9da1d7eb: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.409850 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 200000002->100000001 MsgAppResp Term:6 Log:0/17
I0804 02:00:52.409858 93842 multiraft/multiraft.go:793 Outgoing Message[1]: 200000002->100000001 MsgAppResp Term:6 Log:0/18
I0804 02:00:52.410983 93842 storage/range_command.go:135 executed InternalPushTxn command header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > pushee_txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false > now:<wall_time:0 logical:65 > push_type:ABORT_TXN range_lookup:false : header:<timestamp:<wall_time:0 logical:0 > > pushee_txn:<name:"range_command.go:1344" key:"b" id:"\373\264[|\272uL\321\210\235`6\037*\235\353" priority:1711143152 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:44 > orig_timestamp:<wall_time:0 logical:44 > max_timestamp:<wall_time:0 logical:44 > certain_nodes:<> Writing:false >
I0804 02:00:52.411072 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/17
I0804 02:00:52.411092 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/18
I0804 02:00:52.411198 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.411228 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:18 XXX_unrecognized:[]}
I0804 02:00:52.411251 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/18 EntryConfChange "\b\x00\x10\x00\x18\x83\x80\x80\x800\"\x8e\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00\a\x91C\xf7\xf4\xa5\xee;\b\x02\x10\x81\x80\x80\x80\x10\x1a\xf2\x01J\xef\x01\no\n\x04\b\x00\x106\x
I0804 02:00:52.411263 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/18 Commit:18
W0804 02:00:52.411424 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00\x00kb\x00\x01rdsc" "" "range_command.go:1344" id=f3d34072 key="b" rw=false pri=24.74269645 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,54 orig=0.000000000,54 max=0.000000000,54 }
W0804 02:00:52.411450 93842 storage/range_command.go:1264 TODO(tschottdorf): changeReplicasTrigger
I0804 02:00:52.411594 93842 storage/range_command.go:135 executed EndTransaction command header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > commit:true internal_commit_trigger:<change_replicas_trigger:<node_id:3 store_id:3 change_type:ADD_REPLICA updated_replicas:<node_id:1 store_id:1 > updated_replicas:<node_id:2 store_id:2 > updated_replicas:<node_id:3 store_id:3 > > > intents:<key:"\000\000\000kb\000\001rdsc" txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > > intents:<key:"\000\000meta2\377\377" txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > > : header:<timestamp:<wall_time:0 logical:0 > txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > > commit_wait:0
I0804 02:00:52.411865 93842 multiraft/multiraft.go:871 node 100000001 applying configuration change {0 ConfChangeAddNode 12884901891 [0 0 0 0 0 0 0 0 0 7 145 67 247 244 165 238 59 8 2 16 129 128 128 128 16 26 242 1 74 239 1 10 111 10 4 8 0 16 54 18 4 8 0 16 0 26 1 98 42 4 114 111 111 116 50 4 8 1 16 1 56 2 74 78 10 21 114 97 110 103 101 95 99 111 109 109 97 110 100 46 103 111 58 49 51 52 52 18 1 98 26 16 243 211 64 114 76 151 64 127 185 95 179 40 95 55 59 73 32 208 223 174 253 1 40 0 48 0 56 0 74 4 8 0 16 54 82 4 8 0 16 54 90 4 8 0 16 54 98 0 104 0 80 0 16 1 26 26 26 24 8 3 16 3 24 0 34 4 8 1 16 1 34 4 8 2 16 2 34 4 8 3 16 3 34 47 10 11 0 0 0 107 98 0 1 114 100 115 99 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0 34 45 10 9 0 0 109 101 116 97 50 255 255 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0] []}
I0804 02:00:52.411913 93842 multiraft/multiraft.go:767 group 2: new proposal 000000000000000026984b92f6740304
I0804 02:00:52.411990 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.412072 93842 multiraft/multiraft.go:784 New Entry[0]: 6/19 EntryNormal 000000000000000026984b92f6740304: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.412145 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/18 Commit:18 Entries:[6/19 EntryNormal 000000000000000026984b92f6740304: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_tim
I0804 02:00:52.412213 93842 multiraft/multiraft.go:793 Outgoing Message[1]: 100000001->300000003 MsgApp Term:6 Log:6/18 Commit:18 Entries:[6/19 EntryNormal 000000000000000026984b92f6740304: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_tim
W0804 02:00:52.412276 93842 rpc/tls.go:57 connecting via tcp to 127.0.0.1:49262 without TLS
I0804 02:00:52.412722 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/18 Commit:18
I0804 02:00:52.412829 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/18 Commit:18 Entries:[6/19 EntryNormal 000000000000000026984b92f6740304: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_tim
I0804 02:00:52.412951 93842 multiraft/multiraft.go:776 node 200000002: group 2 raft ready
I0804 02:00:52.412963 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:0 Commit:18 XXX_unrecognized:[]}
I0804 02:00:52.413036 93842 multiraft/multiraft.go:784 New Entry[0]: 6/19 EntryNormal 000000000000000026984b92f6740304: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.413057 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/18 EntryConfChange "\b\x00\x10\x00\x18\x83\x80\x80\x800\"\x8e\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00\a\x91C\xf7\xf4\xa5\xee;\b\x02\x10\x81\x80\x80\x80\x10\x1a\xf2\x01J\xef\x01\no\n\x04\b\x00\x106\x
I0804 02:00:52.413066 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 200000002->100000001 MsgAppResp Term:6 Log:0/18
I0804 02:00:52.413075 93842 multiraft/multiraft.go:793 Outgoing Message[1]: 200000002->100000001 MsgAppResp Term:6 Log:0/19
W0804 02:00:52.413180 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00\x00kb\x00\x01rdsc" "" "range_command.go:1344" id=f3d34072 key="b" rw=false pri=24.74269645 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,54 orig=0.000000000,54 max=0.000000000,54 }
W0804 02:00:52.413202 93842 storage/range_command.go:1264 TODO(tschottdorf): changeReplicasTrigger
I0804 02:00:52.413341 93842 storage/range_command.go:135 executed EndTransaction command header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > commit:true internal_commit_trigger:<change_replicas_trigger:<node_id:3 store_id:3 change_type:ADD_REPLICA updated_replicas:<node_id:1 store_id:1 > updated_replicas:<node_id:2 store_id:2 > updated_replicas:<node_id:3 store_id:3 > > > intents:<key:"\000\000\000kb\000\001rdsc" txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > > intents:<key:"\000\000meta2\377\377" txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > > : header:<timestamp:<wall_time:0 logical:0 > txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > > commit_wait:0
I0804 02:00:52.413425 93842 security/auth.go:48 RPC: no TLS
I0804 02:00:52.413585 93842 multiraft/multiraft.go:871 node 200000002 applying configuration change {0 ConfChangeAddNode 12884901891 [0 0 0 0 0 0 0 0 0 7 145 67 247 244 165 238 59 8 2 16 129 128 128 128 16 26 242 1 74 239 1 10 111 10 4 8 0 16 54 18 4 8 0 16 0 26 1 98 42 4 114 111 111 116 50 4 8 1 16 1 56 2 74 78 10 21 114 97 110 103 101 95 99 111 109 109 97 110 100 46 103 111 58 49 51 52 52 18 1 98 26 16 243 211 64 114 76 151 64 127 185 95 179 40 95 55 59 73 32 208 223 174 253 1 40 0 48 0 56 0 74 4 8 0 16 54 82 4 8 0 16 54 90 4 8 0 16 54 98 0 104 0 80 0 16 1 26 26 26 24 8 3 16 3 24 0 34 4 8 1 16 1 34 4 8 2 16 2 34 4 8 3 16 3 34 47 10 11 0 0 0 107 98 0 1 114 100 115 99 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0 34 45 10 9 0 0 109 101 116 97 50 255 255 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0] []}
I0804 02:00:52.413676 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/18
I0804 02:00:52.413693 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/19
I0804 02:00:52.413784 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.413796 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:19 XXX_unrecognized:[]}
I0804 02:00:52.413871 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/19 EntryNormal 000000000000000026984b92f6740304: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.413881 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/19 Commit:19
I0804 02:00:52.414057 93842 storage/range_command.go:135 executed InternalPushTxn command header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > pushee_txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > now:<wall_time:0 logical:76 > push_type:CLEANUP_TXN range_lookup:false : header:<timestamp:<wall_time:0 logical:0 > > pushee_txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false >
I0804 02:00:52.414176 93842 multiraft/multiraft.go:767 group 1: new proposal 00000000000000004542c29291018d7c
I0804 02:00:52.414209 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.414220 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:28 XXX_unrecognized:[]}
I0804 02:00:52.414274 93842 multiraft/multiraft.go:784 New Entry[0]: 6/28 EntryNormal 00000000000000004542c29291018d7c: raft_id:1 origin_node_id:100000001 cmd:<internal_resolve_intent:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"\000
I0804 02:00:52.414323 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/28 EntryNormal 00000000000000004542c29291018d7c: raft_id:1 origin_node_id:100000001 cmd:<internal_resolve_intent:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"\000
I0804 02:00:52.414443 93842 storage/range_command.go:135 executed InternalResolveIntent command header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.414629 93842 multiraft/multiraft.go:500 node 300000003: group 2 got message 100000001->300000003 MsgApp Term:6 Log:6/18 Commit:18 Entries:[6/19 EntryNormal 000000000000000026984b92f6740304: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_tim
I0804 02:00:52.414641 93842 multiraft/multiraft.go:513 node 300000003: got message for unknown group 2; creating it
I0804 02:00:52.414649 93842 multiraft/multiraft.go:665 node 300000003 creating group 2
I0804 02:00:52.414726 93842 raft/raft.go:390 300000003 became follower at term 0
I0804 02:00:52.414749 93842 raft/raft.go:207 newRaft 300000003 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]
I0804 02:00:52.414755 93842 raft/raft.go:390 300000003 became follower at term 1
I0804 02:00:52.414772 93842 raft/raft.go:479 300000003 [term: 1] received a MsgApp message with higher term from 100000001 [term: 6]
I0804 02:00:52.414778 93842 raft/raft.go:390 300000003 became follower at term 6
I0804 02:00:52.414788 93842 raft/raft.go:661 300000003 [logterm: 0, index: 18] rejected msgApp [logterm: 6, index: 18] from 100000001
I0804 02:00:52.414804 93842 multiraft/multiraft.go:776 node 300000003: group 2 raft ready
I0804 02:00:52.414816 93842 multiraft/multiraft.go:778 SoftState updated: {Lead:4294967297 RaftState:StateFollower}
I0804 02:00:52.414825 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:0 Commit:0 XXX_unrecognized:[]}
I0804 02:00:52.414834 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 300000003->100000001 MsgAppResp Term:6 Log:0/18 Rejected
I0804 02:00:52.414876 93842 multiraft/multiraft.go:919 node 300000003: connecting to new node 100000001
I0804 02:00:52.414957 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 300000003->100000001 MsgAppResp Term:6 Log:0/18 Rejected
I0804 02:00:52.414987 93842 raft/raft.go:517 100000001 received msgApp rejection(lastindex: 0) from 300000003 for index 18
I0804 02:00:52.414997 93842 raft/raft.go:519 100000001 decreased progress of 300000003 to [next = 1, match = 0, state = ProgressStateProbe, waiting = false, pendingSnapshot = 0]
I0804 02:00:52.415127 93842 raft/raft.go:258 100000001 [firstindex: 11, commit: 19] sent snapshot[index: 19, term: 6] to 300000003 [next = 1, match = 0, state = ProgressStateProbe, waiting = false, pendingSnapshot = 0]
I0804 02:00:52.415138 93842 raft/raft.go:260 100000001 paused sending replication messages to 300000003 [next = 1, match = 0, state = ProgressStateSnapshot, waiting = true, pendingSnapshot = 19]
I0804 02:00:52.415158 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.415570 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->300000003 MsgSnap Term:6 Log:0/0 Snapshot:{[10 27 8 2 18 1 98 26 2 255 255 34 4 8 1 16 1 34 4 8 2 16 2 34 4 8 3 16 3 18 60 10 24 0 255 0 255 0 255 105 9 2 114 101 115 45 8 46 49 8 218 187 2
I0804 02:00:52.415638 93842 raft/raft.go:565 100000001 snapshot succeeded, resumed sending replication messages to 300000003 [next = 20, match = 0, state = ProgressStateProbe, waiting = false, pendingSnapshot = 0]
I0804 02:00:52.415700 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/19 Commit:19
I0804 02:00:52.415778 93842 multiraft/multiraft.go:776 node 200000002: group 2 raft ready
I0804 02:00:52.415789 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:0 Commit:19 XXX_unrecognized:[]}
I0804 02:00:52.415866 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/19 EntryNormal 000000000000000026984b92f6740304: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.415875 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 200000002->100000001 MsgAppResp Term:6 Log:0/19
I0804 02:00:52.416056 93842 storage/range_command.go:135 executed InternalPushTxn command header:<timestamp:<wall_time:0 logical:54 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > pushee_txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false > now:<wall_time:0 logical:76 > push_type:CLEANUP_TXN range_lookup:false : header:<timestamp:<wall_time:0 logical:0 > > pushee_txn:<name:"range_command.go:1344" key:"b" id:"\363\323@rL\227@\177\271_\263(_7;I" priority:531345360 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:54 > orig_timestamp:<wall_time:0 logical:54 > max_timestamp:<wall_time:0 logical:54 > certain_nodes:<> Writing:false >
I0804 02:00:52.416139 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/19
I0804 02:00:52.416589 93842 multiraft/multiraft.go:500 node 300000003: group 2 got message 100000001->300000003 MsgSnap Term:6 Log:0/0 Snapshot:{[10 27 8 2 18 1 98 26 2 255 255 34 4 8 1 16 1 34 4 8 2 16 2 34 4 8 3 16 3 18 60 10 24 0 255 0 255 0 255 105 9 2 114 101 115 45 8 46 49 8 218 187 2
I0804 02:00:52.416637 93842 raft/raft.go:698 300000003 [commit: 0, lastindex: 0, lastterm: 0] starts to restore snapshot [index: 19, term: 6]
I0804 02:00:52.416647 93842 raft/log.go:250 log [committed=0, applied=0, unstable.offset=1, len(unstable.Entries)=0] starts to restore snapshot [index: 19, term: 6]
I0804 02:00:52.416657 93842 raft/raft.go:710 300000003 restored progress of 100000001 [next = 20, match = 0, state = ProgressStateProbe, waiting = false, pendingSnapshot = 0]
I0804 02:00:52.416665 93842 raft/raft.go:710 300000003 restored progress of 200000002 [next = 20, match = 0, state = ProgressStateProbe, waiting = false, pendingSnapshot = 0]
I0804 02:00:52.416672 93842 raft/raft.go:710 300000003 restored progress of 300000003 [next = 20, match = 19, state = ProgressStateProbe, waiting = false, pendingSnapshot = 0]
I0804 02:00:52.416678 93842 raft/raft.go:675 300000003 [commit: 0] restored snapshot [index: 19, term: 6]
I0804 02:00:52.416693 93842 multiraft/multiraft.go:776 node 300000003: group 2 raft ready
I0804 02:00:52.416703 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:0 Commit:19 XXX_unrecognized:[]}
I0804 02:00:52.418484 93842 multiraft/multiraft.go:790 Snapshot updated: data:"\n\033\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002\"\004\010\003\020\003\022<\n\030\000\377\000\377\000\377i\t\002res-\010.1\010\332\273\025\206D\000\001\022 \02
I0804 02:00:52.418499 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 300000003->100000001 MsgAppResp Term:6 Log:0/19
I0804 02:00:52.418787 93842 multiraft/multiraft.go:767 group 2: new proposal 00000000000000003629d9f17d9e8fbc
I0804 02:00:52.418843 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.418928 93842 multiraft/multiraft.go:784 New Entry[0]: 6/20 EntryNormal 00000000000000003629d9f17d9e8fbc: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.419003 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/19 Commit:19 Entries:[6/20 EntryNormal 00000000000000003629d9f17d9e8fbc: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:
I0804 02:00:52.419227 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/19 Commit:19 Entries:[6/20 EntryNormal 00000000000000003629d9f17d9e8fbc: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:
I0804 02:00:52.419285 93842 multiraft/multiraft.go:776 node 200000002: group 2 raft ready
I0804 02:00:52.419357 93842 multiraft/multiraft.go:784 New Entry[0]: 6/20 EntryNormal 00000000000000003629d9f17d9e8fbc: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.419368 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 200000002->100000001 MsgAppResp Term:6 Log:0/20
I0804 02:00:52.419459 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 300000003->100000001 MsgAppResp Term:6 Log:0/19
I0804 02:00:52.419474 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/20
I0804 02:00:52.419603 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.419615 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:20 XXX_unrecognized:[]}
I0804 02:00:52.419685 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/20 EntryNormal 00000000000000003629d9f17d9e8fbc: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.419755 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->300000003 MsgApp Term:6 Log:6/19 Commit:19 Entries:[6/20 EntryNormal 00000000000000003629d9f17d9e8fbc: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:
I0804 02:00:52.419765 93842 multiraft/multiraft.go:793 Outgoing Message[1]: 100000001->300000003 MsgApp Term:6 Log:6/20 Commit:20
I0804 02:00:52.419772 93842 multiraft/multiraft.go:793 Outgoing Message[2]: 100000001->200000002 MsgApp Term:6 Log:6/20 Commit:20
I0804 02:00:52.419997 93842 storage/range_command.go:135 executed ConditionalPut command header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000kb\000\001rdsc" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002" checksum:1271410328 > exp_value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002\"\004\010\003\020\003" checksum:1525536640 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.420159 93842 multiraft/multiraft.go:767 group 1: new proposal 000000000000000043ea3b9393f93f33
I0804 02:00:52.420203 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.420223 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:29 XXX_unrecognized:[]}
I0804 02:00:52.420306 93842 multiraft/multiraft.go:784 New Entry[0]: 6/29 EntryNormal 000000000000000043ea3b9393f93f33: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" u
I0804 02:00:52.420385 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/29 EntryNormal 000000000000000043ea3b9393f93f33: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" u
I0804 02:00:52.420530 93842 storage/range_command.go:135 executed Put command header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002" checksum:1095748559 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.420653 93842 multiraft/multiraft.go:767 group 2: new proposal 0000000000000000207403def63a5b6f
I0804 02:00:52.420744 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.420778 93842 multiraft/multiraft.go:784 New Entry[0]: 6/21 EntryConfChange "\b\x00\x10\x01\x18\x83\x80\x80\x800\"\x88\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00 t\x03\xde\xf6:[o\b\x02\x10\x81\x80\x80\x80\x10\x1a\xec\x01J\xe9\x01\no\n\x04\b\x00\x10U\x12\x04\
I0804 02:00:52.420800 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/20 Commit:20 Entries:[6/21 EntryConfChange "\b\x00\x10\x01\x18\x83\x80\x80\x800\"\x88\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00 t\x03\xde\xf6:[o\b\x02\x10\x81\x8
I0804 02:00:52.420852 93842 multiraft/multiraft.go:793 Outgoing Message[1]: 100000001->300000003 MsgApp Term:6 Log:6/20 Commit:20 Entries:[6/21 EntryConfChange "\b\x00\x10\x01\x18\x83\x80\x80\x800\"\x88\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00 t\x03\xde\xf6:[o\b\x02\x10\x81\x8
I0804 02:00:52.420961 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/20 Commit:20
I0804 02:00:52.420991 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/20 Commit:20 Entries:[6/21 EntryConfChange "\b\x00\x10\x01\x18\x83\x80\x80\x800\"\x88\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00 t\x03\xde\xf6:[o\b\x02\x10\x81\x8
I0804 02:00:52.421091 93842 multiraft/multiraft.go:776 node 200000002: group 2 raft ready
I0804 02:00:52.421103 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:0 Commit:20 XXX_unrecognized:[]}
I0804 02:00:52.421122 93842 multiraft/multiraft.go:784 New Entry[0]: 6/21 EntryConfChange "\b\x00\x10\x01\x18\x83\x80\x80\x800\"\x88\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00 t\x03\xde\xf6:[o\b\x02\x10\x81\x80\x80\x80\x10\x1a\xec\x01J\xe9\x01\no\n\x04\b\x00\x10U\x12\x04\
I0804 02:00:52.421196 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/20 EntryNormal 00000000000000003629d9f17d9e8fbc: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.421206 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 200000002->100000001 MsgAppResp Term:6 Log:0/20
I0804 02:00:52.421214 93842 multiraft/multiraft.go:793 Outgoing Message[1]: 200000002->100000001 MsgAppResp Term:6 Log:0/21
I0804 02:00:52.421462 93842 storage/range_command.go:135 executed ConditionalPut command header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000kb\000\001rdsc" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002" checksum:1271410328 > exp_value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002\"\004\010\003\020\003" checksum:1525536640 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.421606 93842 multiraft/multiraft.go:500 node 300000003: group 2 got message 100000001->300000003 MsgApp Term:6 Log:6/19 Commit:19 Entries:[6/20 EntryNormal 00000000000000003629d9f17d9e8fbc: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:
I0804 02:00:52.421624 93842 multiraft/multiraft.go:500 node 300000003: group 2 got message 100000001->300000003 MsgApp Term:6 Log:6/20 Commit:20
I0804 02:00:52.421721 93842 multiraft/multiraft.go:500 node 300000003: group 2 got message 100000001->300000003 MsgApp Term:6 Log:6/20 Commit:20 Entries:[6/21 EntryConfChange "\b\x00\x10\x01\x18\x83\x80\x80\x800\"\x88\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00 t\x03\xde\xf6:[o\b\x02\x10\x81\x8
I0804 02:00:52.421762 93842 multiraft/multiraft.go:776 node 300000003: group 2 raft ready
I0804 02:00:52.421773 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:0 Commit:20 XXX_unrecognized:[]}
I0804 02:00:52.421845 93842 multiraft/multiraft.go:784 New Entry[0]: 6/20 EntryNormal 00000000000000003629d9f17d9e8fbc: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.421864 93842 multiraft/multiraft.go:784 New Entry[1]: 6/21 EntryConfChange "\b\x00\x10\x01\x18\x83\x80\x80\x800\"\x88\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00 t\x03\xde\xf6:[o\b\x02\x10\x81\x80\x80\x80\x10\x1a\xec\x01J\xe9\x01\no\n\x04\b\x00\x10U\x12\x04\
I0804 02:00:52.421931 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/20 EntryNormal 00000000000000003629d9f17d9e8fbc: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.421940 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 300000003->100000001 MsgAppResp Term:6 Log:0/20
I0804 02:00:52.421949 93842 multiraft/multiraft.go:793 Outgoing Message[1]: 300000003->100000001 MsgAppResp Term:6 Log:0/20
I0804 02:00:52.421956 93842 multiraft/multiraft.go:793 Outgoing Message[2]: 300000003->100000001 MsgAppResp Term:6 Log:0/21
I0804 02:00:52.422203 93842 storage/range_command.go:135 executed ConditionalPut command header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000kb\000\001rdsc" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002" checksum:1271410328 > exp_value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002\"\004\010\003\020\003" checksum:1525536640 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.422281 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/20
I0804 02:00:52.422297 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/21
I0804 02:00:52.422405 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.422417 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:21 XXX_unrecognized:[]}
I0804 02:00:52.422439 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/21 EntryConfChange "\b\x00\x10\x01\x18\x83\x80\x80\x800\"\x88\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00 t\x03\xde\xf6:[o\b\x02\x10\x81\x80\x80\x80\x10\x1a\xec\x01J\xe9\x01\no\n\x04\b\x00\x10U\x12\x04\
I0804 02:00:52.422449 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/21 Commit:21
I0804 02:00:52.422458 93842 multiraft/multiraft.go:793 Outgoing Message[1]: 100000001->300000003 MsgApp Term:6 Log:6/21 Commit:21
I0804 02:00:52.422541 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 300000003->100000001 MsgAppResp Term:6 Log:0/20
W0804 02:00:52.422608 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00\x00kb\x00\x01rdsc" "" "range_command.go:1344" id=6eb8384c key="b" rw=false pri=72.14923784 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,85 orig=0.000000000,85 max=0.000000000,85 }
W0804 02:00:52.422630 93842 storage/range_command.go:1264 TODO(tschottdorf): changeReplicasTrigger
I0804 02:00:52.422770 93842 storage/range_command.go:135 executed EndTransaction command header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > commit:true internal_commit_trigger:<change_replicas_trigger:<node_id:3 store_id:3 change_type:REMOVE_REPLICA updated_replicas:<node_id:1 store_id:1 > updated_replicas:<node_id:2 store_id:2 > > > intents:<key:"\000\000\000kb\000\001rdsc" txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > > intents:<key:"\000\000meta2\377\377" txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > > : header:<timestamp:<wall_time:0 logical:0 > txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > > commit_wait:0
I0804 02:00:52.423007 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 300000003->100000001 MsgAppResp Term:6 Log:0/20
I0804 02:00:52.423026 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 300000003->100000001 MsgAppResp Term:6 Log:0/21
I0804 02:00:52.423084 93842 multiraft/multiraft.go:871 node 100000001 applying configuration change {0 ConfChangeRemoveNode 12884901891 [0 0 0 0 0 0 0 0 0 32 116 3 222 246 58 91 111 8 2 16 129 128 128 128 16 26 236 1 74 233 1 10 111 10 4 8 0 16 85 18 4 8 0 16 0 26 1 98 42 4 114 111 111 116 50 4 8 1 16 1 56 2 74 78 10 21 114 97 110 103 101 95 99 111 109 109 97 110 100 46 103 111 58 49 51 52 52 18 1 98 26 16 110 184 56 76 109 81 66 209 174 169 99 214 246 32 60 192 32 188 185 231 226 5 40 0 48 0 56 0 74 4 8 0 16 85 82 4 8 0 16 85 90 4 8 0 16 85 98 0 104 0 80 0 16 1 26 20 26 18 8 3 16 3 24 1 34 4 8 1 16 1 34 4 8 2 16 2 34 47 10 11 0 0 0 107 98 0 1 114 100 115 99 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0 34 45 10 9 0 0 109 101 116 97 50 255 255 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0] []}
I0804 02:00:52.423107 93842 multiraft/multiraft.go:767 group 2: new proposal 00000000000000002e4fa459169873f5
I0804 02:00:52.423159 93842 multiraft/multiraft.go:767 group 2: new proposal 00000000000000002607c649581eeb39
I0804 02:00:52.423189 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.423262 93842 multiraft/multiraft.go:784 New Entry[0]: 6/22 EntryNormal 00000000000000002e4fa459169873f5: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.423332 93842 multiraft/multiraft.go:784 New Entry[1]: 6/23 EntryNormal 00000000000000002607c649581eeb39: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.423402 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/21 Commit:21 Entries:[6/22 EntryNormal 00000000000000002e4fa459169873f5: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:
I0804 02:00:52.423474 93842 multiraft/multiraft.go:793 Outgoing Message[1]: 100000001->200000002 MsgApp Term:6 Log:6/22 Commit:21 Entries:[6/23 EntryNormal 00000000000000002607c649581eeb39: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_tim
I0804 02:00:52.423585 93842 multiraft/multiraft.go:500 node 300000003: group 2 got message 100000001->300000003 MsgApp Term:6 Log:6/21 Commit:21
I0804 02:00:52.423653 93842 multiraft/multiraft.go:776 node 300000003: group 2 raft ready
I0804 02:00:52.423664 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:0 Commit:21 XXX_unrecognized:[]}
I0804 02:00:52.423685 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/21 EntryConfChange "\b\x00\x10\x01\x18\x83\x80\x80\x800\"\x88\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00 t\x03\xde\xf6:[o\b\x02\x10\x81\x80\x80\x80\x10\x1a\xec\x01J\xe9\x01\no\n\x04\b\x00\x10U\x12\x04\
I0804 02:00:52.423694 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 300000003->100000001 MsgAppResp Term:6 Log:0/21
W0804 02:00:52.423788 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00\x00kb\x00\x01rdsc" "" "range_command.go:1344" id=6eb8384c key="b" rw=false pri=72.14923784 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,85 orig=0.000000000,85 max=0.000000000,85 }
W0804 02:00:52.423810 93842 storage/range_command.go:1264 TODO(tschottdorf): changeReplicasTrigger
I0804 02:00:52.423956 93842 storage/range_command.go:135 executed EndTransaction command header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > commit:true internal_commit_trigger:<change_replicas_trigger:<node_id:3 store_id:3 change_type:REMOVE_REPLICA updated_replicas:<node_id:1 store_id:1 > updated_replicas:<node_id:2 store_id:2 > > > intents:<key:"\000\000\000kb\000\001rdsc" txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > > intents:<key:"\000\000meta2\377\377" txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > > : header:<timestamp:<wall_time:0 logical:0 > txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > > commit_wait:0
I0804 02:00:52.424031 93842 multiraft/multiraft.go:871 node 300000003 applying configuration change {0 ConfChangeRemoveNode 12884901891 [0 0 0 0 0 0 0 0 0 32 116 3 222 246 58 91 111 8 2 16 129 128 128 128 16 26 236 1 74 233 1 10 111 10 4 8 0 16 85 18 4 8 0 16 0 26 1 98 42 4 114 111 111 116 50 4 8 1 16 1 56 2 74 78 10 21 114 97 110 103 101 95 99 111 109 109 97 110 100 46 103 111 58 49 51 52 52 18 1 98 26 16 110 184 56 76 109 81 66 209 174 169 99 214 246 32 60 192 32 188 185 231 226 5 40 0 48 0 56 0 74 4 8 0 16 85 82 4 8 0 16 85 90 4 8 0 16 85 98 0 104 0 80 0 16 1 26 20 26 18 8 3 16 3 24 1 34 4 8 1 16 1 34 4 8 2 16 2 34 47 10 11 0 0 0 107 98 0 1 114 100 115 99 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0 34 45 10 9 0 0 109 101 116 97 50 255 255 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0] []}
I0804 02:00:52.424081 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/21 Commit:21
I0804 02:00:52.424163 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/21 Commit:21 Entries:[6/22 EntryNormal 00000000000000002e4fa459169873f5: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:
I0804 02:00:52.424278 93842 multiraft/multiraft.go:776 node 200000002: group 2 raft ready
I0804 02:00:52.424290 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:0 Commit:21 XXX_unrecognized:[]}
I0804 02:00:52.424358 93842 multiraft/multiraft.go:784 New Entry[0]: 6/22 EntryNormal 00000000000000002e4fa459169873f5: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.425307 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/21 EntryConfChange "\b\x00\x10\x01\x18\x83\x80\x80\x800\"\x88\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00 t\x03\xde\xf6:[o\b\x02\x10\x81\x80\x80\x80\x10\x1a\xec\x01J\xe9\x01\no\n\x04\b\x00\x10U\x12\x04\
I0804 02:00:52.425324 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 200000002->100000001 MsgAppResp Term:6 Log:0/21
I0804 02:00:52.425333 93842 multiraft/multiraft.go:793 Outgoing Message[1]: 200000002->100000001 MsgAppResp Term:6 Log:0/22
I0804 02:00:52.425451 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 300000003->100000001 MsgAppResp Term:6 Log:0/21
I0804 02:00:52.425646 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/22 Commit:21 Entries:[6/23 EntryNormal 00000000000000002607c649581eeb39: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_tim
W0804 02:00:52.425768 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00\x00kb\x00\x01rdsc" "" "range_command.go:1344" id=6eb8384c key="b" rw=false pri=72.14923784 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,85 orig=0.000000000,85 max=0.000000000,85 }
W0804 02:00:52.425797 93842 storage/range_command.go:1264 TODO(tschottdorf): changeReplicasTrigger
I0804 02:00:52.425972 93842 storage/range_command.go:135 executed EndTransaction command header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > commit:true internal_commit_trigger:<change_replicas_trigger:<node_id:3 store_id:3 change_type:REMOVE_REPLICA updated_replicas:<node_id:1 store_id:1 > updated_replicas:<node_id:2 store_id:2 > > > intents:<key:"\000\000\000kb\000\001rdsc" txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > > intents:<key:"\000\000meta2\377\377" txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > > : header:<timestamp:<wall_time:0 logical:0 > txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > > commit_wait:0
I0804 02:00:52.426106 93842 multiraft/multiraft.go:871 node 200000002 applying configuration change {0 ConfChangeRemoveNode 12884901891 [0 0 0 0 0 0 0 0 0 32 116 3 222 246 58 91 111 8 2 16 129 128 128 128 16 26 236 1 74 233 1 10 111 10 4 8 0 16 85 18 4 8 0 16 0 26 1 98 42 4 114 111 111 116 50 4 8 1 16 1 56 2 74 78 10 21 114 97 110 103 101 95 99 111 109 109 97 110 100 46 103 111 58 49 51 52 52 18 1 98 26 16 110 184 56 76 109 81 66 209 174 169 99 214 246 32 60 192 32 188 185 231 226 5 40 0 48 0 56 0 74 4 8 0 16 85 82 4 8 0 16 85 90 4 8 0 16 85 98 0 104 0 80 0 16 1 26 20 26 18 8 3 16 3 24 1 34 4 8 1 16 1 34 4 8 2 16 2 34 47 10 11 0 0 0 107 98 0 1 114 100 115 99 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0 34 45 10 9 0 0 109 101 116 97 50 255 255 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0] []}
I0804 02:00:52.426138 93842 multiraft/multiraft.go:776 node 200000002: group 2 raft ready
I0804 02:00:52.426238 93842 multiraft/multiraft.go:784 New Entry[0]: 6/23 EntryNormal 00000000000000002607c649581eeb39: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.426251 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 200000002->100000001 MsgAppResp Term:6 Log:0/23
I0804 02:00:52.426517 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/21
I0804 02:00:52.426533 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/22
I0804 02:00:52.426627 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.426656 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:22 XXX_unrecognized:[]}
I0804 02:00:52.426727 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/22 EntryNormal 00000000000000002e4fa459169873f5: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.426737 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/23 Commit:22
I0804 02:00:52.426813 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/23
I0804 02:00:52.426955 93842 storage/range_command.go:135 executed ConditionalPut command header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000kb\000\001rdsc" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001" checksum:2503404014 > exp_value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002" checksum:1271410328 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.427139 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.427152 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:23 XXX_unrecognized:[]}
I0804 02:00:52.427227 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/23 EntryNormal 00000000000000002607c649581eeb39: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.427237 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/23 Commit:23
I0804 02:00:52.427410 93842 storage/range_command.go:135 executed InternalPushTxn command header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > pushee_txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > now:<wall_time:0 logical:96 > push_type:CLEANUP_TXN range_lookup:false : header:<timestamp:<wall_time:0 logical:0 > > pushee_txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false >
I0804 02:00:52.427530 93842 multiraft/multiraft.go:767 group 1: new proposal 0000000000000000727a71f52257bb7d
I0804 02:00:52.427563 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.427573 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:30 XXX_unrecognized:[]}
I0804 02:00:52.427634 93842 multiraft/multiraft.go:784 New Entry[0]: 6/30 EntryNormal 0000000000000000727a71f52257bb7d: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" u
I0804 02:00:52.427691 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/30 EntryNormal 0000000000000000727a71f52257bb7d: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" u
I0804 02:00:52.427812 93842 storage/range_command.go:135 executed Put command header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001" checksum:647626849 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.427952 93842 multiraft/multiraft.go:767 group 2: new proposal 000000000000000009825e117039374b
I0804 02:00:52.427964 93842 multiraft/multiraft.go:767 group 1: new proposal 00000000000000001c73fac825416fed
I0804 02:00:52.428022 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.428096 93842 multiraft/multiraft.go:784 New Entry[0]: 6/24 EntryNormal 000000000000000009825e117039374b: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.428167 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/23 Commit:23 Entries:[6/24 EntryNormal 000000000000000009825e117039374b: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_tim
I0804 02:00:52.428176 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.428185 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:31 XXX_unrecognized:[]}
I0804 02:00:52.428233 93842 multiraft/multiraft.go:784 New Entry[0]: 6/31 EntryNormal 00000000000000001c73fac825416fed: raft_id:1 origin_node_id:100000001 cmd:<internal_resolve_intent:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000
I0804 02:00:52.428280 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/31 EntryNormal 00000000000000001c73fac825416fed: raft_id:1 origin_node_id:100000001 cmd:<internal_resolve_intent:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000
I0804 02:00:52.428432 93842 storage/range_command.go:135 executed InternalResolveIntent command header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.428524 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/23 Commit:22
I0804 02:00:52.428541 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/23 Commit:23
I0804 02:00:52.428721 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/23 Commit:23 Entries:[6/24 EntryNormal 000000000000000009825e117039374b: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_tim
I0804 02:00:52.428792 93842 multiraft/multiraft.go:776 node 200000002: group 2 raft ready
I0804 02:00:52.428803 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:0 Commit:23 XXX_unrecognized:[]}
I0804 02:00:52.428874 93842 multiraft/multiraft.go:784 New Entry[0]: 6/24 EntryNormal 000000000000000009825e117039374b: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.428950 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/22 EntryNormal 00000000000000002e4fa459169873f5: raft_id:2 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000
I0804 02:00:52.429016 93842 multiraft/multiraft.go:787 Committed Entry[1]: 6/23 EntryNormal 00000000000000002607c649581eeb39: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.429026 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 200000002->100000001 MsgAppResp Term:6 Log:0/23
I0804 02:00:52.429034 93842 multiraft/multiraft.go:793 Outgoing Message[1]: 200000002->100000001 MsgAppResp Term:6 Log:0/23
I0804 02:00:52.429042 93842 multiraft/multiraft.go:793 Outgoing Message[2]: 200000002->100000001 MsgAppResp Term:6 Log:0/24
I0804 02:00:52.429216 93842 storage/range_command.go:135 executed ConditionalPut command header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000kb\000\001rdsc" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001" checksum:2503404014 > exp_value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001\"\004\010\002\020\002" checksum:1271410328 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.429363 93842 storage/range_command.go:135 executed InternalPushTxn command header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > pushee_txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > now:<wall_time:0 logical:96 > push_type:CLEANUP_TXN range_lookup:false : header:<timestamp:<wall_time:0 logical:0 > > pushee_txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false >
I0804 02:00:52.429435 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/23
I0804 02:00:52.429451 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/23
I0804 02:00:52.429499 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/24
I0804 02:00:52.429578 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.429589 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:24 XXX_unrecognized:[]}
I0804 02:00:52.429662 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/24 EntryNormal 000000000000000009825e117039374b: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.429672 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/24 Commit:24
I0804 02:00:52.429840 93842 storage/range_command.go:135 executed InternalPushTxn command header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > pushee_txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > now:<wall_time:0 logical:105 > push_type:ABORT_TXN range_lookup:false : header:<timestamp:<wall_time:0 logical:0 > > pushee_txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false >
I0804 02:00:52.429948 93842 multiraft/multiraft.go:767 group 1: new proposal 0000000000000000572d92faded7e411
W0804 02:00:52.429978 93842 storage/store.go:1291 conflicting intents on ["\x00\x00meta2\xff\xff"]: resolved? true
I0804 02:00:52.430018 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.430028 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:32 XXX_unrecognized:[]}
I0804 02:00:52.430086 93842 multiraft/multiraft.go:784 New Entry[0]: 6/32 EntryNormal 0000000000000000572d92faded7e411: raft_id:1 origin_node_id:100000001 cmd:<internal_resolve_intent:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000
I0804 02:00:52.430135 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/32 EntryNormal 0000000000000000572d92faded7e411: raft_id:1 origin_node_id:100000001 cmd:<internal_resolve_intent:<header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000
I0804 02:00:52.430245 93842 storage/range_command.go:135 executed InternalResolveIntent command header:<timestamp:<wall_time:0 logical:85 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" user:"root" replica:<node_id:0 store_id:0 > raft_id:0 txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.430309 93842 multiraft/multiraft.go:767 group 1: new proposal 00000000000000001ee9f7676678e7aa
I0804 02:00:52.430340 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.430350 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:33 XXX_unrecognized:[]}
I0804 02:00:52.430409 93842 multiraft/multiraft.go:784 New Entry[0]: 6/33 EntryNormal 00000000000000001ee9f7676678e7aa: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" u
I0804 02:00:52.430465 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/33 EntryNormal 00000000000000001ee9f7676678e7aa: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" u
I0804 02:00:52.430583 93842 storage/range_command.go:135 executed Put command header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\002\022\001b\032\002\377\377\"\004\010\001\020\001" checksum:647626849 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.430691 93842 multiraft/multiraft.go:767 group 2: new proposal 000000000000000027dff7ab244fcd36
I0804 02:00:52.430743 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.430765 93842 multiraft/multiraft.go:784 New Entry[0]: 6/25 EntryConfChange "\b\x00\x10\x01\x18\x82\x80\x80\x80 \"\x82\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00'\xdf\xf7\xab$O\xcd6\b\x02\x10\x81\x80\x80\x80\x10\x1a\xe6\x01J\xe3\x01\no\n\x04\b\x00\x10^\x12\x
I0804 02:00:52.430786 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/24 Commit:24 Entries:[6/25 EntryConfChange "\b\x00\x10\x01\x18\x82\x80\x80\x80 \"\x82\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00'\xdf\xf7\xab$O\xcd6\b\x02\x10\x81
I0804 02:00:52.430879 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/24 Commit:24
I0804 02:00:52.430911 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/24 Commit:24 Entries:[6/25 EntryConfChange "\b\x00\x10\x01\x18\x82\x80\x80\x80 \"\x82\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00'\xdf\xf7\xab$O\xcd6\b\x02\x10\x81
I0804 02:00:52.431014 93842 multiraft/multiraft.go:776 node 200000002: group 2 raft ready
I0804 02:00:52.431025 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:0 Commit:24 XXX_unrecognized:[]}
I0804 02:00:52.431044 93842 multiraft/multiraft.go:784 New Entry[0]: 6/25 EntryConfChange "\b\x00\x10\x01\x18\x82\x80\x80\x80 \"\x82\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00'\xdf\xf7\xab$O\xcd6\b\x02\x10\x81\x80\x80\x80\x10\x1a\xe6\x01J\xe3\x01\no\n\x04\b\x00\x10^\x12\x
I0804 02:00:52.431120 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/24 EntryNormal 000000000000000009825e117039374b: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.431129 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 200000002->100000001 MsgAppResp Term:6 Log:0/24
I0804 02:00:52.431137 93842 multiraft/multiraft.go:793 Outgoing Message[1]: 200000002->100000001 MsgAppResp Term:6 Log:0/25
I0804 02:00:52.431335 93842 storage/range_command.go:135 executed InternalPushTxn command header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > pushee_txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false > now:<wall_time:0 logical:105 > push_type:ABORT_TXN range_lookup:false : header:<timestamp:<wall_time:0 logical:0 > > pushee_txn:<name:"range_command.go:1344" key:"b" id:"n\2708LmQB\321\256\251c\326\366 <\300" priority:1549393084 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:85 > orig_timestamp:<wall_time:0 logical:85 > max_timestamp:<wall_time:0 logical:85 > certain_nodes:<> Writing:false >
I0804 02:00:52.431409 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/24
I0804 02:00:52.431425 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/25
I0804 02:00:52.431521 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.431532 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:25 XXX_unrecognized:[]}
I0804 02:00:52.431552 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/25 EntryConfChange "\b\x00\x10\x01\x18\x82\x80\x80\x80 \"\x82\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00'\xdf\xf7\xab$O\xcd6\b\x02\x10\x81\x80\x80\x80\x10\x1a\xe6\x01J\xe3\x01\no\n\x04\b\x00\x10^\x12\x
I0804 02:00:52.431561 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgApp Term:6 Log:6/25 Commit:25
W0804 02:00:52.431655 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00\x00kb\x00\x01rdsc" "" "range_command.go:1344" id=086dbfab key="b" rw=false pri=21.13950850 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,94 orig=0.000000000,94 max=0.000000000,94 }
W0804 02:00:52.431677 93842 storage/range_command.go:1264 TODO(tschottdorf): changeReplicasTrigger
I0804 02:00:52.432746 93842 storage/range_command.go:135 executed EndTransaction command header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > commit:true internal_commit_trigger:<change_replicas_trigger:<node_id:2 store_id:2 change_type:REMOVE_REPLICA updated_replicas:<node_id:1 store_id:1 > > > intents:<key:"\000\000\000kb\000\001rdsc" txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > > intents:<key:"\000\000meta2\377\377" txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > > : header:<timestamp:<wall_time:0 logical:0 > txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > > commit_wait:0
I0804 02:00:52.433030 93842 multiraft/multiraft.go:871 node 100000001 applying configuration change {0 ConfChangeRemoveNode 8589934594 [0 0 0 0 0 0 0 0 0 39 223 247 171 36 79 205 54 8 2 16 129 128 128 128 16 26 230 1 74 227 1 10 111 10 4 8 0 16 94 18 4 8 0 16 0 26 1 98 42 4 114 111 111 116 50 4 8 1 16 1 56 2 74 78 10 21 114 97 110 103 101 95 99 111 109 109 97 110 100 46 103 111 58 49 51 52 52 18 1 98 26 16 8 109 191 171 61 84 66 24 180 51 189 116 11 31 102 101 32 128 253 187 216 1 40 0 48 0 56 0 74 4 8 0 16 94 82 4 8 0 16 94 90 4 8 0 16 94 98 0 104 0 80 0 16 1 26 14 26 12 8 2 16 2 24 1 34 4 8 1 16 1 34 47 10 11 0 0 0 107 98 0 1 114 100 115 99 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0 34 45 10 9 0 0 109 101 116 97 50 255 255 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0] []}
I0804 02:00:52.433062 93842 multiraft/multiraft.go:500 node 200000002: group 2 got message 100000001->200000002 MsgApp Term:6 Log:6/25 Commit:25
I0804 02:00:52.433155 93842 multiraft/multiraft.go:776 node 200000002: group 2 raft ready
I0804 02:00:52.433183 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:0 Commit:25 XXX_unrecognized:[]}
I0804 02:00:52.433205 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/25 EntryConfChange "\b\x00\x10\x01\x18\x82\x80\x80\x80 \"\x82\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00'\xdf\xf7\xab$O\xcd6\b\x02\x10\x81\x80\x80\x80\x10\x1a\xe6\x01J\xe3\x01\no\n\x04\b\x00\x10^\x12\x
I0804 02:00:52.433215 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 200000002->100000001 MsgAppResp Term:6 Log:0/25
I0804 02:00:52.433262 93842 multiraft/multiraft.go:767 group 2: new proposal 00000000000000005ef4e81ede4561ad
W0804 02:00:52.433387 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00\x00kb\x00\x01rdsc" "" "range_command.go:1344" id=086dbfab key="b" rw=false pri=21.13950850 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,94 orig=0.000000000,94 max=0.000000000,94 }
W0804 02:00:52.433411 93842 storage/range_command.go:1264 TODO(tschottdorf): changeReplicasTrigger
I0804 02:00:52.433557 93842 storage/range_command.go:135 executed EndTransaction command header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > commit:true internal_commit_trigger:<change_replicas_trigger:<node_id:2 store_id:2 change_type:REMOVE_REPLICA updated_replicas:<node_id:1 store_id:1 > > > intents:<key:"\000\000\000kb\000\001rdsc" txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > > intents:<key:"\000\000meta2\377\377" txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > > : header:<timestamp:<wall_time:0 logical:0 > txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > > commit_wait:0
I0804 02:00:52.433607 93842 multiraft/multiraft.go:776 node 100000001: group 2 raft ready
I0804 02:00:52.433618 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:26 XXX_unrecognized:[]}
I0804 02:00:52.433691 93842 multiraft/multiraft.go:784 New Entry[0]: 6/26 EntryNormal 00000000000000005ef4e81ede4561ad: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.433763 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/26 EntryNormal 00000000000000005ef4e81ede4561ad: raft_id:2 origin_node_id:100000001 cmd:<internal_push_txn:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"b" user:"r
I0804 02:00:52.433803 93842 multiraft/multiraft.go:871 node 200000002 applying configuration change {0 ConfChangeRemoveNode 8589934594 [0 0 0 0 0 0 0 0 0 39 223 247 171 36 79 205 54 8 2 16 129 128 128 128 16 26 230 1 74 227 1 10 111 10 4 8 0 16 94 18 4 8 0 16 0 26 1 98 42 4 114 111 111 116 50 4 8 1 16 1 56 2 74 78 10 21 114 97 110 103 101 95 99 111 109 109 97 110 100 46 103 111 58 49 51 52 52 18 1 98 26 16 8 109 191 171 61 84 66 24 180 51 189 116 11 31 102 101 32 128 253 187 216 1 40 0 48 0 56 0 74 4 8 0 16 94 82 4 8 0 16 94 90 4 8 0 16 94 98 0 104 0 80 0 16 1 26 14 26 12 8 2 16 2 24 1 34 4 8 1 16 1 34 47 10 11 0 0 0 107 98 0 1 114 100 115 99 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0 34 45 10 9 0 0 109 101 116 97 50 255 255 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0] []}
I0804 02:00:52.433996 93842 storage/range_command.go:135 executed InternalPushTxn command header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"b" user:"root" replica:<node_id:1 store_id:1 > raft_id:2 txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > pushee_txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > now:<wall_time:0 logical:116 > push_type:CLEANUP_TXN range_lookup:false : header:<timestamp:<wall_time:0 logical:0 > > pushee_txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false >
I0804 02:00:52.434111 93842 multiraft/multiraft.go:767 group 1: new proposal 00000000000000005d78399cbed80a3a
I0804 02:00:52.434143 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.434154 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:34 XXX_unrecognized:[]}
I0804 02:00:52.434211 93842 multiraft/multiraft.go:784 New Entry[0]: 6/34 EntryNormal 00000000000000005d78399cbed80a3a: raft_id:1 origin_node_id:100000001 cmd:<internal_resolve_intent:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"\000
I0804 02:00:52.434262 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/34 EntryNormal 00000000000000005d78399cbed80a3a: raft_id:1 origin_node_id:100000001 cmd:<internal_resolve_intent:<header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"\000
I0804 02:00:52.434378 93842 storage/range_command.go:135 executed InternalResolveIntent command header:<timestamp:<wall_time:0 logical:94 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2\377\377" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1344" key:"b" id:"\010m\277\253=TB\030\2643\275t\013\037fe" priority:453967488 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:94 > orig_timestamp:<wall_time:0 logical:94 > max_timestamp:<wall_time:0 logical:94 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.434475 93842 multiraft/multiraft.go:734 node 200000002 removing group 2
W0804 02:00:52.434533 93842 storage/client_raft_test.go:868 _______________________
I0804 02:00:52.434615 93842 multiraft/multiraft.go:767 group 1: new proposal 000000000000000072d0a1e9406aec9d
I0804 02:00:52.434647 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.434657 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:35 XXX_unrecognized:[]}
I0804 02:00:52.434727 93842 multiraft/multiraft.go:784 New Entry[0]: 6/35 EntryNormal 000000000000000072d0a1e9406aec9d: raft_id:1 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:122 > cmd_id:<wall_time:0 random:0 > key:"\000\000\00
I0804 02:00:52.434792 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/35 EntryNormal 000000000000000072d0a1e9406aec9d: raft_id:1 origin_node_id:100000001 cmd:<conditional_put:<header:<timestamp:<wall_time:0 logical:122 > cmd_id:<wall_time:0 random:0 > key:"\000\000\00
I0804 02:00:52.434936 93842 storage/range_command.go:135 executed ConditionalPut command header:<timestamp:<wall_time:0 logical:122 > cmd_id:<wall_time:0 random:0 > key:"\000\000\000k\000\001rdsc" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1344" key:"" id:"EQ\247\344\304\243L1\251\377r\037\004c\356+" priority:1227593819 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:122 > orig_timestamp:<wall_time:0 logical:122 > max_timestamp:<wall_time:0 logical:122 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\001\022\000\032\001b\"\004\010\001\020\001\"\004\010\002\020\002" checksum:4064119559 > exp_value:<bytes:"\010\001\022\000\032\001b\"\004\010\001\020\001" checksum:2733074692 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.435132 93842 multiraft/multiraft.go:767 group 1: new proposal 000000000000000057613082c233f007
I0804 02:00:52.435165 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.435175 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:36 XXX_unrecognized:[]}
I0804 02:00:52.435238 93842 multiraft/multiraft.go:784 New Entry[0]: 6/36 EntryNormal 000000000000000057613082c233f007: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:122 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2b" user:"r
I0804 02:00:52.435310 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/36 EntryNormal 000000000000000057613082c233f007: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:122 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2b" user:"r
I0804 02:00:52.435433 93842 storage/range_command.go:135 executed Put command header:<timestamp:<wall_time:0 logical:122 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta2b" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1344" key:"" id:"EQ\247\344\304\243L1\251\377r\037\004c\356+" priority:1227593819 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:122 > orig_timestamp:<wall_time:0 logical:122 > max_timestamp:<wall_time:0 logical:122 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\001\022\000\032\001b\"\004\010\001\020\001\"\004\010\002\020\002" checksum:1867480352 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.435533 93842 multiraft/multiraft.go:767 group 1: new proposal 00000000000000007d4d8e9fa5ead0bd
I0804 02:00:52.435564 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.435574 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:37 XXX_unrecognized:[]}
I0804 02:00:52.435635 93842 multiraft/multiraft.go:784 New Entry[0]: 6/37 EntryNormal 00000000000000007d4d8e9fa5ead0bd: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:122 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta1\377\377"
I0804 02:00:52.435692 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/37 EntryNormal 00000000000000007d4d8e9fa5ead0bd: raft_id:1 origin_node_id:100000001 cmd:<put:<header:<timestamp:<wall_time:0 logical:122 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta1\377\377"
I0804 02:00:52.435815 93842 storage/range_command.go:135 executed Put command header:<timestamp:<wall_time:0 logical:122 > cmd_id:<wall_time:0 random:0 > key:"\000\000meta1\377\377" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1344" key:"" id:"EQ\247\344\304\243L1\251\377r\037\004c\356+" priority:1227593819 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:122 > orig_timestamp:<wall_time:0 logical:122 > max_timestamp:<wall_time:0 logical:122 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > value:<bytes:"\010\001\022\000\032\001b\"\004\010\001\020\001\"\004\010\002\020\002" checksum:1588464792 > : header:<timestamp:<wall_time:0 logical:0 > >
I0804 02:00:52.435935 93842 multiraft/multiraft.go:767 group 1: new proposal 0000000000000000760b0d22050143a6
I0804 02:00:52.435968 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.435978 93842 multiraft/multiraft.go:781 HardState updated: {Term:6 Vote:4294967297 Commit:38 XXX_unrecognized:[]}
I0804 02:00:52.436002 93842 multiraft/multiraft.go:784 New Entry[0]: 6/38 EntryConfChange "\b\x00\x10\x00\x18\x82\x80\x80\x80 \"\xb3\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00v\v\r\"\x05\x01C\xa6\b\x01\x10\x81\x80\x80\x80\x10\x1a\x97\x02J\x94\x02\nm\n\x04\b\x00\x10z\x12\x
I0804 02:00:52.436022 93842 multiraft/multiraft.go:787 Committed Entry[0]: 6/38 EntryConfChange "\b\x00\x10\x00\x18\x82\x80\x80\x80 \"\xb3\x02\x00\x00\x00\x00\x00\x00\x00\x00\x00v\v\r\"\x05\x01C\xa6\b\x01\x10\x81\x80\x80\x80\x10\x1a\x97\x02J\x94\x02\nm\n\x04\b\x00\x10z\x12\x
W0804 02:00:52.436118 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00\x00k\x00\x01rdsc" "" "range_command.go:1344" id=4551a7e4 key="" rw=false pri=57.16429183 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,122 orig=0.000000000,122 max=0.000000000,122 }
W0804 02:00:52.436154 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00meta1\xff\xff" "" "range_command.go:1344" id=4551a7e4 key="" rw=false pri=57.16429183 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,122 orig=0.000000000,122 max=0.000000000,122 }
W0804 02:00:52.436185 93842 storage/range_command.go:346 resolving on EndTransaction: {"\x00\x00meta2b" "" "range_command.go:1344" id=4551a7e4 key="" rw=false pri=57.16429183 iso=SERIALIZABLE stat=PENDING epo=0 ts=0.000000000,122 orig=0.000000000,122 max=0.000000000,122 }
W0804 02:00:52.436202 93842 storage/range_command.go:1264 TODO(tschottdorf): changeReplicasTrigger
I0804 02:00:52.436365 93842 storage/range_command.go:135 executed EndTransaction command header:<timestamp:<wall_time:0 logical:122 > cmd_id:<wall_time:0 random:0 > key:"" user:"root" replica:<node_id:1 store_id:1 > raft_id:1 txn:<name:"range_command.go:1344" key:"" id:"EQ\247\344\304\243L1\251\377r\037\004c\356+" priority:1227593819 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:122 > orig_timestamp:<wall_time:0 logical:122 > max_timestamp:<wall_time:0 logical:122 > certain_nodes:<> Writing:false > read_consistency:CONSISTENT > commit:true internal_commit_trigger:<change_replicas_trigger:<node_id:2 store_id:2 change_type:ADD_REPLICA updated_replicas:<node_id:1 store_id:1 > updated_replicas:<node_id:2 store_id:2 > > > intents:<key:"\000\000\000k\000\001rdsc" txn:<name:"range_command.go:1344" key:"" id:"EQ\247\344\304\243L1\251\377r\037\004c\356+" priority:1227593819 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:122 > orig_timestamp:<wall_time:0 logical:122 > max_timestamp:<wall_time:0 logical:122 > certain_nodes:<> Writing:false > > intents:<key:"\000\000meta1\377\377" txn:<name:"range_command.go:1344" key:"" id:"EQ\247\344\304\243L1\251\377r\037\004c\356+" priority:1227593819 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:122 > orig_timestamp:<wall_time:0 logical:122 > max_timestamp:<wall_time:0 logical:122 > certain_nodes:<> Writing:false > > intents:<key:"\000\000meta2b" txn:<name:"range_command.go:1344" key:"" id:"EQ\247\344\304\243L1\251\377r\037\004c\356+" priority:1227593819 isolation:SERIALIZABLE status:PENDING epoch:0 timestamp:<wall_time:0 logical:122 > orig_timestamp:<wall_time:0 logical:122 > max_timestamp:<wall_time:0 logical:122 > certain_nodes:<> Writing:false > > : header:<timestamp:<wall_time:0 logical:0 > txn:<name:"range_command.go:1344" key:"" id:"EQ\247\344\304\243L1\251\377r\037\004c\356+" priority:1227593819 isolation:SERIALIZABLE status:COMMITTED epoch:0 timestamp:<wall_time:0 logical:122 > orig_timestamp:<wall_time:0 logical:122 > max_timestamp:<wall_time:0 logical:122 > certain_nodes:<> Writing:false > > commit_wait:0
I0804 02:00:52.436520 93842 multiraft/multiraft.go:871 node 100000001 applying configuration change {0 ConfChangeAddNode 8589934594 [0 0 0 0 0 0 0 0 0 118 11 13 34 5 1 67 166 8 1 16 129 128 128 128 16 26 151 2 74 148 2 10 109 10 4 8 0 16 122 18 4 8 0 16 0 26 0 42 4 114 111 111 116 50 4 8 1 16 1 56 1 74 77 10 21 114 97 110 103 101 95 99 111 109 109 97 110 100 46 103 111 58 49 51 52 52 18 0 26 16 69 81 167 228 196 163 76 49 169 255 114 31 4 99 238 43 32 219 176 174 201 4 40 0 48 0 56 0 74 4 8 0 16 122 82 4 8 0 16 122 90 4 8 0 16 122 98 0 104 0 80 0 16 1 26 20 26 18 8 2 16 2 24 0 34 4 8 1 16 1 34 4 8 2 16 2 34 46 10 10 0 0 0 107 0 1 114 100 115 99 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0 34 45 10 9 0 0 109 101 116 97 49 255 255 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0 34 44 10 8 0 0 109 101 116 97 50 98 26 32 10 0 32 0 40 0 48 0 56 0 74 4 8 0 16 0 82 4 8 0 16 0 90 4 8 0 16 0 98 0 104 0] []}
I0804 02:00:52.436656 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 300000003->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.436747 93842 multiraft/multiraft.go:500 node 100000001: group 2 got message 200000002->100000001 MsgAppResp Term:6 Log:0/25
I0804 02:00:52.470567 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 100000001->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.470628 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.470655 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgHeartbeat Term:6 Log:0/0
I0804 02:00:52.470792 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 100000001->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.470892 93842 multiraft/multiraft.go:776 node 300000003: group 2 raft ready
I0804 02:00:52.470912 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 300000003->100000001 MsgHeartbeatResp Term:6 Log:0/0
I0804 02:00:52.471004 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeatResp Term:0 Log:0/0
I0804 02:00:52.483282 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 200000002->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.483356 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 200000002->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.484710 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.484786 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 300000003->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.573311 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.573338 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgHeartbeat Term:6 Log:0/0
I0804 02:00:52.573421 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 100000001->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.573465 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 100000001->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.573528 93842 multiraft/multiraft.go:776 node 300000003: group 2 raft ready
I0804 02:00:52.573542 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 300000003->100000001 MsgHeartbeatResp Term:6 Log:0/0
I0804 02:00:52.573610 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeatResp Term:0 Log:0/0
I0804 02:00:52.583280 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 200000002->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.583332 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 200000002->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.584677 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 300000003->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.584729 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.673155 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.673207 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgHeartbeat Term:6 Log:0/0
I0804 02:00:52.673297 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 100000001->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.673427 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 100000001->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.673528 93842 multiraft/multiraft.go:776 node 300000003: group 2 raft ready
I0804 02:00:52.673558 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 300000003->100000001 MsgHeartbeatResp Term:6 Log:0/0
I0804 02:00:52.673644 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeatResp Term:0 Log:0/0
I0804 02:00:52.683306 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 200000002->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.683389 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 200000002->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.684671 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 300000003->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.684729 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.773320 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.773350 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgHeartbeat Term:6 Log:0/0
I0804 02:00:52.773442 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 100000001->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.773485 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 100000001->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.773558 93842 multiraft/multiraft.go:776 node 300000003: group 2 raft ready
I0804 02:00:52.773573 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 300000003->100000001 MsgHeartbeatResp Term:6 Log:0/0
I0804 02:00:52.773647 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeatResp Term:0 Log:0/0
I0804 02:00:52.783716 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 200000002->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.783790 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 200000002->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.784589 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.784671 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 300000003->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.872477 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.872513 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgHeartbeat Term:6 Log:0/0
I0804 02:00:52.872626 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 100000001->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.872691 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 100000001->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.872778 93842 multiraft/multiraft.go:776 node 300000003: group 2 raft ready
I0804 02:00:52.872801 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 300000003->100000001 MsgHeartbeatResp Term:6 Log:0/0
I0804 02:00:52.872918 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeatResp Term:0 Log:0/0
I0804 02:00:52.884136 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 200000002->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.884231 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 200000002->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.884367 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 300000003->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.884429 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.974168 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:52.974194 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgHeartbeat Term:6 Log:0/0
I0804 02:00:52.974308 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 100000001->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.974421 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 100000001->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.974535 93842 multiraft/multiraft.go:776 node 300000003: group 2 raft ready
I0804 02:00:52.974555 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 300000003->100000001 MsgHeartbeatResp Term:6 Log:0/0
I0804 02:00:52.974627 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeatResp Term:0 Log:0/0
I0804 02:00:52.985373 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 200000002->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.985431 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 200000002->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.985453 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:52.985533 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 300000003->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.073526 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:53.073578 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgHeartbeat Term:6 Log:0/0
I0804 02:00:53.073654 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 100000001->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.073779 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 100000001->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.073871 93842 multiraft/multiraft.go:776 node 300000003: group 2 raft ready
I0804 02:00:53.073902 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 300000003->100000001 MsgHeartbeatResp Term:6 Log:0/0
I0804 02:00:53.073989 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeatResp Term:0 Log:0/0
I0804 02:00:53.083558 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 200000002->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.083632 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 200000002->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.084609 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 300000003->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.084666 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.172833 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:53.172861 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgHeartbeat Term:6 Log:0/0
I0804 02:00:53.172946 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 100000001->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.173002 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 100000001->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.173046 93842 multiraft/multiraft.go:776 node 300000003: group 2 raft ready
I0804 02:00:53.173060 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 300000003->100000001 MsgHeartbeatResp Term:6 Log:0/0
I0804 02:00:53.173130 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeatResp Term:0 Log:0/0
I0804 02:00:53.187558 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 200000002->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.187620 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 200000002->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.187650 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.188071 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 300000003->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.269824 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:53.269859 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgHeartbeat Term:6 Log:0/0
I0804 02:00:53.269972 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 100000001->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.270061 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 100000001->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.270122 93842 multiraft/multiraft.go:776 node 300000003: group 2 raft ready
I0804 02:00:53.270141 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 300000003->100000001 MsgHeartbeatResp Term:6 Log:0/0
I0804 02:00:53.270236 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeatResp Term:0 Log:0/0
I0804 02:00:53.283255 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 200000002->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.283340 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 200000002->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.284677 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 300000003->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.284729 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.372981 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:53.373018 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgHeartbeat Term:6 Log:0/0
I0804 02:00:53.373109 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 100000001->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.373228 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 100000001->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.373306 93842 multiraft/multiraft.go:776 node 300000003: group 2 raft ready
I0804 02:00:53.373322 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 300000003->100000001 MsgHeartbeatResp Term:6 Log:0/0
I0804 02:00:53.373416 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeatResp Term:0 Log:0/0
I0804 02:00:53.385832 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 200000002->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.385873 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.385993 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 300000003->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.386043 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 200000002->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.472955 93842 multiraft/multiraft.go:776 node 100000001: group 1 raft ready
I0804 02:00:53.472984 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 100000001->200000002 MsgHeartbeat Term:6 Log:0/0
I0804 02:00:53.473078 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 100000001->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.473140 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 100000001->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.473207 93842 multiraft/multiraft.go:776 node 300000003: group 2 raft ready
I0804 02:00:53.473221 93842 multiraft/multiraft.go:793 Outgoing Message[0]: 300000003->100000001 MsgHeartbeatResp Term:6 Log:0/0
I0804 02:00:53.473298 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeatResp Term:0 Log:0/0
I0804 02:00:53.484850 93842 multiraft/multiraft.go:500 node 300000003: group 0 got message 200000002->300000003 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.484915 93842 multiraft/multiraft.go:500 node 200000002: group 0 got message 300000003->200000002 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.484969 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 200000002->100000001 MsgHeartbeat Term:0 Log:0/0
I0804 02:00:53.484988 93842 multiraft/multiraft.go:500 node 100000001: group 0 got message 300000003->100000001 MsgHeartbeat Term:0 Log:0/0
W0804 02:00:53.530061 93842 rpc/server.go:351 rpc: server cannot decode request: read tcp 127.0.0.1:49264: use of closed network connection
W0804 02:00:53.530129 93842 rpc/server.go:351 rpc: server cannot decode request: read tcp 127.0.0.1:49263: use of closed network connection
W0804 02:00:53.530178 93842 rpc/server.go:351 rpc: server cannot decode request: read tcp 127.0.0.1:49265: use of closed network connection
--- FAIL: TestRaftAfterRemoveRange (1.17s)
testing.go:150: storage/client_test.go:320: condition failed to evaluate within 1s: storage/client_test.go:316: range not found on store 1
FAIL
exit status 1
FAIL github.com/cockroachdb/cockroach/storage 1.286s
make: *** [test] Error 1
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment