Oct 11 14:09:59.393 INFO testing raft-0.4.0 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling
Oct 11 14:09:59.393 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen
Oct 11 14:09:59.393 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-6/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-6/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/./work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"`
Oct 11 14:09:59.614 INFO blam! 44dceb896a48f8ddb384fb9b2e0b28cbc27b35e5ed75bf80be446365b12bb21d
Oct 11 14:09:59.620 INFO running `"docker" "start" "-a" "44dceb896a48f8ddb384fb9b2e0b28cbc27b35e5ed75bf80be446365b12bb21d"`
Oct 11 14:10:00.617 INFO kablam! usermod: no changes
Oct 11 14:10:00.789 INFO kablam!    Compiling protobuf v2.1.1
Oct 11 14:10:22.412 INFO kablam!    Compiling raft v0.4.0 (/source)
Oct 11 14:10:28.173 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 27.51s
Oct 11 14:10:28.176 INFO kablam! su: No module specific data is present
Oct 11 14:10:28.712 INFO running `"docker" "rm" "-f" "44dceb896a48f8ddb384fb9b2e0b28cbc27b35e5ed75bf80be446365b12bb21d"`
Oct 11 14:10:28.900 INFO blam! 44dceb896a48f8ddb384fb9b2e0b28cbc27b35e5ed75bf80be446365b12bb21d
Oct 11 14:10:28.902 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run
Oct 11 14:10:28.902 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-6/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-6/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/./work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"`
Oct 11 14:10:29.240 INFO blam! d4290f622806871f119e5fe906f38f3d6dc31fba3859a2f615262c2d76389bd2
Oct 11 14:10:29.250 INFO running `"docker" "start" "-a" "d4290f622806871f119e5fe906f38f3d6dc31fba3859a2f615262c2d76389bd2"`
Oct 11 14:10:29.936 INFO kablam! usermod: no changes
Oct 11 14:10:30.204 INFO kablam!    Compiling raft v0.4.0 (/source)
Oct 11 14:10:49.323 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 19.36s
Oct 11 14:10:49.334 INFO kablam! su: No module specific data is present
Oct 11 14:10:49.759 INFO running `"docker" "rm" "-f" "d4290f622806871f119e5fe906f38f3d6dc31fba3859a2f615262c2d76389bd2"`
Oct 11 14:10:49.980 INFO blam! d4290f622806871f119e5fe906f38f3d6dc31fba3859a2f615262c2d76389bd2
Oct 11 14:10:49.982 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen
Oct 11 14:10:49.982 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-6/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-6/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/./work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"`
Oct 11 14:10:50.345 INFO blam! 3d3f6b369fb77289fc9b438295bb60b4dbc52e82bd86fff5bf3620e14b806e4a
Oct 11 14:10:50.351 INFO running `"docker" "start" "-a" "3d3f6b369fb77289fc9b438295bb60b4dbc52e82bd86fff5bf3620e14b806e4a"`
Oct 11 14:10:51.100 INFO kablam! usermod: no changes
Oct 11 14:10:51.244 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Oct 11 14:10:51.251 INFO kablam!      Running /target/debug/deps/raft-bafe9fc52fbdc8c3
Oct 11 14:10:51.253 INFO blam! 
Oct 11 14:10:51.253 INFO blam! running 37 tests
Oct 11 14:10:51.255 INFO blam! test log_unstable::test::test_maybe_first_index ... ok
Oct 11 14:10:51.255 INFO blam! test errors::tests::test_error_equal ... ok
Oct 11 14:10:51.256 INFO blam! test errors::tests::test_storage_error_equal ... ok
Oct 11 14:10:51.257 INFO blam! test log_unstable::test::test_restore ... ok
Oct 11 14:10:51.258 INFO blam! test log_unstable::test::test_maybe_last_index ... ok
Oct 11 14:10:51.258 INFO blam! test log_unstable::test::test_maybe_term ... ok
Oct 11 14:10:51.258 INFO blam! test log_unstable::test::test_truncate_and_append ... ok
Oct 11 14:10:51.259 INFO blam! test log_unstable::test::test_stable_to ... ok
Oct 11 14:10:51.267 INFO blam! test raft_log::test::test_append ... ok
Oct 11 14:10:51.267 INFO blam! test progress::test::test_inflight_free_to ... ok
Oct 11 14:10:51.267 INFO blam! test progress::test::test_inflight_add ... ok
Oct 11 14:10:51.267 INFO blam! test raft_log::test::test_has_next_ents ... ok
Oct 11 14:10:51.267 INFO blam! test progress::test::test_inflight_free_first_one ... ok
Oct 11 14:10:51.268 INFO blam! test raft_log::test::test_is_up_to_date ... ok
Oct 11 14:10:51.268 INFO blam! test raft_log::test::test_find_conflict ... ok
Oct 11 14:10:51.278 INFO blam! test raft_log::test::test_compaction_side_effects ... ok
Oct 11 14:10:51.278 INFO blam! test raft_log::test::test_log_restore ... ok
Oct 11 14:10:51.279 INFO blam! test raft_log::test::test_next_ents ... ok
Oct 11 14:10:51.284 INFO blam! test raft_log::test::test_stable_to_with_snap ... ok
Oct 11 14:10:51.302 INFO blam! test raft_log::test::test_stable_to ... ok
Oct 11 14:10:51.302 INFO blam! test raft_log::test::test_term ... ok
Oct 11 14:10:51.302 INFO blam! test raft_log::test::test_unstable_ents ... ok
Oct 11 14:10:51.302 INFO blam! test raft_log::test::test_term_with_unstable_snapshot ... ok
Oct 11 14:10:51.304 INFO blam! test raw_node::test::test_is_local_msg ... ok
Oct 11 14:10:51.305 INFO blam! test storage::test::test_storage_append ... ok
Oct 11 14:10:51.305 INFO blam! test storage::test::test_storage_apply_snapshot ... ok
Oct 11 14:10:51.305 INFO blam! test storage::test::test_storage_compact ... ok
Oct 11 14:10:51.305 INFO blam! test storage::test::test_storage_entries ... ok
Oct 11 14:10:51.313 INFO blam! test storage::test::test_storage_create_snapshot ... ok
Oct 11 14:10:51.313 INFO blam! test storage::test::test_storage_last_index ... ok
Oct 11 14:10:51.313 INFO blam! test storage::test::test_storage_first_index ... ok
Oct 11 14:10:51.320 INFO blam! test storage::test::test_storage_term ... ok
Oct 11 14:10:51.341 INFO blam! test raft_log::test::test_commit_to ... ok
Oct 11 14:10:51.347 INFO blam! test raft_log::test::test_is_outofbounds ... ok
Oct 11 14:10:51.358 INFO blam! test raft_log::test::test_log_maybe_append ... ok
Oct 11 14:10:51.358 INFO kablam!      Running /target/debug/deps/tests-f1bbeb7d55ec02d3
Oct 11 14:10:51.358 INFO blam! test raft_log::test::test_compaction ... ok
Oct 11 14:10:51.358 INFO blam! test raft_log::test::test_slice ... ok
Oct 11 14:10:51.358 INFO blam! 
Oct 11 14:10:51.358 INFO blam! test result: ok. 37 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 11 14:10:51.358 INFO blam! 
Oct 11 14:10:51.360 INFO blam! 
Oct 11 14:10:51.360 INFO blam! running 152 tests
Oct 11 14:10:51.367 INFO blam! test integration_cases::test_raft::test_add_node ... ok
Oct 11 14:10:51.367 INFO blam! test integration_cases::test_raft::test_add_node_check_quorum ... ok
Oct 11 14:10:51.367 INFO blam! test integration_cases::test_raft::test_bcast_beat ... ok
Oct 11 14:10:51.367 INFO blam! test integration_cases::test_raft::test_all_server_stepdown ... ok
Oct 11 14:10:51.368 INFO blam! test integration_cases::test_raft::test_candidate_concede ... ok
Oct 11 14:10:51.369 INFO blam! test integration_cases::test_raft::test_add_learner ... ok
Oct 11 14:10:51.369 INFO blam! test integration_cases::test_raft::test_cannot_commit_without_new_term_entry ... ok
Oct 11 14:10:51.373 INFO blam! test integration_cases::test_raft::test_candidate_reset_term_msg_heartbeat ... ok
Oct 11 14:10:51.374 INFO blam! test integration_cases::test_raft::test_campaign_while_leader ... ok
Oct 11 14:10:51.374 INFO blam! test integration_cases::test_raft::test_commit_after_remove_node ... ok
Oct 11 14:10:51.376 INFO blam! test integration_cases::test_raft::test_commit ... ok
Oct 11 14:10:51.377 INFO blam! test integration_cases::test_raft::test_disruptive_follower ... ok
Oct 11 14:10:51.378 INFO blam! test integration_cases::test_raft::test_candidate_reset_term_msg_append ... ok
Oct 11 14:10:51.378 INFO blam! test integration_cases::test_raft::test_election_tick_range ... ok
Oct 11 14:10:51.379 INFO blam! test integration_cases::test_raft::test_disruptive_follower_pre_vote ... ok
Oct 11 14:10:51.379 INFO blam! test integration_cases::test_raft::test_handle_heartbeat_resp ... ok
Oct 11 14:10:51.379 INFO blam! test integration_cases::test_raft::test_commit_without_new_term_entry ... ok
Oct 11 14:10:51.382 INFO blam! test integration_cases::test_raft::test_ignore_providing_snapshot ... ok
Oct 11 14:10:51.384 INFO blam! test integration_cases::test_raft::test_free_stuck_candidate_with_check_quorum ... ok
Oct 11 14:10:51.384 INFO blam! test integration_cases::test_raft::test_leader_append_response ... ok
Oct 11 14:10:51.384 INFO blam! test integration_cases::test_raft::test_handle_msg_append ... ok
Oct 11 14:10:51.385 INFO blam! test integration_cases::test_raft::test_dueling_candidates ... ok
Oct 11 14:10:51.385 INFO blam! test integration_cases::test_raft::test_dueling_pre_candidates ... ok
Oct 11 14:10:51.385 INFO blam! test integration_cases::test_raft::test_leader_cycle ... ok
Oct 11 14:10:51.387 INFO blam! test integration_cases::test_raft::test_handle_heartbeat ... ok
Oct 11 14:10:51.387 INFO blam! test integration_cases::test_raft::test_leader_increase_next ... ok
Oct 11 14:10:51.388 INFO blam! test integration_cases::test_raft::test_leader_election_overwrite_newer_logs_pre_vote ... ok
Oct 11 14:10:51.388 INFO blam! test integration_cases::test_raft::test_leader_election_with_check_quorum ... ok
Oct 11 14:10:51.389 INFO blam! test integration_cases::test_raft::test_leader_cycle_pre_vote ... ok
Oct 11 14:10:51.389 INFO blam! test integration_cases::test_raft::test_leader_stepdown_when_quorum_lost ... ok
Oct 11 14:10:51.389 INFO blam! test integration_cases::test_raft::test_leader_stepdown_when_quorum_active ... ok
Oct 11 14:10:51.391 INFO blam! test integration_cases::test_raft::test_leader_transfer_after_snapshot ... ok
Oct 11 14:10:51.391 INFO blam! test integration_cases::test_raft::test_leader_transfer_back ... ok
Oct 11 14:10:51.391 INFO blam! test integration_cases::test_raft::test_leader_transfer_receive_higher_term_vote ... ok
Oct 11 14:10:51.391 INFO blam! test integration_cases::test_raft::test_leader_transfer_ignore_proposal ... ok
Oct 11 14:10:51.392 INFO blam! test integration_cases::test_raft::test_leader_election ... ok
Oct 11 14:10:51.392 INFO blam! test integration_cases::test_raft::test_leader_election_overwrite_newer_logs ... ok
Oct 11 14:10:51.392 INFO blam! test integration_cases::test_raft::test_leader_superseding_with_check_quorum ... ok
Oct 11 14:10:51.404 INFO blam! test integration_cases::test_raft::test_leader_transfer_second_transfer_to_another_node ... ok
Oct 11 14:10:51.404 INFO blam! test integration_cases::test_raft::test_leader_transfer_second_transfer_to_same_node ... ok
Oct 11 14:10:51.408 INFO blam! test integration_cases::test_raft::test_leader_transfer_remove_node ... ok
Oct 11 14:10:51.409 INFO blam! test integration_cases::test_raft::test_leader_transfer_to_slow_follower ... ok
Oct 11 14:10:51.409 INFO blam! test integration_cases::test_raft::test_leader_transfer_to_uptodate_node ... ok
Oct 11 14:10:51.409 INFO blam! test integration_cases::test_raft::test_leader_election_pre_vote ... ok
Oct 11 14:10:51.410 INFO blam! test integration_cases::test_raft::test_leader_transfer_to_self ... ok
Oct 11 14:10:51.410 INFO blam! test integration_cases::test_raft::test_leader_transfer_timeout ... ok
Oct 11 14:10:51.410 INFO blam! test integration_cases::test_raft::test_leader_transfer_with_check_quorum ... ok
Oct 11 14:10:51.411 INFO blam! test integration_cases::test_raft::test_leader_transfer_to_non_existing_node ... ok
Oct 11 14:10:51.412 INFO blam! test integration_cases::test_raft::test_learner_log_replication ... ok
Oct 11 14:10:51.415 INFO blam! test integration_cases::test_raft::test_learner_promotion ... ok
Oct 11 14:10:51.415 INFO blam! test integration_cases::test_raft::test_msg_append_response_wait_reset ... ok
Oct 11 14:10:51.415 INFO blam! test integration_cases::test_raft::test_learner_receive_snapshot ... ok
Oct 11 14:10:51.415 INFO blam! test integration_cases::test_raft::test_leader_transfer_to_uptodate_node_from_follower ... ok
Oct 11 14:10:51.415 INFO blam! test integration_cases::test_raft::test_learner_election_timeout ... ok
Oct 11 14:10:51.415 INFO blam! test integration_cases::test_raft::test_new_leader_pending_config ... ok
Oct 11 14:10:51.416 INFO blam! test integration_cases::test_raft::test_node_with_smaller_term_can_complete_election ... ok
Oct 11 14:10:51.420 INFO blam! test integration_cases::test_raft::test_learner_respond_vote ... ok
Oct 11 14:10:51.420 INFO blam! test integration_cases::test_raft::test_log_replicatioin ... ok
Oct 11 14:10:51.420 INFO blam! test integration_cases::test_raft::test_pre_campaign_while_leader ... ok
Oct 11 14:10:51.420 INFO blam! test integration_cases::test_raft::test_prevote_migration_can_complete_election ... ok
Oct 11 14:10:51.424 INFO blam! test integration_cases::test_raft::test_prevote_migration_with_free_stuck_pre_candidate ... ok
Oct 11 14:10:51.424 INFO blam! test integration_cases::test_raft::test_progress_become_replicate ... ok
Oct 11 14:10:51.424 INFO blam! test integration_cases::test_raft::test_progress_become_snapshot ... ok
Oct 11 14:10:51.424 INFO blam! test integration_cases::test_raft::test_progress_is_paused ... ok
Oct 11 14:10:51.427 INFO blam! test integration_cases::test_raft::test_progress_become_probe ... ok
Oct 11 14:10:51.427 INFO blam! test integration_cases::test_raft::test_prevote_with_check_quorum ... ok
Oct 11 14:10:51.428 INFO blam! test integration_cases::test_raft::test_non_promotable_voter_which_check_quorum ... ok
Oct 11 14:10:51.429 INFO blam! test integration_cases::test_raft::test_old_messages ... ok
Oct 11 14:10:51.429 INFO blam! test integration_cases::test_raft::test_progress_resume ... ok
Oct 11 14:10:51.436 INFO blam! test integration_cases::test_raft::test_progress_update ... ok
Oct 11 14:10:51.436 INFO blam! test integration_cases::test_raft::test_progress_maybe_decr ... ok
Oct 11 14:10:51.444 INFO blam! test integration_cases::test_raft::test_progress_resume_by_heartbeat_resp ... ok
Oct 11 14:10:51.444 INFO blam! test integration_cases::test_raft::test_progress_paused ... ok
Oct 11 14:10:51.450 INFO blam! test integration_cases::test_raft::test_prevote_from_any_state ... ok
Oct 11 14:10:51.456 INFO blam! test integration_cases::test_raft::test_provide_snap ... ok
Oct 11 14:10:51.456 INFO blam! test integration_cases::test_raft::test_raft_frees_read_only_mem ... ok
Oct 11 14:10:51.456 INFO blam! test integration_cases::test_raft::test_prevote_with_split_vote ... ok
Oct 11 14:10:51.458 INFO blam! test integration_cases::test_raft::test_proposal_by_proxy ... ok
Oct 11 14:10:51.459 INFO blam! test integration_cases::test_raft::test_proposal ... ok
Oct 11 14:10:51.459 INFO blam! test integration_cases::test_raft::test_promotable ... ok
Oct 11 14:10:51.469 INFO blam! test integration_cases::test_raft::test_recv_msg_request_vote ... ok
Oct 11 14:10:51.469 INFO blam! test integration_cases::test_raft::test_raft_nodes ... ok
Oct 11 14:10:51.469 INFO blam! test integration_cases::test_raft::test_read_only_for_new_leader ... ok
Oct 11 14:10:51.469 INFO blam! test integration_cases::test_raft::test_read_only_option_lease ... ok
Oct 11 14:10:51.469 INFO blam! test integration_cases::test_raft::test_remove_node ... ok
Oct 11 14:10:51.470 INFO blam! test integration_cases::test_raft::test_read_only_option_lease_without_check_quorum ... ok
Oct 11 14:10:51.476 INFO blam! test integration_cases::test_raft::test_restore_ignore_snapshot ... ok
Oct 11 14:10:51.476 INFO blam! test integration_cases::test_raft::test_recv_msg_beat ... ok
Oct 11 14:10:51.476 INFO blam! test integration_cases::test_raft::test_restore ... ok
Oct 11 14:10:51.476 INFO blam! test integration_cases::test_raft::test_restore_with_learner ... ok
Oct 11 14:10:51.476 INFO blam! test integration_cases::test_raft::test_restore_from_snap_msg ... ok
Oct 11 14:10:51.476 INFO blam! test integration_cases::test_raft::test_restore_learner_promotion ... ok
Oct 11 14:10:51.476 INFO blam! test integration_cases::test_raft::test_remove_learner ... ok
Oct 11 14:10:51.476 INFO blam! test integration_cases::test_raft::test_recv_msg_unreachable ... ok
Oct 11 14:10:51.476 INFO blam! test integration_cases::test_raft::test_read_only_option_safe ... ok
Oct 11 14:10:51.480 INFO blam! test integration_cases::test_raft::test_single_node_candidate ... ok
Oct 11 14:10:51.481 INFO blam! test integration_cases::test_raft::test_send_append_for_progress_probe ... ok
Oct 11 14:10:51.493 INFO blam! test integration_cases::test_raft::test_pass_election_timeout ... ok
Oct 11 14:10:51.493 INFO blam! test integration_cases::test_raft::test_send_append_for_progress_replicate ... ok
Oct 11 14:10:51.496 INFO blam! test integration_cases::test_raft::test_single_node_commit ... ok
Oct 11 14:10:51.496 INFO blam! test integration_cases::test_raft::test_sinle_node_pre_candidate ... ok
Oct 11 14:10:51.496 INFO blam! test integration_cases::test_raft::test_step_ignore_config ... ok
Oct 11 14:10:51.504 INFO blam! test integration_cases::test_raft::test_send_append_for_progress_snapshot ... ok
Oct 11 14:10:51.515 INFO blam! test integration_cases::test_raft::test_transfer_non_member ... ok
Oct 11 14:10:51.523 INFO blam! test integration_cases::test_raft::test_slow_node_restore ... ok
Oct 11 14:10:51.523 INFO blam! test integration_cases::test_raft_flow_control::test_msg_app_flow_control_recv_heartbeat ... ok
Oct 11 14:10:51.536 INFO blam! test integration_cases::test_raft::test_restore_invalid_learner ... ok
Oct 11 14:10:51.536 INFO kablam! ERROR 2018-10-11T14:10:51Z: raft::raft:  can't become learner when restores snapshot [index: 11, term: 11]
Oct 11 14:10:51.542 INFO blam! test integration_cases::test_raft::test_vote_from_any_state ... ok
Oct 11 14:10:51.542 INFO blam! test integration_cases::test_raft::test_step_config ... ok
Oct 11 14:10:51.552 INFO blam! test integration_cases::test_raft_flow_control::test_msg_app_flow_control_full ... ok
Oct 11 14:10:51.559 INFO blam! test integration_cases::test_raft_paper::test_candidate_update_term_from_message ... ok
Oct 11 14:10:51.559 INFO blam! test integration_cases::test_raft_paper::test_candidate_fallback ... ok
Oct 11 14:10:51.559 INFO blam! test integration_cases::test_raft_paper::test_candidate_start_new_election ... ok
Oct 11 14:10:51.567 INFO blam! test integration_cases::test_raft_paper::test_follower_commit_entry ... ok
Oct 11 14:10:51.574 INFO blam! test integration_cases::test_raft_paper::test_follower_append_entries ... ok
Oct 11 14:10:51.580 INFO blam! test integration_cases::test_raft_paper::test_follower_check_msg_append ... ok
Oct 11 14:10:51.584 INFO blam! test integration_cases::test_raft_paper::test_follower_start_election ... ok
Oct 11 14:10:51.596 INFO blam! test integration_cases::test_raft_paper::test_follower_update_term_from_message ... ok
Oct 11 14:10:51.600 INFO blam! test integration_cases::test_raft_paper::test_follower_vote ... ok
Oct 11 14:10:51.600 INFO blam! test integration_cases::test_raft_paper::test_leader_acknowledge_commit ... ok
Oct 11 14:10:51.600 INFO blam! test integration_cases::test_raft_paper::test_leader_bcast_beat ... ok
Oct 11 14:10:51.600 INFO blam! test integration_cases::test_raft_paper::test_leader_commit_entry ... ok
Oct 11 14:10:51.616 INFO blam! test integration_cases::test_raft_paper::test_leader_election_in_one_round_rpc ... ok
Oct 11 14:10:51.616 INFO blam! test integration_cases::test_raft_paper::test_leader_commit_preceding_entries ... ok
Oct 11 14:10:51.616 INFO blam! test integration_cases::test_raft_paper::test_leader_only_commits_log_from_current_term ... ok
Oct 11 14:10:51.619 INFO blam! test integration_cases::test_raft_paper::test_leader_start_replication ... ok
Oct 11 14:10:51.619 INFO blam! test integration_cases::test_raft_paper::test_leader_update_term_from_message ... ok
Oct 11 14:10:51.622 INFO blam! test integration_cases::test_raft_paper::test_start_as_follower ... ok
Oct 11 14:10:51.652 INFO blam! test integration_cases::test_raft_paper::test_leader_sync_follower_log ... ok
Oct 11 14:10:51.652 INFO blam! test integration_cases::test_raft_paper::test_vote_request ... ok
Oct 11 14:10:51.652 INFO blam! test integration_cases::test_raft_paper::test_voter ... ok
Oct 11 14:10:51.664 INFO blam! test integration_cases::test_raft_snap::test_pending_snapshot_pause_replication ... ok
Oct 11 14:10:51.664 INFO blam! test integration_cases::test_raft_snap::test_sending_snapshot_set_pending_snapshot ... ok
Oct 11 14:10:51.672 INFO blam! test integration_cases::test_raft_snap::test_snapshot_abort ... ok
Oct 11 14:10:51.672 INFO blam! test integration_cases::test_raft_snap::test_snapshot_failure ... ok
Oct 11 14:10:51.672 INFO blam! test integration_cases::test_raft_snap::test_snapshot_succeed ... ok
Oct 11 14:10:51.672 INFO blam! test integration_cases::test_raw_node::test_raw_node_propose_add_duplicate_node ... ok
Oct 11 14:10:51.688 INFO blam! test integration_cases::test_raw_node::test_raw_node_propose_add_learner_node ... ok
Oct 11 14:10:51.688 INFO blam! test integration_cases::test_raw_node::test_raw_node_propose_and_conf_change ... ok
Oct 11 14:10:51.696 INFO blam! test integration_cases::test_raw_node::test_raw_node_read_index_to_old_leader ... ok
Oct 11 14:10:51.696 INFO blam! test integration_cases::test_raw_node::test_raw_node_read_index ... ok
Oct 11 14:10:51.716 INFO blam! test integration_cases::test_raw_node::test_raw_node_restart ... ok
Oct 11 14:10:51.716 INFO blam! test integration_cases::test_raw_node::test_raw_node_restart_from_snapshot ... ok
Oct 11 14:10:51.718 INFO blam! test integration_cases::test_raw_node::test_raw_node_step ... ok
Oct 11 14:10:51.718 INFO kablam! ERROR 2018-10-11T14:10:51Z: raft::raft:  invalid format of MsgReadIndexResp from 0, entries count: 0
Oct 11 14:10:51.726 INFO blam! test integration_cases::test_raw_node::test_raw_node_start ... ok
Oct 11 14:10:51.726 INFO blam! test integration_cases::test_raft::test_state_transition ... ok
Oct 11 14:10:51.731 INFO blam! test integration_cases::test_raw_node::test_skip_bcast_commit ... ok
Oct 11 14:10:51.732 INFO blam! test integration_cases::test_raft_flow_control::test_msg_app_flow_control_move_forward ... ok
Oct 11 14:10:51.740 INFO blam! test integration_cases::test_raft_paper::test_acandidates_election_timeout_nonconf ... ok
Oct 11 14:10:51.795 INFO blam! test integration_cases::test_raft_paper::test_follower_election_timeout_nonconflict ... ok
Oct 11 14:10:52.060 INFO blam! test integration_cases::test_raft_paper::test_candidate_election_timeout_randomized ... ok
Oct 11 14:10:52.060 INFO blam! test integration_cases::test_raft_paper::test_follower_election_timeout_randomized ... ok
Oct 11 14:10:52.060 INFO blam! 
Oct 11 14:10:52.060 INFO blam! test result: ok. 152 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 11 14:10:52.060 INFO blam! 
Oct 11 14:10:52.063 INFO kablam!    Doc-tests raft
Oct 11 14:10:54.420 INFO blam! 
Oct 11 14:10:54.420 INFO blam! running 12 tests
Oct 11 14:10:54.420 INFO blam! test src/lib.rs -  (line 172) ... ignored
Oct 11 14:10:54.420 INFO blam! test src/lib.rs -  (line 185) ... ignored
Oct 11 14:10:54.420 INFO blam! test src/lib.rs -  (line 198) ... ignored
Oct 11 14:10:54.431 INFO blam! test src/lib.rs -  (line 208) ... ignored
Oct 11 14:10:54.435 INFO blam! test src/lib.rs -  (line 217) ... ignored
Oct 11 14:10:54.435 INFO blam! test src/lib.rs -  (line 230) ... ignored
Oct 11 14:10:54.435 INFO blam! test src/lib.rs -  (line 253) ... ignored
Oct 11 14:11:00.013 INFO blam! test src/lib.rs - prelude (line 318) ... ok
Oct 11 14:11:00.412 INFO blam! test src/util.rs - util::limit_size (line 29) ... ok
Oct 11 14:11:01.492 INFO blam! test src/lib.rs -  (line 32) ... ok
Oct 11 14:11:01.602 INFO blam! test src/lib.rs -  (line 61) ... ok
Oct 11 14:11:01.880 INFO blam! test src/lib.rs -  (line 112) ... ok
Oct 11 14:11:01.880 INFO blam! 
Oct 11 14:11:01.880 INFO blam! test result: ok. 5 passed; 0 failed; 7 ignored; 0 measured; 0 filtered out
Oct 11 14:11:01.880 INFO blam! 
Oct 11 14:11:01.893 INFO kablam! su: No module specific data is present
Oct 11 14:11:02.144 INFO running `"docker" "rm" "-f" "3d3f6b369fb77289fc9b438295bb60b4dbc52e82bd86fff5bf3620e14b806e4a"`
Oct 11 14:11:02.251 INFO blam! 3d3f6b369fb77289fc9b438295bb60b4dbc52e82bd86fff5bf3620e14b806e4a