[INFO] fetching crate nvpair 0.5.0...
[INFO] testing nvpair-0.5.0 against master#0d13f6afeba4935499abe0c9a07426c94492c94e for pr-96025-1
[INFO] extracting crate nvpair 0.5.0 into /workspace/builds/worker-6/source
[INFO] validating manifest of crates.io crate nvpair 0.5.0 on toolchain 0d13f6afeba4935499abe0c9a07426c94492c94e
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+0d13f6afeba4935499abe0c9a07426c94492c94e" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate nvpair 0.5.0
[INFO] finished tweaking crates.io crate nvpair 0.5.0
[INFO] tweaked toml for crates.io crate nvpair 0.5.0 written to /workspace/builds/worker-6/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+0d13f6afeba4935499abe0c9a07426c94492c94e" "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" "+0d13f6afeba4935499abe0c9a07426c94492c94e" "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] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded foreign-types-shared v0.3.1
[INFO] [stderr]   Downloaded foreign-types-macros v0.2.2
[INFO] [stderr]   Downloaded cstr-argument v0.1.2
[INFO] [stderr]   Downloaded nvpair-sys v0.4.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/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:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+0d13f6afeba4935499abe0c9a07426c94492c94e" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 3502a44a39c0832294e061c28f16610b977a8d5ee7a391290945f788b31fc0c0
[INFO] running `Command { std: "docker" "start" "-a" "3502a44a39c0832294e061c28f16610b977a8d5ee7a391290945f788b31fc0c0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3502a44a39c0832294e061c28f16610b977a8d5ee7a391290945f788b31fc0c0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3502a44a39c0832294e061c28f16610b977a8d5ee7a391290945f788b31fc0c0", kill_on_drop: false }`
[INFO] [stdout] 3502a44a39c0832294e061c28f16610b977a8d5ee7a391290945f788b31fc0c0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/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:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+0d13f6afeba4935499abe0c9a07426c94492c94e" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6f23f4a7528fa4c7e96990058b0a7902092e6d766f461a89c3d83966e5a5fe44
[INFO] running `Command { std: "docker" "start" "-a" "6f23f4a7528fa4c7e96990058b0a7902092e6d766f461a89c3d83966e5a5fe44", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.38
[INFO] [stderr]    Compiling unicode-xid v0.2.3
[INFO] [stderr]    Compiling syn v1.0.93
[INFO] [stderr]    Compiling memchr v2.5.0
[INFO] [stderr]    Compiling nvpair-sys v0.4.0
[INFO] [stderr]    Compiling foreign-types-shared v0.3.1
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling cstr-argument v0.1.2
[INFO] [stderr]    Compiling quote v1.0.18
[INFO] [stderr]    Compiling foreign-types-macros v0.2.2
[INFO] [stderr]    Compiling foreign-types v0.5.0
[INFO] [stderr]    Compiling nvpair v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.60s
[INFO] running `Command { std: "docker" "inspect" "6f23f4a7528fa4c7e96990058b0a7902092e6d766f461a89c3d83966e5a5fe44", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6f23f4a7528fa4c7e96990058b0a7902092e6d766f461a89c3d83966e5a5fe44", kill_on_drop: false }`
[INFO] [stdout] 6f23f4a7528fa4c7e96990058b0a7902092e6d766f461a89c3d83966e5a5fe44
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/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:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+0d13f6afeba4935499abe0c9a07426c94492c94e" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d5427f5148bca1c83c37467fa78c1db738b4f48e24140f3ad8f3b289562c0aca
[INFO] running `Command { std: "docker" "start" "-a" "d5427f5148bca1c83c37467fa78c1db738b4f48e24140f3ad8f3b289562c0aca", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling nvpair v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.94s
[INFO] [stderr]   Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/nvpair-8522c9391238c5a1)
[INFO] [stderr]   Executable tests/nvpair.rs (/opt/rustwide/target/debug/deps/nvpair-3ef7cd7424cb8d82)
[INFO] running `Command { std: "docker" "inspect" "d5427f5148bca1c83c37467fa78c1db738b4f48e24140f3ad8f3b289562c0aca", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d5427f5148bca1c83c37467fa78c1db738b4f48e24140f3ad8f3b289562c0aca", kill_on_drop: false }`
[INFO] [stdout] d5427f5148bca1c83c37467fa78c1db738b4f48e24140f3ad8f3b289562c0aca
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/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:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+0d13f6afeba4935499abe0c9a07426c94492c94e" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 83fe95d83a4298743a93ae34f65203ba585a350c1e47b6ab96c032a5732c8386
[INFO] running `Command { std: "docker" "start" "-a" "83fe95d83a4298743a93ae34f65203ba585a350c1e47b6ab96c032a5732c8386", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/nvpair-8522c9391238c5a1)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/nvpair.rs (/opt/rustwide/target/debug/deps/nvpair-3ef7cd7424cb8d82)
[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 7 tests
[INFO] [stdout] test lookup ... ok
[INFO] [stdout] test insert_cstr ... ok
[INFO] [stdout] test new ... ok
[INFO] [stdout] test size_empty_native ... ok
[INFO] [stdout] test add_boolean ... ok
[INFO] [stdout] test insert ... ok
[INFO] [stdout] test iter ... 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]    Doc-tests nvpair
[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] running `Command { std: "docker" "inspect" "83fe95d83a4298743a93ae34f65203ba585a350c1e47b6ab96c032a5732c8386", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "83fe95d83a4298743a93ae34f65203ba585a350c1e47b6ab96c032a5732c8386", kill_on_drop: false }`
[INFO] [stdout] 83fe95d83a4298743a93ae34f65203ba585a350c1e47b6ab96c032a5732c8386