[INFO] fetching crate typing_engine 0.5.0...
[INFO] testing typing_engine-0.5.0 against master#ec6f9a5b4413f74386267ef8efc93712c2ce6db6 for pr-155739-1
[INFO] extracting crate typing_engine 0.5.0 into /workspace/builds/worker-7-tc1/source
[INFO] started tweaking crates.io crate typing_engine 0.5.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate typing_engine 0.5.0
[INFO] tweaked toml for crates.io crate typing_engine 0.5.0 written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate typing_engine 0.5.0 on toolchain ec6f9a5b4413f74386267ef8efc93712c2ce6db6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate typing_engine 0.5.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] f353a1f6b975d03a985991fbcb35b4ad21834ba7c1aa681b0a04593d0845ea39
[INFO] running `Command { std: "docker" "start" "-a" "f353a1f6b975d03a985991fbcb35b4ad21834ba7c1aa681b0a04593d0845ea39", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f353a1f6b975d03a985991fbcb35b4ad21834ba7c1aa681b0a04593d0845ea39", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f353a1f6b975d03a985991fbcb35b4ad21834ba7c1aa681b0a04593d0845ea39", kill_on_drop: false }`
[INFO] [stdout] f353a1f6b975d03a985991fbcb35b4ad21834ba7c1aa681b0a04593d0845ea39
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7921f63aa54d2fbe4b21654f1a6919c3ce8397b635cfd0b608c603a4ebee27ee
[INFO] running `Command { std: "docker" "start" "-a" "7921f63aa54d2fbe4b21654f1a6919c3ce8397b635cfd0b608c603a4ebee27ee", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.180
[INFO] [stderr]    Compiling proc-macro2 v1.0.105
[INFO] [stderr]    Compiling quote v1.0.43
[INFO] [stderr]    Compiling zerocopy v0.8.33
[INFO] [stderr]    Compiling syn v2.0.114
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling typing_engine v0.5.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: method `active_target` is never used
[INFO] [stdout]    --> src/typing_engine/multi_target.rs:297:19
[INFO] [stdout]     |
[INFO] [stdout] 261 | impl TargetsSwitcher {
[INFO] [stdout]     | -------------------- method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 297 |     pub(super) fn active_target(&self) -> Option<&TypingTarget> {
[INFO] [stdout]     |                   ^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 11.27s
[INFO] running `Command { std: "docker" "inspect" "7921f63aa54d2fbe4b21654f1a6919c3ce8397b635cfd0b608c603a4ebee27ee", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7921f63aa54d2fbe4b21654f1a6919c3ce8397b635cfd0b608c603a4ebee27ee", kill_on_drop: false }`
[INFO] [stdout] 7921f63aa54d2fbe4b21654f1a6919c3ce8397b635cfd0b608c603a4ebee27ee
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 87301fe6c6f8ede55d7a80dea05a16a9f6da628fd3c9c1c36eac423bfb7d14eb
[INFO] running `Command { std: "docker" "start" "-a" "87301fe6c6f8ede55d7a80dea05a16a9f6da628fd3c9c1c36eac423bfb7d14eb", kill_on_drop: false }`
[INFO] [stdout] warning: method `active_target` is never used
[INFO] [stdout]    --> src/typing_engine/multi_target.rs:297:19
[INFO] [stdout]     |
[INFO] [stdout] 261 | impl TargetsSwitcher {
[INFO] [stdout]     | -------------------- method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 297 |     pub(super) fn active_target(&self) -> Option<&TypingTarget> {
[INFO] [stdout]     |                   ^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling typing_engine v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 4.76s
[INFO] running `Command { std: "docker" "inspect" "87301fe6c6f8ede55d7a80dea05a16a9f6da628fd3c9c1c36eac423bfb7d14eb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "87301fe6c6f8ede55d7a80dea05a16a9f6da628fd3c9c1c36eac423bfb7d14eb", kill_on_drop: false }`
[INFO] [stdout] 87301fe6c6f8ede55d7a80dea05a16a9f6da628fd3c9c1c36eac423bfb7d14eb
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a318e1ab2be77039c2e3fe80ee0a3249dc2b9cc379a5013dabe5b3860265e185
[INFO] running `Command { std: "docker" "start" "-a" "a318e1ab2be77039c2e3fe80ee0a3249dc2b9cc379a5013dabe5b3860265e185", kill_on_drop: false }`
[INFO] [stderr] warning: method `active_target` is never used
[INFO] [stderr]    --> src/typing_engine/multi_target.rs:297:19
[INFO] [stderr]     |
[INFO] [stderr] 261 | impl TargetsSwitcher {
[INFO] [stderr]     | -------------------- method in this implementation
[INFO] [stderr] ...
[INFO] [stderr] 297 |     pub(super) fn active_target(&self) -> Option<&TypingTarget> {
[INFO] [stderr]     |                   ^^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `typing_engine` (lib) generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/typing_engine-ddd75e591ed46171)
[INFO] [stdout] 
[INFO] [stdout] running 170 tests
[INFO] [stdout] test query::test::construct_query_5 ... ok
[INFO] [stdout] test query::test::construct_query_7 ... ok
[INFO] [stdout] test statistics::lap_statistics::tests::lap_end_is_converted_correctly_when_ideal_key_stroke_is_requested ... ok
[INFO] [stdout] test query::test::construct_query_3 ... ok
[INFO] [stdout] test query::test::construct_query_1 ... ok
[INFO] [stdout] test statistics::lap_statistics::tests::lap_end_is_converted_correctly_when_chunk_is_requested ... ok
[INFO] [stdout] test statistics::lap_statistics::tests::lap_end_is_converted_correctly_when_spell_is_requested ... ok
[INFO] [stdout] test statistics::lap_statistics::tests::lap_info_construct_elapsed_time_correctly ... ok
[INFO] [stdout] test statistics::lap_statistics::tests::lap_info_construct_lap_end_correctly ... ok
[INFO] [stdout] test statistics::lap_statistics::tests::lap_info_construct_lap_time_correctly ... ok
[INFO] [stdout] test query::test::construct_query_2 ... ok
[INFO] [stdout] test statistics::multi_target_position_convert::test::convert_between_key_stroke_delta_1 ... ok
[INFO] [stdout] test statistics::multi_target_position_convert::test::convert_between_key_stroke_delta_2 ... ok
[INFO] [stdout] test statistics::lap_statistics::tests::lap_end_is_converted_correctly_when_key_stroke_is_requested ... ok
[INFO] [stdout] test query::test::construct_query_6 ... ok
[INFO] [stdout] test statistics::multi_target_position_convert::test::multi_target_delta_converter_2 ... ok
[INFO] [stdout] test statistics::multi_target_position_convert::test::multi_target_delta_converter_3 ... ok
[INFO] [stdout] test statistics::multi_target_position_convert::test::multi_target_delta_converter_4 ... ok
[INFO] [stdout] test statistics::multi_target_position_convert::test::multi_target_delta_converter_5 ... ok
[INFO] [stdout] test statistics::multi_target_position_convert::test::multi_target_delta_converter_6 ... ok
[INFO] [stdout] test statistics::multi_target_position_convert::test::multi_target_delta_converter_1 ... ok
[INFO] [stdout] test statistics::multi_target_position_convert::test::multi_target_delta_converter_8 ... ok
[INFO] [stdout] test statistics::skill_statistics::public::test::add_entity_skill_statistics_with_different_entity ... ok
[INFO] [stdout] test statistics::skill_statistics::public::test::add_skill_statistics ... ok
[INFO] [stdout] test statistics::skill_statistics::public::test::skill_statistics_accuracy_is_calculated_correctly ... ok
[INFO] [stdout] test statistics::skill_statistics::public::test::skill_statistics_averate_time_is_calculated_correctly ... ok
[INFO] [stdout] test statistics::skill_statistics::public::test::empty_skill_statistics ... ok
[INFO] [stdout] test statistics::skill_statistics::public::test::skill_statistics_wrong_count_ranking_is_constructed_correctly ... ok
[INFO] [stdout] test statistics::skill_statistics::test::empty_primitive_skill_statistics ... ok
[INFO] [stdout] test statistics::skill_statistics::test::key_stroke_correct_event_update_singke_key_stroke_statistics ... ok
[INFO] [stdout] test statistics::skill_statistics::test::update_primitive_skill_statistics_once_without_wrong ... ok
[INFO] [stdout] test statistics::skill_statistics::test::update_primitive_skill_statistics_multiple_times ... ok
[INFO] [stdout] test statistics::skill_statistics::test::update_primitive_skill_statistics_once_with_wrong ... ok
[INFO] [stdout] test statistics::skill_statistics::public::test::add_entity_skill_statistics_with_same_entity ... ok
[INFO] [stdout] test statistics::test::consume_chunk_confirmed_event_with_wrong_key_stroke ... ok
[INFO] [stdout] test statistics::test::consume_inflight_spell_snapshotted_event_with_wrong_stroke_with_double_spell_update_statistics_manager ... ok
[INFO] [stdout] test query::test::construct_query_4 ... ok
[INFO] [stdout] test statistics::test::consume_chunk_added_event_update_display_string ... ok
[INFO] [stdout] test statistics::test::consume_inflight_spell_snapshotted_event_with_wrong_stroke_with_single_spell_update_display_string ... ok
[INFO] [stdout] test statistics::test::consume_inflight_spell_snapshotted_event_without_wrong_stroke_with_double_spell_update_statistics_manager ... ok
[INFO] [stdout] test statistics::test::consume_inflight_spell_snapshotted_event_without_wrong_stroke_with_double_spell_update_display_string ... ok
[INFO] [stdout] test statistics::multi_target_position_convert::test::multi_target_delta_converter_7 ... ok
[INFO] [stdout] test statistics::test::consume_ideal_key_stroke_deemed_finished_event_with_wrong_stroke_update_statistics_manager ... ok
[INFO] [stdout] test statistics::test::consume_inflight_spell_snapshotted_event_with_wrong_stroke_with_single_spell_update_statistics_manager ... ok
[INFO] [stdout] test statistics::test::consume_ideal_key_stroke_deemed_finished_event_without_wrong_stroke_update_statistics_manager ... ok
[INFO] [stdout] test statistics::test::consume_chunk_added_event_update_statistics_manager ... ok
[INFO] [stdout] test statistics::test::consume_chunk_confirmed_event_without_wrong_key_stroke ... ok
[INFO] [stdout] test statistics::test::consume_inflight_spell_snapshotted_event_without_wrong_stroke_with_single_spell_update_display_string ... ok
[INFO] [stdout] test statistics::test::consume_inflight_spell_snapshotted_event_with_wrong_stroke_with_double_spell_update_display_string ... ok
[INFO] [stdout] test statistics::test::consume_inflight_spell_snapshotted_event_without_wrong_stroke_with_single_spell_update_statistics_manager ... ok
[INFO] [stdout] test statistics::test::consume_key_stroke_correct_event_with_wrong_stroke_update_display_string ... ok
[INFO] [stdout] test statistics::test::consume_key_stroke_correct_event_with_wrong_stroke_update_statistics_manager ... ok
[INFO] [stdout] test statistics::test::consume_spell_deemed_finished_event_with_wrong_stroke_update_display_string ... ok
[INFO] [stdout] test statistics::test::consume_key_stroke_correct_event_without_wrong_stroke_update_display_string ... ok
[INFO] [stdout] test statistics::test::consume_spell_deemed_finished_event_without_wrong_key_stroke_update_display_string ... ok
[INFO] [stdout] test statistics::test::consume_spell_deemed_finished_event_with_wrong_key_stroke_update_statistics_manager ... ok
[INFO] [stdout] test statistics::test::consume_spell_deemed_finished_event_without_wrong_key_stroke_update_statistics_manager ... ok
[INFO] [stdout] test statistics::test::consume_spell_deemed_finished_event_without_wrong_stroke_update_display_string ... ok
[INFO] [stdout] test statistics::test::consume_key_stroke_correct_event_without_wrong_stroke_update_statistics_manager ... ok
[INFO] [stdout] test statistics::test::consume_key_stroke_snapshotted_event_started_with_wrong_stroke_update_display_string ... ok
[INFO] [stdout] test statistics::test::consume_key_stroke_snapshotted_event_started_with_wrong_stroke_update_statistics_manager ... ok
[INFO] [stdout] test statistics::test::consume_key_stroke_snapshotted_event_started_without_wrong_stroke_update_statistics_manager ... ok
[INFO] [stdout] test statistics::test::consume_key_stroke_snapshotted_event_started_without_wrong_stroke_update_display_string ... ok
[INFO] [stdout] test statistics::test::consume_key_stroke_snapshotted_event_unstarted_update_display_string ... ok
[INFO] [stdout] test statistics::test::consume_spell_deemed_finished_event_with_wrong_key_stroke_update_display_string ... ok
[INFO] [stdout] test statistics::skill_statistics::test::empty_skill_statistics_manager ... ok
[INFO] [stdout] test typing_engine::multi_target::test::add_target_not_activate_target ... ok
[INFO] [stdout] test typing_engine::multi_target::test::local_time_same_target_reactivate_uses_last_key_time ... ok
[INFO] [stdout] test typing_engine::multi_target::test::local_time_ignores_inactive_time_across_targets ... ok
[INFO] [stdout] test statistics::test::consume_spell_finished_event_with_wrong_key_stroke_update_display_string ... ok
[INFO] [stdout] test statistics::test::consume_spell_finished_event_with_wrong_key_stroke_update_statistics_manager ... ok
[INFO] [stdout] test statistics::test::consume_spell_finished_event_without_wrong_key_stroke_update_statistics_manager ... ok
[INFO] [stdout] test statistics::test::consume_spell_finished_event_without_wrong_key_stroke_update_display_string ... ok
[INFO] [stdout] test statistics::test::spell_cursor_position_of_display_string_builder_without_inflight_spell_snapshotted_event_is_last_position_plus_one ... ok
[INFO] [stdout] test typing_engine::multi_target::test::activate_target_first_time_switches_correctly ... ok
[INFO] [stdout] test typing_engine::multi_target::test::activate_target_to_non_exist_fails ... ok
[INFO] [stdout] test typing_engine::multi_target::test::empty_targets_switcher_has_no_active_target ... ok
[INFO] [stdout] test typing_engine::multi_target::test::activate_target_second_time_switches_correctly ... ok
[INFO] [stdout] test typing_engine::multi_target::test::local_time_first_key_after_activation_uses_activation_time ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::append_chunks_to_finished_processed_chunk_info_become_unfinished ... ok
[INFO] [stdout] test typing_engine::multi_target::test::local_time_subsequent_key_uses_last_key_time ... ok
[INFO] [stdout] test statistics::test::consume_key_stroke_snapshotted_event_unstarted_update_statistics_manager ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::append_chunks_to_processed_chunk_info_returns_chunk_added_events ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::after_last_chunk_confirmation_processed_chunk_info_is_finished ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::correct_stroke_to_processed_chunk_info_with_delayed_confirmable_inflight_chunk_confirms_delayed_confirmed_candidate_and_next_chunk ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::candidate_restriction_during_stroke_to_processed_chunk_info ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::correct_stroke_to_processed_chunk_info_with_delayed_confirmable_inflight_chunk_confirms_delayed_confirmed_candidate ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::correct_stroke_to_processed_chunk_info_returns_chunk_confirmed_event ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::correct_stroke_to_processed_chunk_info_returns_spell_finished_event ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::correct_stroke_to_processed_chunk_info_with_delayed_confirmable_inflight_chunk_confirms_not_delayed_confirmed_candidate ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::correct_stroke_to_processed_chunk_info_returns_key_stroke_correct_event ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::create_processed_chunk_info_returns_chunk_added_events ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::last_key_stroke_elapsed_time_uses_pending_key_stroke ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::last_key_stroke_elapsed_time_keeps_after_finish ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::last_key_stroke_elapsed_time_uses_confirmed_when_inflight_has_no_input ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::snapshot_processed_chunk_info_with_inflight_chunk_with_double_splitted ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::snapshot_processed_chunk_info_with_inflight_chunk_without_wrong_key_stroke ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::last_key_stroke_elapsed_time_none_when_inflight_has_no_key_stroke ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::snapshot_processed_chunk_info_with_unprocessed_chunk ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::wrong_stroke_to_processed_chunk_info_returns_no_event ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::empty_processed_chunk_info ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::last_key_stroke_elapsed_time_none_when_no_chunks ... ok
[INFO] [stdout] test typing_primitive_types::chunk::candidate_unappended::test::append_key_stroke_to_chunks_1 ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::snapshot_processed_chunk_info_with_inflight_chunk_with_delayed_confirmable_candidate ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::last_key_stroke_elapsed_time_updates_on_wrong_stroke ... ok
[INFO] [stdout] test typing_engine::processed_chunk_info::test::snapshot_processed_chunk_info_with_inflight_chunk_with_wrong_key_stroke ... ok
[INFO] [stdout] test typing_primitive_types::chunk::candidate_unappended::test::append_key_stroke_to_chunks_2 ... ok
[INFO] [stdout] test typing_primitive_types::chunk::inflight::test::correct_stroke_to_inflight_chunk_confirms_not_delayed_confirm_candidate ... ok
[INFO] [stdout] test typing_primitive_types::chunk::candidate_unappended::test::append_key_stroke_to_chunks_5 ... ok
[INFO] [stdout] test typing_primitive_types::chunk::inflight::test::correct_stroke_to_inflight_chunk_finishes_spell ... ok
[INFO] [stdout] test typing_primitive_types::chunk::inflight::test::correct_stroke_to_inflight_chunk_confirms_delayed_confirm_candidate ... ok
[INFO] [stdout] test typing_primitive_types::chunk::candidate_unappended::test::append_key_stroke_to_chunks_6 ... ok
[INFO] [stdout] test typing_primitive_types::chunk::candidate_unappended::test::append_key_stroke_to_chunks_7 ... ok
[INFO] [stdout] test typing_primitive_types::chunk::candidate_unappended::test::append_key_stroke_to_repellent_partial_single_n_availability_due_to_next_chunk_head ... ok
[INFO] [stdout] test typing_primitive_types::chunk::candidate_unappended::test::append_key_stroke_to_displayable_ascii ... ok
[INFO] [stdout] test typing_primitive_types::chunk::candidate_unappended::test::append_key_stroke_to_repellent_with_single_n_availability ... ok
[INFO] [stdout] test typing_primitive_types::chunk::candidate_unappended::test::append_key_stroke_to_repellent_without_single_n_availability_due_to_last_chunk ... ok
[INFO] [stdout] test typing_primitive_types::chunk::has_actual_key_strokes::test::wrong_positions_of_not_double_splitted ... ok
[INFO] [stdout] test typing_primitive_types::chunk::has_actual_key_strokes::test::wrong_positions_of_unfinished_key_stroke ... ok
[INFO] [stdout] test typing_primitive_types::chunk::candidate_unappended::test::append_key_stroke_to_repellent_without_single_n_availability_due_to_ascii_of_next_chunk ... ok
[INFO] [stdout] test typing_primitive_types::chunk::candidate_unappended::test::append_key_stroke_to_repellent_without_single_n_availability_due_to_next_chunk_head ... ok
[INFO] [stdout] test typing_primitive_types::chunk::has_actual_key_strokes::test::wrong_positions_of_double_splitted ... ok
[INFO] [stdout] test typing_primitive_types::vocabulary::test::construct_chunks_from_vocabulary_entry_2 ... ok
[INFO] [stdout] test typing_primitive_types::chunk::inflight::test::correct_stroke_to_inflight_chunk_that_becomes_delayed_confirmable ... ok
[INFO] [stdout] test typing_primitive_types::chunk::inflight::test::correct_stroke_to_inflight_chunk_with_wrong_stroke ... ok
[INFO] [stdout] test typing_primitive_types::vocabulary::test::corresponding_view_positions_for_spell_1 ... ok
[INFO] [stdout] test vocabulary_parser::test::convert_two_backslash_to_single_convert_four_backshasled_totwo_backslashes ... ok
[INFO] [stdout] test typing_primitive_types::chunk::inflight::test::correct_stroke_to_inflight_chunk_without_wrong_stroke ... ok
[INFO] [stdout] test typing_primitive_types::chunk::inflight::test::correct_stroke_to_inflight_chunk_finishes_spell_and_confirms_split_chunk ... ok
[INFO] [stdout] test typing_primitive_types::chunk::inflight::test::wrong_stroke_to_inflight_chunk ... ok
[INFO] [stdout] test typing_primitive_types::chunk::inflight::test::wrong_stroke_to_inflight_chunk_that_is_delayed_confirmable ... ok
[INFO] [stdout] test typing_primitive_types::chunk::test::construct_spell_end_vector_1 ... ok
[INFO] [stdout] test typing_primitive_types::chunk::test::construct_spell_end_vector_2 ... ok
[INFO] [stdout] test typing_primitive_types::chunk::test::is_element_end_at_key_stroke_index_1 ... ok
[INFO] [stdout] test typing_primitive_types::chunk::unprocessed::test::strict_key_stroke_to_unprocessed_chunk_make_delayed_confirm_candidate_into_usual_candidate ... ok
[INFO] [stdout] test typing_primitive_types::chunk::unprocessed::test::strict_key_stroke_to_unprocessed_chunk_remove_duplication ... ok
[INFO] [stdout] test typing_primitive_types::vocabulary::test::construct_chunks_from_vocabulary_entry_1 ... ok
[INFO] [stdout] test vocabulary_parser::test::convert_two_backslash_to_single_convert_two_backslashes_correctly ... ok
[INFO] [stdout] test vocabulary_parser::test::convert_two_backslash_to_single_not_convert_third_backslash_with_following_charactor ... ok
[INFO] [stdout] test typing_primitive_types::vocabulary::test::construct_chunks_from_vocabulary_entry_3 ... ok
[INFO] [stdout] test vocabulary_parser::test::convert_two_backslash_to_single_not_convert_third_backslash_without_following_charactor ... ok
[INFO] [stdout] test vocabulary_parser::test::parse_vocabulary_entry_error_components_count_mismatch_no_colon ... ok
[INFO] [stdout] test vocabulary_parser::test::parse_vocabulary_entry_error_components_count_mismatch_too_many_colons ... ok
[INFO] [stdout] test vocabulary_parser::test::parse_vocabulary_entry_error_compound_symbol_mismatch_nested ... ok
[INFO] [stdout] test vocabulary_parser::test::parse_vocabulary_entry_error_compound_symbol_mismatch_unclosed ... ok
[INFO] [stdout] test vocabulary_parser::test::parse_vocabulary_entry_error_compound_symbol_mismatch_unopened ... ok
[INFO] [stdout] test vocabulary_parser::test::parse_vocabulary_entry_error_empty_compound ... ok
[INFO] [stdout] test vocabulary_parser::test::parse_vocabulary_entry_error_invalid_spell_string ... ok
[INFO] [stdout] test vocabulary_parser::test::parse_vocabulary_entry_error_multiple_lines ... ok
[INFO] [stdout] test vocabulary_parser::test::parse_vocabulary_entry_error_view_and_spells_count_mismatch_too_few_spells ... ok
[INFO] [stdout] test vocabulary_parser::test::parse_vocabulary_entry_error_view_and_spells_count_mismatch_too_many_spells ... ok
[INFO] [stdout] test vocabulary_parser::test::parse_vocabulary_entry_error_view_and_spells_count_mismatch_with_compound ... ok
[INFO] [stdout] test vocabulary_parser::test::parse_vocabulary_entry_success_normal ... ok
[INFO] [stdout] test typing_primitive_types::chunk::inflight::test::correct_stroke_to_inflight_chunk_confirms_chunk ... ok
[INFO] [stdout] test vocabulary_parser::test::parse_vocabulary_entry_success_with_compound ... ok
[INFO] [stdout] test vocabulary_parser::test::parse_vocabulary_entry_success_with_escaped_brackets ... ok
[INFO] [stdout] test vocabulary_parser::test::remove_square_parentheses_recognize_backslashed_backslash_correctly ... ok
[INFO] [stdout] test vocabulary_parser::test::parse_vocabulary_entry_success_with_escaped_characters ... ok
[INFO] [stdout] test vocabulary_parser::test::remove_square_parentheses_recognize_backslashed_square_parentheses_correctly ... ok
[INFO] [stdout] test vocabulary_parser::test::remove_square_parentheses_remain_backslash_not_following_special_charactors_correctly ... ok
[INFO] [stdout] test vocabulary_parser::test::remove_square_parentheses_returns_err_when_compound_is_closed_without_opened ... ok
[INFO] [stdout] test vocabulary_parser::test::remove_square_parentheses_returns_err_when_compound_is_empty ... ok
[INFO] [stdout] test vocabulary_parser::test::remove_square_parentheses_returns_err_when_nesting ... ok
[INFO] [stdout] test vocabulary_parser::test::remove_square_parentheses_returns_err_when_compound_is_not_closed ... ok
[INFO] [stdout] test vocabulary_parser::test::split_by_non_escaped_separator_remain_backslash_correctly ... ok
[INFO] [stdout] test vocabulary_parser::test::split_by_non_escaped_separator_split_empty_string_correctly ... ok
[INFO] [stdout] test vocabulary_parser::test::split_by_non_escaped_separator_escape_backslash_correctly ... ok
[INFO] [stdout] test vocabulary_parser::test::split_by_non_escaped_separator_split_empty_component_correctly ... ok
[INFO] [stdout] test vocabulary_parser::test::split_by_non_escaped_separator_split_non_escaped_correctly ... ok
[INFO] [stdout] test vocabulary_parser::test::remove_square_parentheses_recognize_count_correctly ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 170 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/append_query_test.rs (/opt/rustwide/target/debug/deps/append_query_test-58b156781c2baca2)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test append_query_updates_statistics_without_affecting_finished_counts ... ok
[INFO] [stdout] test append_query_allows_finish_and_result_is_correct ... ok
[INFO] [stdout] test append_query_after_finished_allows_second_run_and_result_is_correct ... ok
[INFO] [stdout] test append_query_updates_display_string_without_moving_cursor_or_wrong_positions ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_test.rs (/opt/rustwide/target/debug/deps/integration_test-00210c192a6e7cf8)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test construct_display_info_when_finished_output_correct_display_string ... ok
[INFO] [stdout] test construct_result_output_correct_result ... ok
[INFO] [stdout] test construct_result_output_correct_skill_statistics ... ok
[INFO] [stdout] test construct_display_info_output_correct_display_string ... ok
[INFO] [stdout] test init_engine_twice_initialized_correctly ... ok
[INFO] [stdout] test construct_display_info_output_correct_lap_info ... ok
[INFO] [stdout] test construct_display_info_output_correct_summary_statistics ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/multi_target_integration_test.rs (/opt/rustwide/target/debug/deps/multi_target_integration_test-a951ae2fa6074577)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test activate_target_with_invalid_index_does_not_change_active_target ... ok
[INFO] [stdout] test add_target_increments_count_and_activate_updates_active_index ... ok
[INFO] [stdout] test construct_aggregated_result_sums_started_targets_ignores_unstarted ... ok
[INFO] [stdout] test multi_target_switching_ignores_inactive_time_for_local_elapsed ... ok
[INFO] [stdout] test append_query_to_target_updates_only_selected_target ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/typing_engine_error_test.rs (/opt/rustwide/target/debug/deps/typing_engine_error_test-b61010bed55f2ea7)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test append_query_before_init_returns_not_initialized ... ok
[INFO] [stdout] test start_target_with_invalid_index_returns_target_not_found ... ok
[INFO] [stdout] test construct_result_before_start_returns_not_started ... ok
[INFO] [stdout] test append_query_to_target_with_invalid_index_returns_target_not_found ... ok
[INFO] [stdout] test construct_display_info_before_start_returns_not_started ... ok
[INFO] [stdout] test start_before_init_returns_not_initialized ... ok
[INFO] [stdout] test start_target_twice_returns_already_started ... ok
[INFO] [stdout] test construct_result_before_finish_returns_not_finished ... ok
[INFO] [stdout] test stroke_key_after_finished_returns_already_finished ... ok
[INFO] [stdout] test stroke_key_before_start_returns_not_started ... ok
[INFO] [stdout] test stroke_key_without_active_target_returns_not_initialized ... ok
[INFO] [stdout] test construct_display_info_of_target_before_start_returns_must_be_started ... ok
[INFO] [stdout] test construct_display_info_of_target_with_invalid_index_returns_target_not_found ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests typing_engine
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test src/lib.rs - (line 4) ... ok
[INFO] [stdout] test src/lib.rs - (line 73) ... ok
[INFO] [stdout] test src/lib.rs - (line 122) ... ok
[INFO] [stdout] test src/lib.rs - (line 137) ... ok
[INFO] [stdout] test src/vocabulary_parser.rs - vocabulary_parser::parse_vocabulary_entry (line 79) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.62s; merged doctests compilation took 0.61s
[INFO] running `Command { std: "docker" "inspect" "a318e1ab2be77039c2e3fe80ee0a3249dc2b9cc379a5013dabe5b3860265e185", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a318e1ab2be77039c2e3fe80ee0a3249dc2b9cc379a5013dabe5b3860265e185", kill_on_drop: false }`
[INFO] [stdout] a318e1ab2be77039c2e3fe80ee0a3249dc2b9cc379a5013dabe5b3860265e185
