[INFO] fetching crate pair_macro 0.1.4...
[INFO] testing pair_macro-0.1.4 against master#caccb4d0368bd918ef6668af8e13834d07040417 for pr-146098-1
[INFO] extracting crate pair_macro 0.1.4 into /workspace/builds/worker-2-tc1/source
[INFO] started tweaking crates.io crate pair_macro 0.1.4
[INFO] finished tweaking crates.io crate pair_macro 0.1.4
[INFO] tweaked toml for crates.io crate pair_macro 0.1.4 written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate pair_macro 0.1.4 on toolchain caccb4d0368bd918ef6668af8e13834d07040417
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "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" "+caccb4d0368bd918ef6668af8e13834d07040417" "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 14 packages to latest compatible versions
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "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-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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" "+caccb4d0368bd918ef6668af8e13834d07040417" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] eebeb0778ee7ef0c0a3546d4dfc2c5eef929d24ea3191b2dc86d6a1b4d4be795
[INFO] running `Command { std: "docker" "start" "-a" "eebeb0778ee7ef0c0a3546d4dfc2c5eef929d24ea3191b2dc86d6a1b4d4be795", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "eebeb0778ee7ef0c0a3546d4dfc2c5eef929d24ea3191b2dc86d6a1b4d4be795", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "eebeb0778ee7ef0c0a3546d4dfc2c5eef929d24ea3191b2dc86d6a1b4d4be795", kill_on_drop: false }`
[INFO] [stdout] eebeb0778ee7ef0c0a3546d4dfc2c5eef929d24ea3191b2dc86d6a1b4d4be795
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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" "+caccb4d0368bd918ef6668af8e13834d07040417" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ac168ad5cdb50836b1406d73c5d58fb48869129a2cd6b541adff19f549f766c9
[INFO] running `Command { std: "docker" "start" "-a" "ac168ad5cdb50836b1406d73c5d58fb48869129a2cd6b541adff19f549f766c9", kill_on_drop: false }`
[INFO] [stderr]    Compiling pair_macro v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.22s
[INFO] running `Command { std: "docker" "inspect" "ac168ad5cdb50836b1406d73c5d58fb48869129a2cd6b541adff19f549f766c9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ac168ad5cdb50836b1406d73c5d58fb48869129a2cd6b541adff19f549f766c9", kill_on_drop: false }`
[INFO] [stdout] ac168ad5cdb50836b1406d73c5d58fb48869129a2cd6b541adff19f549f766c9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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" "+caccb4d0368bd918ef6668af8e13834d07040417" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f289d06c1cddbb8fd737a208ee2472db8a9feead4d8c0e0d86a0771cb515bf62
[INFO] running `Command { std: "docker" "start" "-a" "f289d06c1cddbb8fd737a208ee2472db8a9feead4d8c0e0d86a0771cb515bf62", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]    Compiling pair_macro v0.1.4 (/opt/rustwide/workdir)
[INFO] [stdout] warning: use of deprecated method `Pair::<T>::fold`: Use into_iter().fold(init, f) instead
[INFO] [stdout]    --> src/lib.rs:822:33
[INFO] [stdout]     |
[INFO] [stdout] 822 |         let f = Pair::new(2, 3).fold(1, |acc, cur| acc * cur);
[INFO] [stdout]     |                                 ^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(deprecated)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.23s
[INFO] running `Command { std: "docker" "inspect" "f289d06c1cddbb8fd737a208ee2472db8a9feead4d8c0e0d86a0771cb515bf62", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f289d06c1cddbb8fd737a208ee2472db8a9feead4d8c0e0d86a0771cb515bf62", kill_on_drop: false }`
[INFO] [stdout] f289d06c1cddbb8fd737a208ee2472db8a9feead4d8c0e0d86a0771cb515bf62
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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" "+caccb4d0368bd918ef6668af8e13834d07040417" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] f867e66f16d9305c97abeb40152c259516f21326b62bd0e1d90e8a2de3a84d30
[INFO] running `Command { std: "docker" "start" "-a" "f867e66f16d9305c97abeb40152c259516f21326b62bd0e1d90e8a2de3a84d30", kill_on_drop: false }`
[INFO] [stderr] warning: use of deprecated method `Pair::<T>::fold`: Use into_iter().fold(init, f) instead
[INFO] [stderr]    --> src/lib.rs:822:33
[INFO] [stderr]     |
[INFO] [stderr] 822 |         let f = Pair::new(2, 3).fold(1, |acc, cur| acc * cur);
[INFO] [stderr]     |                                 ^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(deprecated)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `pair_macro` (lib test) generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.07s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/pair_macro-fe7ecb123337512e)
[INFO] [stdout] 
[INFO] [stdout] running 31 tests
[INFO] [stdout] test tests::map_entrywise ... ok
[INFO] [stdout] test tests::test_add ... ok
[INFO] [stdout] test tests::test_add_assign ... ok
[INFO] [stdout] test tests::test_as_deref ... ok
[INFO] [stdout] test tests::test_as_deref_mut ... ok
[INFO] [stdout] test tests::test_as_ref ... ok
[INFO] [stdout] test tests::test_cloned ... ok
[INFO] [stdout] test tests::test_as_mut ... ok
[INFO] [stdout] test tests::test_copied_mut ... ok
[INFO] [stdout] test tests::test_div ... ok
[INFO] [stdout] test tests::test_fold ... ok
[INFO] [stdout] test tests::test_from_cloned ... ok
[INFO] [stdout] test tests::test_into_option ... ok
[INFO] [stdout] test tests::test_iter ... ok
[INFO] [stdout] test tests::test_div_assign ... ok
[INFO] [stdout] test tests::test_iter_mut ... ok
[INFO] [stdout] test tests::test_map ... ok
[INFO] [stdout] test tests::test_map_in_place ... ok
[INFO] [stdout] test tests::test_into_iter ... ok
[INFO] [stdout] test tests::test_into_result ... ok
[INFO] [stdout] test tests::test_mul ... ok
[INFO] [stdout] test tests::test_mul_assign ... ok
[INFO] [stdout] test tests::test_neg ... ok
[INFO] [stdout] test tests::test_map_entrywise_in_place ... ok
[INFO] [stdout] test tests::test_new ... ok
[INFO] [stdout] test tests::test_rem_assign ... ok
[INFO] [stdout] test tests::test_sub ... ok
[INFO] [stdout] test tests::test_cloned_mut ... ok
[INFO] [stdout] test tests::test_sub_assign ... ok
[INFO] [stderr]      Running tests/create_pair.rs (/opt/rustwide/target/debug/deps/create_pair-284ec1f97064b08d)
[INFO] [stdout] test tests::test_rem ... ok
[INFO] [stdout] test tests::test_copied ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_use_my_own_pair ... ok
[INFO] [stdout] test test_use_my_own_pair_with_comment ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests pair_macro
[INFO] [stdout] 
[INFO] [stdout] running 46 tests
[INFO] [stdout] test src/lib.rs - (line 21) ... ok
[INFO] [stdout] test src/lib.rs - (line 59) ... ok
[INFO] [stdout] test src/lib.rs - Pair<&'_T>::cloned (line 737) ... ok
[INFO] [stdout] test src/lib.rs - (line 7) ... ok
[INFO] [stdout] test src/lib.rs - Pair<&'_T>::copied (line 737) ... ok
[INFO] [stdout] test src/lib.rs - Pair<&'_mutT>::copied (line 737) ... ok
[INFO] [stdout] test src/lib.rs - Pair<&'_mutT>::cloned (line 737) ... ok
[INFO] [stdout] test src/lib.rs - (line 38) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::as_deref_mut (line 740) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::as_deref (line 740) ... ok
[INFO] [stdout] test src/lib.rs - Pair<Option<T>>::into_option (line 738) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::as_ref (line 736) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::as_mut (line 736) ... ok
[INFO] [stdout] test src/lib.rs - Pair<Result<T,E>>::into_result (line 739) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::fold (line 740) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::into_iter (line 737) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::from_cloned (line 736) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::iter (line 737) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::map_entrywise_in_place (line 740) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::map_entrywise (line 736) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::map (line 736) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::map_in_place (line 740) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<&'_T>::cloned (line 743) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::iter_mut (line 737) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::new (line 736) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<&'_mutT>::cloned (line 743) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::as_deref (line 746) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<&'_T>::copied (line 743) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<Option<T>>::into_option (line 744) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<&'_mutT>::copied (line 743) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::as_deref_mut (line 746) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::as_mut (line 742) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::from_cloned (line 742) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::into_iter (line 743) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::as_ref (line 742) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<Result<T,E>>::into_result (line 745) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::fold (line 746) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::map (line 742) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::new (line 742) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::map_entrywise (line 742) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::map_in_place (line 746) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::iter (line 743) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::map_entrywise_in_place (line 746) ... ok
[INFO] [stdout] test src/lib.rs - create_pair (line 106) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::iter_mut (line 743) ... ok
[INFO] [stdout] test src/lib.rs - create_pair (line 120) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 46 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.37s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "f867e66f16d9305c97abeb40152c259516f21326b62bd0e1d90e8a2de3a84d30", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f867e66f16d9305c97abeb40152c259516f21326b62bd0e1d90e8a2de3a84d30", kill_on_drop: false }`
[INFO] [stdout] f867e66f16d9305c97abeb40152c259516f21326b62bd0e1d90e8a2de3a84d30