[INFO] fetching crate kurisu 0.1.6...
[INFO] testing kurisu-0.1.6 against master#350d0ef0ec0493e6d21cfb265cb8211a0e74d766 for pr-145330-1
[INFO] extracting crate kurisu 0.1.6 into /workspace/builds/worker-3-tc1/source
[INFO] started tweaking crates.io crate kurisu 0.1.6
[INFO] finished tweaking crates.io crate kurisu 0.1.6
[INFO] tweaked toml for crates.io crate kurisu 0.1.6 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate kurisu 0.1.6 on toolchain 350d0ef0ec0493e6d21cfb265cb8211a0e74d766
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]      Locking 52 packages to latest compatible versions
[INFO] [stderr]       Adding float-cmp v0.9.0 (available: v0.10.0)
[INFO] [stderr]       Adding textwrap v0.12.1 (available: v0.16.2)
[INFO] [stderr]       Adding toml v0.5.11 (available: v0.9.7)
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded terminal_size v0.1.17
[INFO] [stderr]   Downloaded kurisu-derive v0.1.6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] cb5d415e275f614974e4992ead424d1c8b5fa7d45fe3006ae457947626547291
[INFO] running `Command { std: "docker" "start" "-a" "cb5d415e275f614974e4992ead424d1c8b5fa7d45fe3006ae457947626547291", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "cb5d415e275f614974e4992ead424d1c8b5fa7d45fe3006ae457947626547291", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cb5d415e275f614974e4992ead424d1c8b5fa7d45fe3006ae457947626547291", kill_on_drop: false }`
[INFO] [stdout] cb5d415e275f614974e4992ead424d1c8b5fa7d45fe3006ae457947626547291
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 46737d93ebcd52660a614642b3a5ab1204802601e6334b4e6fe6b3e2a23a2aa3
[INFO] running `Command { std: "docker" "start" "-a" "46737d93ebcd52660a614642b3a5ab1204802601e6334b4e6fe6b3e2a23a2aa3", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling terminal_size v0.1.17
[INFO] [stderr]    Compiling textwrap v0.12.1
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling kurisu-derive v0.1.6
[INFO] [stderr]    Compiling kurisu v0.1.6 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2.19s
[INFO] running `Command { std: "docker" "inspect" "46737d93ebcd52660a614642b3a5ab1204802601e6334b4e6fe6b3e2a23a2aa3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "46737d93ebcd52660a614642b3a5ab1204802601e6334b4e6fe6b3e2a23a2aa3", kill_on_drop: false }`
[INFO] [stdout] 46737d93ebcd52660a614642b3a5ab1204802601e6334b4e6fe6b3e2a23a2aa3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2bb98bcc1bdeb702fbc3049f3e78d39a380a0f245b20a23bc064932c7581a163
[INFO] running `Command { std: "docker" "start" "-a" "2bb98bcc1bdeb702fbc3049f3e78d39a380a0f245b20a23bc064932c7581a163", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling float-cmp v0.9.0
[INFO] [stderr]    Compiling toml v0.5.11
[INFO] [stderr]    Compiling kurisu v0.1.6 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 6.32s
[INFO] running `Command { std: "docker" "inspect" "2bb98bcc1bdeb702fbc3049f3e78d39a380a0f245b20a23bc064932c7581a163", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2bb98bcc1bdeb702fbc3049f3e78d39a380a0f245b20a23bc064932c7581a163", kill_on_drop: false }`
[INFO] [stdout] 2bb98bcc1bdeb702fbc3049f3e78d39a380a0f245b20a23bc064932c7581a163
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 70c306e9c2afd88945591610ce56fcc1fef4cfe7349e2e3bdb07e4dc20868926
[INFO] running `Command { std: "docker" "start" "-a" "70c306e9c2afd88945591610ce56fcc1fef4cfe7349e2e3bdb07e4dc20868926", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/kurisu-236f92e387d0f061)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/normalize_env_args.rs (/opt/rustwide/target/debug/deps/normalize_env_args-fc7cb20f2f1327e6)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test empty_value_double_quoted ... ok
[INFO] [stdout] test long_flag_with_dashes ... ok
[INFO] [stdout] test multiple_comma_values ... ok
[INFO] [stdout] test ending_flags_with_optional_value ... ok
[INFO] [stdout] test multiple_values ... ok
[INFO] [stdout] test only_positional_values_follow ... ok
[INFO] [stdout] test optional_value ... ok
[INFO] [stdout] test required_value_without_value ... ok
[INFO] [stdout] test short_flag_no_space_value ... ok
[INFO] [stdout] test short_flag_stacking ... ok
[INFO] [stdout] test positional_value_dash_only ... ok
[INFO] [stdout] test string_value_double_quoted ... ok
[INFO] [stdout] test no_value_flag_next_to_arg ... 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]      Running tests/parser_extras.rs (/opt/rustwide/target/debug/deps/parser_extras-758de8e06359c8fa)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/struct_args.rs (/opt/rustwide/target/debug/deps/struct_args-d9c0ada159cc11e1)
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 23 tests
[INFO] [stdout] test auto_shorts ... ok
[INFO] [stdout] test debug_info ... ok
[INFO] [stdout] test builtins ... ok
[INFO] [stdout] test empty_value_double_quoted ... ok
[INFO] [stdout] test default_long ... ok
[INFO] [stdout] test environment_var_fallback ... ok
[INFO] [stdout] test environment_var_fallback_prefix ... ok
[INFO] [stdout] test multiple_comma_values ... ok
[INFO] [stdout] test default_mandatory_values ... ok
[INFO] [stdout] test positional ... ok
[INFO] [stdout] test only_positional_values_follow ... ok
[INFO] [stdout] test multiple_values ... ok
[INFO] [stdout] test positional_dash_only ... ok
[INFO] [stdout] test occurrences ... ok
[INFO] [stdout] test positional_infinite_optional ... ok
[INFO] [stdout] test positional_infinite_string ... ok
[INFO] [stdout] test annotation_parser ... ok
[INFO] [stdout] test environment_var_fallback_override ... ok
[INFO] [stdout] test short_flag_no_space_value ... ok
[INFO] [stdout] test positional_infinite ... ok
[INFO] [stdout] test positional_infinite_and_last ... ok
[INFO] [stdout] test values ... ok
[INFO] [stdout] test not_occurrence ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/struct_info.rs (/opt/rustwide/target/debug/deps/struct_info-267c90c039683162)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test cargo_only_if_no_value ... ok
[INFO] [stdout] test doc ... ok
[INFO] [stdout] test annotation ... ok
[INFO] [stdout] test none ... ok
[INFO] [stdout] test noargs ... ok
[INFO] [stdout] test cargo ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/validate_usage.rs (/opt/rustwide/target/debug/deps/validate_usage-ffa47cdda25e9d5f)
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stdout] test aliases ... ok
[INFO] [stdout] test exit_arg_custom ... ok
[INFO] [stdout] test exit_arg_help ... ok
[INFO] [stdout] test exit_arg_version ... ok
[INFO] [stdout] test infinite_pos ... ok
[INFO] [stdout] test invalid_arg_within_args ... ok
[INFO] [stdout] test invalid_arg ... ok
[INFO] [stdout] test invalid_long ... ok
[INFO] [stdout] test invalid_short ... ok
[INFO] [stdout] test positional_missing_value ... ok
[INFO] [stdout] test required_if_args ... ok
[INFO] [stdout] test invalid_arg_last_pos ... ok
[INFO] [stdout] test value_required_vs_occurrence ... ok
[INFO] [stdout] test value_required ... ok
[INFO] [stdout] test no_args ... ok
[INFO] [stdout] test value_empty ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stderr]    Doc-tests kurisu
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/lib.rs - (line 42) ... ok
[INFO] [stdout] test src/lib.rs - (line 8) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.33s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "70c306e9c2afd88945591610ce56fcc1fef4cfe7349e2e3bdb07e4dc20868926", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "70c306e9c2afd88945591610ce56fcc1fef4cfe7349e2e3bdb07e4dc20868926", kill_on_drop: false }`
[INFO] [stdout] 70c306e9c2afd88945591610ce56fcc1fef4cfe7349e2e3bdb07e4dc20868926