[INFO] fetching crate pair_macro 0.1.4...
[INFO] testing pair_macro-0.1.4 against beta-2021-09-08 for beta-1.56-1
[INFO] extracting crate pair_macro 0.1.4 into /workspace/builds/worker-47/source
[INFO] validating manifest of crates.io crate pair_macro 0.1.4 on toolchain beta-2021-09-08
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[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-47/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "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" "+beta-2021-09-08" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-47/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-47/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] b84e6d0f4fb4e13d7d2e7c37da6122b045fbc5ba094c905a80b0db7bd8936ffa
[INFO] running `Command { std: "docker" "start" "-a" "b84e6d0f4fb4e13d7d2e7c37da6122b045fbc5ba094c905a80b0db7bd8936ffa", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b84e6d0f4fb4e13d7d2e7c37da6122b045fbc5ba094c905a80b0db7bd8936ffa", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b84e6d0f4fb4e13d7d2e7c37da6122b045fbc5ba094c905a80b0db7bd8936ffa", kill_on_drop: false }`
[INFO] [stdout] b84e6d0f4fb4e13d7d2e7c37da6122b045fbc5ba094c905a80b0db7bd8936ffa
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-47/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-47/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=warn" "-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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d9aa3f4c8e5fa4cd17ed875e545f17014815922f387b312dca17d80f3ec7f844
[INFO] running `Command { std: "docker" "start" "-a" "d9aa3f4c8e5fa4cd17ed875e545f17014815922f387b312dca17d80f3ec7f844", kill_on_drop: false }`
[INFO] [stderr]    Compiling pair_macro v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.40s
[INFO] running `Command { std: "docker" "inspect" "d9aa3f4c8e5fa4cd17ed875e545f17014815922f387b312dca17d80f3ec7f844", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d9aa3f4c8e5fa4cd17ed875e545f17014815922f387b312dca17d80f3ec7f844", kill_on_drop: false }`
[INFO] [stdout] d9aa3f4c8e5fa4cd17ed875e545f17014815922f387b312dca17d80f3ec7f844
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-47/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-47/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=warn" "-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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e2445cce08b719c867840dd051611a5bf588b4eb2677b9f1a05cc10591d2b6b0
[INFO] running `Command { std: "docker" "start" "-a" "e2445cce08b719c867840dd051611a5bf588b4eb2677b9f1a05cc10591d2b6b0", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde v1.0.130
[INFO] [stderr]    Compiling serde_json v1.0.67
[INFO] [stderr]    Compiling pair_macro v0.1.4 (/opt/rustwide/workdir)
[INFO] [stdout] warning: use of deprecated associated function `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] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 8.67s
[INFO] running `Command { std: "docker" "inspect" "e2445cce08b719c867840dd051611a5bf588b4eb2677b9f1a05cc10591d2b6b0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e2445cce08b719c867840dd051611a5bf588b4eb2677b9f1a05cc10591d2b6b0", kill_on_drop: false }`
[INFO] [stdout] e2445cce08b719c867840dd051611a5bf588b4eb2677b9f1a05cc10591d2b6b0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-47/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-47/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=warn" "-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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] f42521c3db3d38c4e3d82815065270e011fe4e66173c93521ff594c905b60159
[INFO] running `Command { std: "docker" "start" "-a" "f42521c3db3d38c4e3d82815065270e011fe4e66173c93521ff594c905b60159", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stdout] 
[INFO] [stderr] warning: use of deprecated associated function `Pair::<T>::fold`: Use into_iter().fold(init, f) instead
[INFO] [stdout] running 31 tests
[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 [unoptimized + debuginfo] target(s) in 0.64s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/pair_macro-6feb135f59962a47)
[INFO] [stdout] test tests::test_add ... ok
[INFO] [stderr]      Running tests/create_pair.rs (/opt/rustwide/target/debug/deps/create_pair-3be7425968966602)
[INFO] [stdout] test tests::test_as_deref_mut ... ok
[INFO] [stdout] test tests::test_as_mut ... ok
[INFO] [stdout] test tests::test_cloned ... ok
[INFO] [stdout] test tests::test_cloned_mut ... ok
[INFO] [stdout] test tests::test_map_entrywise_in_place ... ok
[INFO] [stdout] test tests::test_map_in_place ... ok
[INFO] [stdout] test tests::test_copied_mut ... ok
[INFO] [stdout] test tests::test_neg ... ok
[INFO] [stdout] test tests::test_new ... ok
[INFO] [stdout] test tests::test_fold ... ok
[INFO] [stdout] test tests::test_iter_mut ... ok
[INFO] [stdout] test tests::test_copied ... ok
[INFO] [stdout] test tests::test_div ... ok
[INFO] [stdout] test tests::test_into_iter ... ok
[INFO] [stdout] test tests::test_into_result ... ok
[INFO] [stdout] test tests::test_div_assign ... ok
[INFO] [stdout] test tests::test_map ... ok
[INFO] [stdout] test tests::test_as_ref ... ok
[INFO] [stdout] test tests::test_add_assign ... ok
[INFO] [stdout] test tests::test_from_cloned ... ok
[INFO] [stdout] test tests::test_iter ... ok
[INFO] [stdout] test tests::test_mul_assign ... ok
[INFO] [stdout] test tests::test_mul ... ok
[INFO] [stdout] test tests::test_into_option ... ok
[INFO] [stdout] test tests::test_rem_assign ... ok
[INFO] [stdout] test tests::test_rem ... ok
[INFO] [stdout] test tests::test_as_deref ... ok
[INFO] [stdout] test tests::map_entrywise ... ok
[INFO] [stdout] test tests::test_sub ... ok
[INFO] [stdout] test tests::test_sub_assign ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stderr]    Doc-tests pair_macro
[INFO] [stdout] test test_use_my_own_pair_with_comment ... ok
[INFO] [stdout] test test_use_my_own_pair ... 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] [stdout] 
[INFO] [stdout] running 46 tests
[INFO] [stdout] test src/lib.rs - (line 38) ... ok
[INFO] [stdout] test src/lib.rs - Pair<&'_ T>::cloned (line 737) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::as_deref_mut (line 740) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::fold (line 746) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::into_iter (line 743) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::as_deref (line 740) ... ok
[INFO] [stdout] test src/lib.rs - Pair<&'_ mut T>::cloned (line 737) ... ok
[INFO] [stdout] test src/lib.rs - Pair<&'_ T>::copied (line 737) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::map_in_place (line 740) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::as_deref_mut (line 746) ... ok
[INFO] [stdout] test src/lib.rs - Pair<&'_ mut T>::copied (line 737) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::as_deref (line 746) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::iter_mut (line 743) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::map_entrywise (line 736) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::as_mut (line 742) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::map_entrywise_in_place (line 746) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<&'_ T>::copied (line 743) ... ok
[INFO] [stdout] test src/lib.rs - Pair<Result<T, E>>::into_result (line 739) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::as_ref (line 736) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::as_ref (line 742) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::map_entrywise (line 742) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::new (line 736) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::new (line 742) ... ok
[INFO] [stdout] test src/lib.rs - (line 7) ... ok
[INFO] [stdout] test src/lib.rs - (line 21) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::fold (line 740) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::map_in_place (line 746) ... ok
[INFO] [stdout] test src/lib.rs - create_pair (line 120) ... ok
[INFO] [stdout] test src/lib.rs - (line 59) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::iter (line 737) ... ok
[INFO] [stdout] test src/lib.rs - Pair<Option<T>>::into_option (line 738) ... ok
[INFO] [stdout] test src/lib.rs - create_pair (line 106) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::from_cloned (line 742) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<&'_ T>::cloned (line 743) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<Option<T>>::into_option (line 744) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::from_cloned (line 736) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::as_mut (line 736) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::map (line 736) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::map (line 742) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::iter_mut (line 737) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<Result<T, E>>::into_result (line 745) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<T>::iter (line 743) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::map_entrywise_in_place (line 740) ... ok
[INFO] [stdout] test src/lib.rs - Pair<T>::into_iter (line 737) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<&'_ mut T>::copied (line 743) ... ok
[INFO] [stdout] test src/lib.rs - Triplet<&'_ mut T>::cloned (line 743) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 46 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.27s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "f42521c3db3d38c4e3d82815065270e011fe4e66173c93521ff594c905b60159", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f42521c3db3d38c4e3d82815065270e011fe4e66173c93521ff594c905b60159", kill_on_drop: false }`
[INFO] [stdout] f42521c3db3d38c4e3d82815065270e011fe4e66173c93521ff594c905b60159