[INFO] fetching crate permutation 0.4.0...
[INFO] testing permutation-0.4.0 against beta-2022-02-22 for beta-1.60-1
[INFO] extracting crate permutation 0.4.0 into /workspace/builds/worker-30/source
[INFO] validating manifest of crates.io crate permutation 0.4.0 on toolchain beta-2022-02-22
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate permutation 0.4.0
[INFO] finished tweaking crates.io crate permutation 0.4.0
[INFO] tweaked toml for crates.io crate permutation 0.4.0 written to /workspace/builds/worker-30/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "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-2022-02-22" "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-30/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-30/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 2790a780a976ad414da0b08b227299788bab7447bf913e5bcdc28ff7ade4647b
[INFO] running `Command { std: "docker" "start" "-a" "2790a780a976ad414da0b08b227299788bab7447bf913e5bcdc28ff7ade4647b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2790a780a976ad414da0b08b227299788bab7447bf913e5bcdc28ff7ade4647b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2790a780a976ad414da0b08b227299788bab7447bf913e5bcdc28ff7ade4647b", kill_on_drop: false }`
[INFO] [stdout] 2790a780a976ad414da0b08b227299788bab7447bf913e5bcdc28ff7ade4647b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-30/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-30/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 31a51f726714475ee4a7e4aa23e39b9d1f692b3ad89a529621fcd38fbadd3e8b
[INFO] running `Command { std: "docker" "start" "-a" "31a51f726714475ee4a7e4aa23e39b9d1f692b3ad89a529621fcd38fbadd3e8b", kill_on_drop: false }`
[INFO] [stderr]    Compiling permutation v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.42s
[INFO] running `Command { std: "docker" "inspect" "31a51f726714475ee4a7e4aa23e39b9d1f692b3ad89a529621fcd38fbadd3e8b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "31a51f726714475ee4a7e4aa23e39b9d1f692b3ad89a529621fcd38fbadd3e8b", kill_on_drop: false }`
[INFO] [stdout] 31a51f726714475ee4a7e4aa23e39b9d1f692b3ad89a529621fcd38fbadd3e8b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-30/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-30/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1053106f9e6b2ae69c35b8beb0103986d494000a8c79d5269a17ce004ffbc64f
[INFO] running `Command { std: "docker" "start" "-a" "1053106f9e6b2ae69c35b8beb0103986d494000a8c79d5269a17ce004ffbc64f", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling permutation v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.43s
[INFO] running `Command { std: "docker" "inspect" "1053106f9e6b2ae69c35b8beb0103986d494000a8c79d5269a17ce004ffbc64f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1053106f9e6b2ae69c35b8beb0103986d494000a8c79d5269a17ce004ffbc64f", kill_on_drop: false }`
[INFO] [stdout] 1053106f9e6b2ae69c35b8beb0103986d494000a8c79d5269a17ce004ffbc64f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-30/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-30/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 77e9813895294697302c9df2ebc5e42888192b27fb174c4dd61fb632cc3abf53
[INFO] running `Command { std: "docker" "start" "-a" "77e9813895294697302c9df2ebc5e42888192b27fb174c4dd61fb632cc3abf53", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.20s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/permutation-51ad72a91a4e22f2)
[INFO] [stdout] 
[INFO] [stdout] running 26 tests
[INFO] [stdout] test permutation::tests::apply_array ... ok
[INFO] [stdout] test permutation::tests::apply_inv_norm_in_place ... ok
[INFO] [stdout] test permutation::tests::apply_inv_unnorm_place ... ok
[INFO] [stdout] test permutation::tests::apply_norm_in_place ... ok
[INFO] [stdout] test permutation::tests::apply_slice_in_place_vec ... ok
[INFO] [stdout] test permutation::tests::apply_unnorm_in_place ... ok
[INFO] [stdout] test permutation::tests::basics ... ok
[INFO] [stdout] test permutation::tests::by_cmp ... ok
[INFO] [stdout] test permutation::tests::by_key ... ok
[INFO] [stdout] test permutation::tests::by_partially_ordered_cmp ... ok
[INFO] [stdout] test permutation::tests::from_vec_oneline ... ok
[INFO] [stdout] test permutation::tests::indices ... ok
[INFO] [stdout] test permutation::tests::inverse ... ok
[INFO] [stdout] test permutation::tests::len ... ok
[INFO] [stdout] test permutation::tests::normalize ... ok
[INFO] [stdout] test permutation::tests::normalize_inv ... ok
[INFO] [stdout] test permutation::tests::oneline ... ok
[INFO] [stdout] test permutation::tests::oneline_array ... ok
[INFO] [stdout] test permutation::tests::oneline_slice ... ok
[INFO] [stdout] test permutation::tests::powers ... ok
[INFO] [stdout] test permutation::tests::prod ... ok
[INFO] [stdout] test permutation::tests::sort_array ... ok
[INFO] [stdout] test permutation::tests::sort_array_ref ... ok
[INFO] [stdout] test permutation::tests::sort_slice ... ok
[INFO] [stdout] test permutation::tests::sort_vec ... ok
[INFO] [stdout] test permutation::tests::strings ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests permutation
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::normalize (line 297) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::len (line 245) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::inverse (line 271) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::apply_idx (line 332) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::apply_inv_idx (line 355) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::apply_inv_slice_in_place (line 580) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::&'aPermutation::mul (line 34) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::apply_inv_slice (line 511) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::one (line 228) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::apply_slice_in_place (line 545) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::oneline (line 93) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::apply_slice (line 485) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::from_vec (line 62) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::sort (line 604) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::sort_by (line 650) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::sort_by_key (line 677) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::assign_from_sort_by_key (line 200) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::assign_from_sort_by (line 166) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::sort (line 615) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::assign_from_sort (line 123) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.46s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "77e9813895294697302c9df2ebc5e42888192b27fb174c4dd61fb632cc3abf53", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "77e9813895294697302c9df2ebc5e42888192b27fb174c4dd61fb632cc3abf53", kill_on_drop: false }`
[INFO] [stdout] 77e9813895294697302c9df2ebc5e42888192b27fb174c4dd61fb632cc3abf53