[INFO] fetching crate alphabet 0.2.2...
[INFO] testing alphabet-0.2.2 against try#d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2 for pr-86479
[INFO] extracting crate alphabet 0.2.2 into /workspace/builds/worker-5/source
[INFO] validating manifest of crates.io crate alphabet 0.2.2 on toolchain d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate alphabet 0.2.2
[INFO] finished tweaking crates.io crate alphabet 0.2.2
[INFO] tweaked toml for crates.io crate alphabet 0.2.2 written to /workspace/builds/worker-5/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded alphabet-macro v0.1.2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] a7390ddaf1604c6559ec90aa8a4b1aeefcef019523e0d8c23e40c2485f0ac63e
[INFO] running `Command { std: "docker" "start" "-a" "a7390ddaf1604c6559ec90aa8a4b1aeefcef019523e0d8c23e40c2485f0ac63e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a7390ddaf1604c6559ec90aa8a4b1aeefcef019523e0d8c23e40c2485f0ac63e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a7390ddaf1604c6559ec90aa8a4b1aeefcef019523e0d8c23e40c2485f0ac63e", kill_on_drop: false }`
[INFO] [stdout] a7390ddaf1604c6559ec90aa8a4b1aeefcef019523e0d8c23e40c2485f0ac63e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 3fca01141d9f35912084e1b43aae1689ad871bd2a05f8b2f024a00e4e3b7dfa8
[INFO] running `Command { std: "docker" "start" "-a" "3fca01141d9f35912084e1b43aae1689ad871bd2a05f8b2f024a00e4e3b7dfa8", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.28
[INFO] [stderr]    Compiling more-asserts v0.2.1
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling syn v1.0.74
[INFO] [stderr]    Compiling alphabet-macro v0.1.2
[INFO] [stderr]    Compiling alphabet v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.75s
[INFO] running `Command { std: "docker" "inspect" "3fca01141d9f35912084e1b43aae1689ad871bd2a05f8b2f024a00e4e3b7dfa8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3fca01141d9f35912084e1b43aae1689ad871bd2a05f8b2f024a00e4e3b7dfa8", kill_on_drop: false }`
[INFO] [stdout] 3fca01141d9f35912084e1b43aae1689ad871bd2a05f8b2f024a00e4e3b7dfa8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ca861e4ff1cb9cdc3174bd83768ae6c4b76def67a8d9860d102f6e72d2413d46
[INFO] running `Command { std: "docker" "start" "-a" "ca861e4ff1cb9cdc3174bd83768ae6c4b76def67a8d9860d102f6e72d2413d46", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling alphabet v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.99s
[INFO] running `Command { std: "docker" "inspect" "ca861e4ff1cb9cdc3174bd83768ae6c4b76def67a8d9860d102f6e72d2413d46", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ca861e4ff1cb9cdc3174bd83768ae6c4b76def67a8d9860d102f6e72d2413d46", kill_on_drop: false }`
[INFO] [stdout] ca861e4ff1cb9cdc3174bd83768ae6c4b76def67a8d9860d102f6e72d2413d46
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 1a97f6e1d6c7ca316b507e9ae02eebd2b4f240718aa3b4157629f1d5f0259b1e
[INFO] running `Command { std: "docker" "start" "-a" "1a97f6e1d6c7ca316b507e9ae02eebd2b4f240718aa3b4157629f1d5f0259b1e", kill_on_drop: false }`
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stdout] running 42 tests
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/alphabet-da8e0ebc17f764ec)
[INFO] [stdout] test counter::tests::test_increase_rollover_1 ... ok
[INFO] [stdout] test counter::tests::test_increase_empty ... ok
[INFO] [stdout] test tests::test_empty_alphabet_has_only_empty_word ... ok
[INFO] [stdout] test word::counting_iter::tests::test_bcba_is_word ... ok
[INFO] [stdout] test word::counting_iter::tests::test_create_iterator ... ok
[INFO] [stdout] test word::counting_iter::tests::test_stays_none_on_empty_source ... ok
[INFO] [stdout] test word::word_iter::tests::test_aaaaaa_is_word ... ok
[INFO] [stdout] test counter::tests::test_to_empty_word ... ok
[INFO] [stdout] test counter::tests::test_increase_rollover_large ... ok
[INFO] [stdout] test counter::tests::test_increase ... ok
[INFO] [stdout] test word::counting_iter::tests::test_stays_none_on_singleton_source ... ok
[INFO] [stdout] test word::counting_iter::tests::test_empty_on_empty_source ... ok
[INFO] [stdout] test word::counting_iter::tests::test_empty_on_singleton_source ... ok
[INFO] [stdout] test word::counting_iter::tests::test_not_obtain_empty_word ... ok
[INFO] [stdout] test tests::test_singleton_alphabet_has_no_count_words ... ok
[INFO] [stdout] test tests::test_some_english_words ... ok
[INFO] [stdout] test tests::test_some_german_words ... ok
[INFO] [stdout] test util::tests::test_access_direct ... ok
[INFO] [stdout] test util::tests::test_access_indirect ... ok
[INFO] [stdout] test util::tests::test_get_direct_same ... ok
[INFO] [stdout] test util::tests::test_get_indirect_same ... ok
[INFO] [stdout] test word::counting_iter::tests::test_a_is_first_word ... ok
[INFO] [stdout] test tests::test_empty_alphabet_has_no_count_words ... ok
[INFO] [stdout] test counter::tests::test_to_word_uses_reverse ... ok
[INFO] [stdout] test word::word_iter::tests::test_abcba_is_word ... ok
[INFO] [stdout] test word::word_iter::tests::test_create_iterator ... ok
[INFO] [stdout] test word::word_iter::tests::test_obtain_empty_word ... ok
[INFO] [stdout] test word::word_iter::tests::test_stays_none ... ok
[INFO] [stdout] test word::word_iter::tests::test_ends_after_empty_word_on_empty_source ... ok
[INFO] [stdout] test counter::tests::test_to_word ... ok
[INFO] [stdout] test counter::tests::test_increase_initial_ge_rollover_panic - should panic ... ok
[INFO] [stdout] test counter::tests::test_increase_rollover_0_panic - should panic ... ok
[INFO] [stdout] test tests::test_singleton_alphabet_has_many_words ... ok
[INFO] [stdout] test word::counting_iter::tests::test_word_size_monotonically_increases ... ok
[INFO] [stdout] test word::counting_iter::tests::test_does_not_end ... ok
[INFO] [stdout] test word::word_iter::tests::test_nonempty_alphabet_does_not_end ... ok
[INFO] [stdout] test word::word_iter::tests::test_word_size_monotonically_increases ... ok
[INFO] [stdout] test word::counting_iter::tests::test_abcba_is_not_a_word ... ok
[INFO] [stdout] test tests::test_iter_words_does_not_count ... ok
[INFO] [stdout] test tests::test_many_words ... ok
[INFO] [stdout] test tests::test_many_words_counting ... ok
[INFO] [stdout] test tests::test_binary_counting_works ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 42 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.17s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests alphabet
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test src/lib.rs - Alphabet::iter_words_counting (line 115) ... ok
[INFO] [stdout] test src/lib.rs - Alphabet::iter_words (line 65) ... ok
[INFO] [stdout] test src/lib.rs - Alphabet::iter_words (line 47) ... ok
[INFO] [stdout] test src/lib.rs - Alphabet::iter_words_counting (line 95) ... ok
[INFO] [stdout] test src/lib.rs - Alphabet::iter_words_counting (line 108) ... ok
[INFO] [stdout] test src/lib.rs - Alphabet::iter_words (line 35) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.02s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "1a97f6e1d6c7ca316b507e9ae02eebd2b4f240718aa3b4157629f1d5f0259b1e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1a97f6e1d6c7ca316b507e9ae02eebd2b4f240718aa3b4157629f1d5f0259b1e", kill_on_drop: false }`
[INFO] [stdout] 1a97f6e1d6c7ca316b507e9ae02eebd2b4f240718aa3b4157629f1d5f0259b1e