[INFO] fetching crate optfield 0.4.0...
[INFO] testing optfield-0.4.0 against try#8de4c7234dd9b97c9d76b58671343fdbbc9a433e+target=x86_64-unknown-linux-musl for musl_upgrade_1_2_5_with_libc_patch_0
[INFO] extracting crate optfield 0.4.0 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate optfield 0.4.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate optfield 0.4.0
[INFO] tweaked toml for crates.io crate optfield 0.4.0 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate optfield 0.4.0 on toolchain 8de4c7234dd9b97c9d76b58671343fdbbc9a433e
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "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" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]      Locking 7 packages to latest compatible versions
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "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-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 8b82d28b83fa9022d0954db5ead89ad3bcec67778158ebc8d9838a69db4c42a0
[INFO] running `Command { std: "docker" "start" "-a" "8b82d28b83fa9022d0954db5ead89ad3bcec67778158ebc8d9838a69db4c42a0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8b82d28b83fa9022d0954db5ead89ad3bcec67778158ebc8d9838a69db4c42a0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8b82d28b83fa9022d0954db5ead89ad3bcec67778158ebc8d9838a69db4c42a0", kill_on_drop: false }`
[INFO] [stdout] 8b82d28b83fa9022d0954db5ead89ad3bcec67778158ebc8d9838a69db4c42a0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "build" "--frozen" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] fef3626cbb49379c13ef6704f8167de7306b7550061d33500675f6c0cf5dfd06
[INFO] running `Command { std: "docker" "start" "-a" "fef3626cbb49379c13ef6704f8167de7306b7550061d33500675f6c0cf5dfd06", kill_on_drop: false }`
[INFO] [stderr]    Compiling optfield v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.96s
[INFO] running `Command { std: "docker" "inspect" "fef3626cbb49379c13ef6704f8167de7306b7550061d33500675f6c0cf5dfd06", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fef3626cbb49379c13ef6704f8167de7306b7550061d33500675f6c0cf5dfd06", kill_on_drop: false }`
[INFO] [stdout] fef3626cbb49379c13ef6704f8167de7306b7550061d33500675f6c0cf5dfd06
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--no-run" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 9a1475e00701db3115d878f28e9fd22592ff1f895e78567469e19ef6f571e35c
[INFO] running `Command { std: "docker" "start" "-a" "9a1475e00701db3115d878f28e9fd22592ff1f895e78567469e19ef6f571e35c", kill_on_drop: false }`
[INFO] [stderr]    Compiling paste v1.0.15
[INFO] [stderr]    Compiling proc-macro2 v1.0.95
[INFO] [stderr]    Compiling serde v1.0.219
[INFO] [stderr]    Compiling quote v1.0.40
[INFO] [stderr]    Compiling syn v2.0.104
[INFO] [stderr]    Compiling optfield v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 6.76s
[INFO] running `Command { std: "docker" "inspect" "9a1475e00701db3115d878f28e9fd22592ff1f895e78567469e19ef6f571e35c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9a1475e00701db3115d878f28e9fd22592ff1f895e78567469e19ef6f571e35c", kill_on_drop: false }`
[INFO] [stdout] 9a1475e00701db3115d878f28e9fd22592ff1f895e78567469e19ef6f571e35c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] e2f2991c824a7d4792718add36a77edc3bb6abe5399915f1f15eec8345d2441d
[INFO] running `Command { std: "docker" "start" "-a" "e2f2991c824a7d4792718add36a77edc3bb6abe5399915f1f15eec8345d2441d", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/optfield-a0673701e83cd661)
[INFO] [stdout] 
[INFO] [stdout] running 47 tests
[INFO] [stdout] test args::tests::parse_attr_list ... ok
[INFO] [stdout] test args::tests::parse_attrs_test ... ok
[INFO] [stdout] test args::tests::parse_doc ... ok
[INFO] [stdout] test args::tests::parse_field_doc ... ok
[INFO] [stdout] test args::tests::parse_from ... ok
[INFO] [stdout] test args::tests::parse_merge_fn ... ok
[INFO] [stdout] test args::tests::parse_field_attrs ... ok
[INFO] [stdout] test args::tests::parse_name ... ok
[INFO] [stdout] test args::tests::parse_no_optional_args ... ok
[INFO] [stdout] test args::tests::parse_rewrap ... ok
[INFO] [stdout] test args::tests::parse_visibility ... ok
[INFO] [stdout] test attrs::tests::add_attrs ... ok
[INFO] [stdout] test attrs::tests::keep_attrs ... ok
[INFO] [stdout] test attrs::tests::keep_same_docs ... ok
[INFO] [stdout] test attrs::tests::remove_attrs ... ok
[INFO] [stdout] test attrs::tests::remove_docs ... ok
[INFO] [stdout] test attrs::tests::remove_other_optfield_attrs ... ok
[INFO] [stdout] test attrs::tests::replace_attrs ... ok
[INFO] [stdout] test attrs::tests::replace_docs ... ok
[INFO] [stdout] test fields::attrs::tests::add_attrs ... ok
[INFO] [stdout] test fields::attrs::tests::keep_attrs ... ok
[INFO] [stdout] test fields::attrs::tests::keep_docs ... ok
[INFO] [stdout] test fields::attrs::tests::remove_attrs ... ok
[INFO] [stdout] test fields::attrs::tests::remove_docs ... ok
[INFO] [stdout] test fields::attrs::tests::replace_attrs ... ok
[INFO] [stdout] test fields::tests::test_is_not_option ... ok
[INFO] [stdout] test fields::tests::test_is_option ... ok
[INFO] [stdout] test fields::tests::with_rewrap ... ok
[INFO] [stdout] test fields::tests::without_rewrap ... ok
[INFO] [stdout] test generate::tests::sets_generics ... ok
[INFO] [stdout] test generate::tests::sets_name ... ok
[INFO] [stdout] test generate::tests::sets_visibility ... ok
[INFO] [stdout] test args::tests::duplicate_merge_fn_panics - should panic ... ok
[INFO] [stdout] test args::tests::doc_first_panics - should panic ... ok
[INFO] [stdout] test args::tests::empty_args_panics - should panic ... ok
[INFO] [stdout] test args::tests::attrs_first_panics - should panic ... ok
[INFO] [stdout] test args::tests::duplicate_field_doc_panics - should panic ... ok
[INFO] [stdout] test args::tests::duplicate_doc_panics - should panic ... ok
[INFO] [stdout] test args::tests::duplicate_from_panics - should panic ... ok
[INFO] [stdout] test args::tests::duplicate_rewrap_panics - should panic ... ok
[INFO] [stdout] test args::tests::field_attrs_first_panics - should panic ... ok
[INFO] [stdout] test args::tests::field_doc_first_panics - should panic ... ok
[INFO] [stdout] test args::tests::duplicate_attrs_panics - should panic ... ok
[INFO] [stdout] test args::tests::duplicate_field_attrs_panics - should panic ... ok
[INFO] [stdout] test args::tests::from_first_panics - should panic ... ok
[INFO] [stdout] test args::tests::merge_fn_first_panics - should panic ... ok
[INFO] [stdout] test args::tests::rewrap_first_panics - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 47 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/from.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/from-8184de51aeebd029)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test from_cfg_field ... ok
[INFO] [stdout] test from_tuple_struct ... ok
[INFO] [stdout] test from_struct ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/merge.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/merge-40e6f7726afa2cb1)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test merge_tuple_struct ... ok
[INFO] [stdout] test merge_struct ... ok
[INFO] [stdout] test merge_cfg_field ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/multiple.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/multiple-9378dbd1533b036a)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test multiple_optfield_same_struct ... ok
[INFO] [stderr]    Doc-tests optfield
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 39 tests
[INFO] [stdout] test src/lib.rs - (line 159) ... ok
[INFO] [stdout] test src/lib.rs - (line 19) ... ok
[INFO] [stdout] test src/lib.rs - (line 134) ... ok
[INFO] [stdout] test src/lib.rs - (line 169) ... ok
[INFO] [stdout] test src/lib.rs - (line 126) ... ok
[INFO] [stdout] test src/lib.rs - (line 234) ... ok
[INFO] [stdout] test src/lib.rs - (line 192) ... ok
[INFO] [stdout] test src/lib.rs - (line 216) ... ok
[INFO] [stdout] test src/lib.rs - (line 251) ... ok
[INFO] [stdout] test src/lib.rs - (line 148) ... ok
[INFO] [stdout] test src/lib.rs - (line 201) ... ok
[INFO] [stdout] test src/lib.rs - (line 226) ... ok
[INFO] [stdout] test src/lib.rs - (line 105) ... ok
[INFO] [stdout] test src/lib.rs - (line 115) ... ok
[INFO] [stdout] test src/lib.rs - (line 257) ... ok
[INFO] [stdout] test src/lib.rs - (line 241) ... ok
[INFO] [stdout] test src/lib.rs - (line 177) ... ok
[INFO] [stdout] test src/lib.rs - (line 267) ... ok
[INFO] [stdout] test src/lib.rs - (line 282) ... ok
[INFO] [stdout] test src/lib.rs - (line 388) ... ok
[INFO] [stdout] test src/lib.rs - (line 28) ... ok
[INFO] [stdout] test src/lib.rs - (line 312) ... ok
[INFO] [stdout] test src/lib.rs - (line 340) ... ok
[INFO] [stdout] test src/lib.rs - (line 293) ... ok
[INFO] [stdout] test src/lib.rs - (line 34) ... ok
[INFO] [stdout] test src/lib.rs - (line 301) ... ok
[INFO] [stdout] test src/lib.rs - (line 433) ... ok
[INFO] [stdout] test src/lib.rs - (line 321) ... ok
[INFO] [stdout] test src/lib.rs - (line 40) ... ok
[INFO] [stdout] test src/lib.rs - (line 69) ... ok
[INFO] [stdout] test src/lib.rs - (line 372) ... ok
[INFO] [stdout] test src/lib.rs - (line 52) ... ok
[INFO] [stdout] test src/lib.rs - (line 401) ... ok
[INFO] [stdout] test src/lib.rs - (line 79) ... ok
[INFO] [stdout] test src/lib.rs - (line 61) ... ok
[INFO] [stdout] test src/lib.rs - (line 353) ... ok
[INFO] [stdout] test src/lib.rs - (line 88) ... ok
[INFO] [stdout] test src/lib.rs - (line 44) ... ok
[INFO] [stdout] test src/lib.rs - (line 96) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 39 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.94s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "e2f2991c824a7d4792718add36a77edc3bb6abe5399915f1f15eec8345d2441d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e2f2991c824a7d4792718add36a77edc3bb6abe5399915f1f15eec8345d2441d", kill_on_drop: false }`
[INFO] [stdout] e2f2991c824a7d4792718add36a77edc3bb6abe5399915f1f15eec8345d2441d