[INFO] fetching crate permutation 0.4.0...
[INFO] testing permutation-0.4.0 against 1.59.0 for beta-1.60-1
[INFO] extracting crate permutation 0.4.0 into /workspace/builds/worker-0/source
[INFO] validating manifest of crates.io crate permutation 0.4.0 on toolchain 1.59.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "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-0/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "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" "+1.59.0" "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/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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" "+1.59.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 73629aea7cf30c006382eb1cd2f89d8cb0290740eca0430a8f8c0f1acae930cb
[INFO] running `Command { std: "docker" "start" "-a" "73629aea7cf30c006382eb1cd2f89d8cb0290740eca0430a8f8c0f1acae930cb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "73629aea7cf30c006382eb1cd2f89d8cb0290740eca0430a8f8c0f1acae930cb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "73629aea7cf30c006382eb1cd2f89d8cb0290740eca0430a8f8c0f1acae930cb", kill_on_drop: false }`
[INFO] [stdout] 73629aea7cf30c006382eb1cd2f89d8cb0290740eca0430a8f8c0f1acae930cb
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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" "+1.59.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d19bb11dc460c998987c5399476c6550b5236c8c8dff0ba6e63395eb35b9430b
[INFO] running `Command { std: "docker" "start" "-a" "d19bb11dc460c998987c5399476c6550b5236c8c8dff0ba6e63395eb35b9430b", kill_on_drop: false }`
[INFO] [stderr]    Compiling permutation v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.15s
[INFO] running `Command { std: "docker" "inspect" "d19bb11dc460c998987c5399476c6550b5236c8c8dff0ba6e63395eb35b9430b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d19bb11dc460c998987c5399476c6550b5236c8c8dff0ba6e63395eb35b9430b", kill_on_drop: false }`
[INFO] [stdout] d19bb11dc460c998987c5399476c6550b5236c8c8dff0ba6e63395eb35b9430b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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" "+1.59.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 59ca411a085b109d086ad7dfb55bd0197ce96fed24149a677e43cc2292aac183
[INFO] running `Command { std: "docker" "start" "-a" "59ca411a085b109d086ad7dfb55bd0197ce96fed24149a677e43cc2292aac183", 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.11s
[INFO] running `Command { std: "docker" "inspect" "59ca411a085b109d086ad7dfb55bd0197ce96fed24149a677e43cc2292aac183", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "59ca411a085b109d086ad7dfb55bd0197ce96fed24149a677e43cc2292aac183", kill_on_drop: false }`
[INFO] [stdout] 59ca411a085b109d086ad7dfb55bd0197ce96fed24149a677e43cc2292aac183
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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" "+1.59.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 82da9049fbe5a3c486bbd2c66e6a776558ac50671491c57b0cb6ecf8a6c0f920
[INFO] running `Command { std: "docker" "start" "-a" "82da9049fbe5a3c486bbd2c66e6a776558ac50671491c57b0cb6ecf8a6c0f920", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.10s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/permutation-61467704b038e422)
[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::basics ... ok
[INFO] [stdout] test permutation::tests::apply_unnorm_in_place ... 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::len ... ok
[INFO] [stdout] test permutation::tests::inverse ... 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_slice ... ok
[INFO] [stdout] test permutation::tests::oneline_array ... 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.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests permutation
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::len (line 245) ... 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::normalize (line 297) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::&'aPermutation::mul (line 34) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::apply_inv_slice_in_place (line 580) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::inverse (line 271) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::one (line 228) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::apply_inv_slice (line 511) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::Permutation::apply_slice (line 485) ... 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::from_vec (line 62) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::sort_by_key (line 677) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::sort_by (line 650) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::sort (line 604) ... ok
[INFO] [stdout] test src/permutation.rs - permutation::sort (line 615) ... 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::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.38s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "82da9049fbe5a3c486bbd2c66e6a776558ac50671491c57b0cb6ecf8a6c0f920", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "82da9049fbe5a3c486bbd2c66e6a776558ac50671491c57b0cb6ecf8a6c0f920", kill_on_drop: false }`
[INFO] [stdout] 82da9049fbe5a3c486bbd2c66e6a776558ac50671491c57b0cb6ecf8a6c0f920