[INFO] fetching crate optional-field 0.1.6...
[INFO] testing optional-field-0.1.6 against master#cdb45c87e2cd43495379f7e867e3cc15dcee9f93 for pr-145838-1
[INFO] extracting crate optional-field 0.1.6 into /workspace/builds/worker-5-tc1/source
[INFO] started tweaking crates.io crate optional-field 0.1.6
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate optional-field 0.1.6
[INFO] tweaked toml for crates.io crate optional-field 0.1.6 written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate optional-field 0.1.6 on toolchain cdb45c87e2cd43495379f7e867e3cc15dcee9f93
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "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" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "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]      Locking 12 packages to latest compatible versions
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded optional-fields-serde-macro v0.1.2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] a571ed3637552309e2bbc0900fbbe4edd4ddaec62143bb395e1872bb2e10ef24
[INFO] running `Command { std: "docker" "start" "-a" "a571ed3637552309e2bbc0900fbbe4edd4ddaec62143bb395e1872bb2e10ef24", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a571ed3637552309e2bbc0900fbbe4edd4ddaec62143bb395e1872bb2e10ef24", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a571ed3637552309e2bbc0900fbbe4edd4ddaec62143bb395e1872bb2e10ef24", kill_on_drop: false }`
[INFO] [stdout] a571ed3637552309e2bbc0900fbbe4edd4ddaec62143bb395e1872bb2e10ef24
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 79d06de65d58d9a592db588d83b0af160756e19e1c61759b130c2df29330c378
[INFO] running `Command { std: "docker" "start" "-a" "79d06de65d58d9a592db588d83b0af160756e19e1c61759b130c2df29330c378", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling syn v2.0.106
[INFO] [stderr]    Compiling serde_derive v1.0.219
[INFO] [stderr]    Compiling optional-fields-serde-macro v0.1.2
[INFO] [stderr]    Compiling serde v1.0.219
[INFO] [stderr]    Compiling optional-field v0.1.6 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 14.42s
[INFO] running `Command { std: "docker" "inspect" "79d06de65d58d9a592db588d83b0af160756e19e1c61759b130c2df29330c378", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "79d06de65d58d9a592db588d83b0af160756e19e1c61759b130c2df29330c378", kill_on_drop: false }`
[INFO] [stdout] 79d06de65d58d9a592db588d83b0af160756e19e1c61759b130c2df29330c378
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ff859623bdc98edbd8679f9a4383b473ecfccf42373b482d1f8fd7081fda9682
[INFO] running `Command { std: "docker" "start" "-a" "ff859623bdc98edbd8679f9a4383b473ecfccf42373b482d1f8fd7081fda9682", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_json v1.0.143
[INFO] [stderr]    Compiling optional-field v0.1.6 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.54s
[INFO] running `Command { std: "docker" "inspect" "ff859623bdc98edbd8679f9a4383b473ecfccf42373b482d1f8fd7081fda9682", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ff859623bdc98edbd8679f9a4383b473ecfccf42373b482d1f8fd7081fda9682", kill_on_drop: false }`
[INFO] [stdout] ff859623bdc98edbd8679f9a4383b473ecfccf42373b482d1f8fd7081fda9682
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 9c2c024ac16e5acf803d85dada0962769f8fcfe664d642b00f420000f1d9aff1
[INFO] running `Command { std: "docker" "start" "-a" "9c2c024ac16e5acf803d85dada0962769f8fcfe664d642b00f420000f1d9aff1", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/optional_field-4c512662fada7d04)
[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/serde.rs (/opt/rustwide/target/debug/deps/serde-2377aeb49f1821b4)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test deserialize_null ... ok
[INFO] [stdout] test deserialize_value ... ok
[INFO] [stdout] test deserialize_missing ... ok
[INFO] [stdout] test serialize_missing ... ok
[INFO] [stdout] test serialize_null ... ok
[INFO] [stderr]    Doc-tests optional_field
[INFO] [stdout] test serialize_value ... ok
[INFO] [stdout] test with_fqn ... 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] [stdout] 
[INFO] [stdout] running 43 tests
[INFO] [stdout] test src/lib.rs - Field<&'_T>::copied (line 817) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::and (line 553) ... ok
[INFO] [stdout] test src/lib.rs - Field<&'_T>::cloned (line 854) ... ok
[INFO] [stdout] test src/lib.rs - Field<&'_mutT>::cloned (line 872) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::and_present (line 587) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::and_then_present (line 640) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::as_mut (line 115) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::and_then (line 619) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::as_deref_mut (line 914) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::as_deref (line 893) ... ok
[INFO] [stdout] test src/lib.rs - Field<&'_mutT>::copied (line 836) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::as_ref (line 94) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::contains (line 64) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::expect (line 482) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::delta (line 940) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::expect (line 476) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::expect_present (line 503) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::get_or_insert_present (line 691) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::get_or_insert (line 662) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::expect_present (line 509) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::has_value (line 50) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::get_or_insert_with (line 717) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::get_or_insert_with_present (line 749) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::is_missing (line 22) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::is_present (line 36) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::map (line 141) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::map_or_else (line 239) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::map_present_or (line 214) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::map_present_or_else (line 263) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::map_present (line 165) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::unwrap (line 299) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::unwrap (line 293) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::unwrap_present (line 322) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::map_or (line 192) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::unwrap_or_else (line 436) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::unwrap_or (line 402) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::unwrap_present_mut (line 380) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::unwrap_present_mut (line 374) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::unwrap_present_or (line 419) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::unwrap_present (line 328) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::unwrap_present_ref (line 348) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::unwrap_present_or_else (line 454) ... ok
[INFO] [stdout] test src/lib.rs - Field<T>::unwrap_present_ref (line 354) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 43 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.33s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "9c2c024ac16e5acf803d85dada0962769f8fcfe664d642b00f420000f1d9aff1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9c2c024ac16e5acf803d85dada0962769f8fcfe664d642b00f420000f1d9aff1", kill_on_drop: false }`
[INFO] [stdout] 9c2c024ac16e5acf803d85dada0962769f8fcfe664d642b00f420000f1d9aff1