[INFO] fetching crate gong 1.4.2... [INFO] testing gong-1.4.2 against beta-2021-09-08 for beta-1.56-1 [INFO] extracting crate gong 1.4.2 into /workspace/builds/worker-104/source [INFO] validating manifest of crates.io crate gong 1.4.2 on toolchain beta-2021-09-08 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate gong 1.4.2 [INFO] finished tweaking crates.io crate gong 1.4.2 [INFO] tweaked toml for crates.io crate gong 1.4.2 written to /workspace/builds/worker-104/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 4fa3f1383deb63413bf0f929231630fe9cdb89e32ede53883bc858165928ab0f [INFO] running `Command { std: "docker" "start" "-a" "4fa3f1383deb63413bf0f929231630fe9cdb89e32ede53883bc858165928ab0f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "4fa3f1383deb63413bf0f929231630fe9cdb89e32ede53883bc858165928ab0f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "4fa3f1383deb63413bf0f929231630fe9cdb89e32ede53883bc858165928ab0f", kill_on_drop: false }` [INFO] [stdout] 4fa3f1383deb63413bf0f929231630fe9cdb89e32ede53883bc858165928ab0f [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/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=warn" "-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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 7a6201f4d807d435e6ee544d90be75bed243db4562c2a45485e425c70ab75feb [INFO] running `Command { std: "docker" "start" "-a" "7a6201f4d807d435e6ee544d90be75bed243db4562c2a45485e425c70ab75feb", kill_on_drop: false }` [INFO] [stderr] Compiling gong v1.4.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.61s [INFO] running `Command { std: "docker" "inspect" "7a6201f4d807d435e6ee544d90be75bed243db4562c2a45485e425c70ab75feb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "7a6201f4d807d435e6ee544d90be75bed243db4562c2a45485e425c70ab75feb", kill_on_drop: false }` [INFO] [stdout] 7a6201f4d807d435e6ee544d90be75bed243db4562c2a45485e425c70ab75feb [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/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=warn" "-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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 6f8bc5d08bb1acf820d472b721678f4d51a5a3c95ef8b7d420d062bb9e378c82 [INFO] running `Command { std: "docker" "start" "-a" "6f8bc5d08bb1acf820d472b721678f4d51a5a3c95ef8b7d420d062bb9e378c82", kill_on_drop: false }` [INFO] [stderr] Compiling gong v1.4.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 1.04s [INFO] running `Command { std: "docker" "inspect" "6f8bc5d08bb1acf820d472b721678f4d51a5a3c95ef8b7d420d062bb9e378c82", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "6f8bc5d08bb1acf820d472b721678f4d51a5a3c95ef8b7d420d062bb9e378c82", kill_on_drop: false }` [INFO] [stdout] 6f8bc5d08bb1acf820d472b721678f4d51a5a3c95ef8b7d420d062bb9e378c82 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/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=warn" "-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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] f9ca82e3c4b03a19cf3cbd69b3c282e1aca77e4c56cab1e3b84e594e377f68be [INFO] running `Command { std: "docker" "start" "-a" "f9ca82e3c4b03a19cf3cbd69b3c282e1aca77e4c56cab1e3b84e594e377f68be", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.58s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/gong-c8eac14376d7da65) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test options::tests::create_long_no_name - should panic ... ok [INFO] [stdout] test options::tests::create_long_with_equals - should panic ... ok [INFO] [stdout] test options::tests::create_short_dash - should panic ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stderr] Running tests/macros.rs (/opt/rustwide/target/debug/deps/macros-ec874382409afad2) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test available_options::cmp_hand_built ... ok [INFO] [stdout] test available_options::cmp_non_fixed ... ok [INFO] [stdout] test available_options::modes ... ok [INFO] [stdout] test available_options::cmp_method_built ... 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/options.rs (/opt/rustwide/target/debug/deps/options-37a6ac5433e17dbb) [INFO] [stdout] [INFO] [stdout] running 19 tests [INFO] [stdout] test basic ... ok [INFO] [stdout] test duplicates::short ... ok [INFO] [stdout] test duplicates::long ... ok [INFO] [stdout] test long_equals::add_long_existing ... ok [INFO] [stdout] test long_equals::bypassed_processing ... ok [INFO] [stdout] test long_equals::invalid_set ... ok [INFO] [stdout] test is_empty ... ok [INFO] [stdout] test long_no_name::add_long_existing ... ok [INFO] [stdout] test set_types ... ok [INFO] [stdout] test long_no_name::invalid_set ... ok [INFO] [stdout] test short_dash::add_short_existing ... ok [INFO] [stdout] test short_dash::invalid_set ... ok [INFO] [stdout] test short_dash::bypassed_processing ... ok [INFO] [stdout] test long_equals::add_long - should panic ... ok [INFO] [stdout] test long_no_name::add_long - should panic ... ok [INFO] [stdout] test long_no_name::add_long_data - should panic ... ok [INFO] [stdout] test short_dash::add_short - should panic ... ok [INFO] [stdout] test short_dash::add_short_data - should panic ... ok [INFO] [stdout] test long_equals::add_long_data - should panic ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s [INFO] [stdout] [INFO] [stderr] Running tests/processing.rs (/opt/rustwide/target/debug/deps/processing-f766bff88b6b9850) [INFO] [stdout] [INFO] [stdout] running 32 tests [INFO] [stdout] test abbreviations::ambiguous ... ok [INFO] [stdout] test abbreviations::unambiguous ... ok [INFO] [stdout] test alt_mode::data_basic ... ok [INFO] [stdout] test alt_mode::data_looking_like_early_term ... ok [INFO] [stdout] test arg_list_owned_set ... ok [INFO] [stdout] test basic ... ok [INFO] [stdout] test case_sensitivity ... ok [INFO] [stdout] test data::arg_placement_long ... ok [INFO] [stdout] test alt_mode::basic ... ok [INFO] [stdout] test abbreviations::exact_override ... ok [INFO] [stdout] test abbreviations::disabled ... ok [INFO] [stdout] test data::arg_placement_short_calc ... ok [INFO] [stdout] test data::arg_placement_short_next ... ok [INFO] [stdout] test data::arg_placement_short_same ... ok [INFO] [stdout] test data::containing_equals ... ok [INFO] [stdout] test data::looking_like_early_term ... ok [INFO] [stdout] test data::looking_like_options ... ok [INFO] [stdout] test data::misc ... ok [INFO] [stdout] test data::missing_long ... ok [INFO] [stdout] test data::missing_short ... ok [INFO] [stdout] test data::multibyte_long ... ok [INFO] [stdout] test data::multibyte_short ... ok [INFO] [stdout] test data::multibyte_utf8combi_short ... ok [INFO] [stdout] test data::repetition ... ok [INFO] [stdout] test data::same_arg_empty ... ok [INFO] [stdout] test early_term ... ok [INFO] [stdout] test long_no_name ... ok [INFO] [stdout] test utf8::test1 ... ok [INFO] [stdout] test utf8::test2 ... ok [INFO] [stdout] test utf8::test3 ... ok [INFO] [stdout] test utf8::test4 ... ok [INFO] [stdout] test repetition ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 32 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stderr] Running tests/testenv.rs (/opt/rustwide/target/debug/deps/testenv-00382f68e57a21d0) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test base_set::is_valid ... ok [INFO] [stdout] test check_constants ... ok [INFO] [stdout] test base_set::is_valid_altmode ... ok [INFO] [stdout] test base_set::can_break - should panic ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stderr] Doc-tests gong [INFO] [stdout] [INFO] [stdout] running 8 tests [INFO] [stdout] test src/docs/usage.rs - docs::usage (line 120) ... ok [INFO] [stdout] test src/macros.rs - macros::gong_option_set_fixed (line 63) ... ok [INFO] [stdout] test src/docs/usage.rs - docs::usage (line 59) ... ok [INFO] [stdout] test src/docs/usage.rs - docs::usage (line 42) ... ok [INFO] [stdout] test src/macros.rs - macros::gong_option_set (line 24) ... ok [INFO] [stdout] test src/docs/usage.rs - docs::usage (line 19) ... ok [INFO] [stdout] test src/docs/usage.rs - docs::usage (line 129) ... ok [INFO] [stdout] test src/docs/usage.rs - docs::usage (line 142) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.65s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "f9ca82e3c4b03a19cf3cbd69b3c282e1aca77e4c56cab1e3b84e594e377f68be", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "f9ca82e3c4b03a19cf3cbd69b3c282e1aca77e4c56cab1e3b84e594e377f68be", kill_on_drop: false }` [INFO] [stdout] f9ca82e3c4b03a19cf3cbd69b3c282e1aca77e4c56cab1e3b84e594e377f68be