[INFO] fetching crate etterna 0.1.0...
[INFO] testing etterna-0.1.0 against master#62efba8a050c64249dab942951bb28f710208bc8 for pr-90799
[INFO] extracting crate etterna 0.1.0 into /workspace/builds/worker-84/source
[INFO] validating manifest of crates.io crate etterna 0.1.0 on toolchain 62efba8a050c64249dab942951bb28f710208bc8
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate etterna 0.1.0
[INFO] finished tweaking crates.io crate etterna 0.1.0
[INFO] tweaked toml for crates.io crate etterna 0.1.0 written to /workspace/builds/worker-84/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "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" "+62efba8a050c64249dab942951bb28f710208bc8" "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-84/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 61f436123d042b01053e0110a538c4b17017bfafbd983558ce9cb473d52bb4ac
[INFO] running `Command { std: "docker" "start" "-a" "61f436123d042b01053e0110a538c4b17017bfafbd983558ce9cb473d52bb4ac", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "61f436123d042b01053e0110a538c4b17017bfafbd983558ce9cb473d52bb4ac", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "61f436123d042b01053e0110a538c4b17017bfafbd983558ce9cb473d52bb4ac", kill_on_drop: false }`
[INFO] [stdout] 61f436123d042b01053e0110a538c4b17017bfafbd983558ce9cb473d52bb4ac
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2b63debaed0aaf1e9f729d13c242a7f4175c0536d1ad8748f93f48a48fdcd3a2
[INFO] running `Command { std: "docker" "start" "-a" "2b63debaed0aaf1e9f729d13c242a7f4175c0536d1ad8748f93f48a48fdcd3a2", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling syn v1.0.82
[INFO] [stderr]    Compiling memchr v2.4.1
[INFO] [stderr]    Compiling lexical-core v0.7.6
[INFO] [stderr]    Compiling libm v0.2.1
[INFO] [stderr]    Compiling unchecked-index v0.2.2
[INFO] [stderr]    Compiling either v1.6.1
[INFO] [stderr]    Compiling permutation v0.2.5
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling quote v1.0.10
[INFO] [stderr]    Compiling itertools v0.9.0
[INFO] [stderr]    Compiling btoi v0.4.2
[INFO] [stderr]    Compiling twoway v0.2.2
[INFO] [stderr]    Compiling thiserror-impl v1.0.30
[INFO] [stderr]    Compiling thiserror v1.0.30
[INFO] [stderr]    Compiling etterna v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 24.22s
[INFO] running `Command { std: "docker" "inspect" "2b63debaed0aaf1e9f729d13c242a7f4175c0536d1ad8748f93f48a48fdcd3a2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2b63debaed0aaf1e9f729d13c242a7f4175c0536d1ad8748f93f48a48fdcd3a2", kill_on_drop: false }`
[INFO] [stdout] 2b63debaed0aaf1e9f729d13c242a7f4175c0536d1ad8748f93f48a48fdcd3a2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] dab09dadb67c37539e6bac2edc745658b87c690dedcb2bad13233baebd639968
[INFO] running `Command { std: "docker" "start" "-a" "dab09dadb67c37539e6bac2edc745658b87c690dedcb2bad13233baebd639968", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling etterna v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.51s
[INFO] running `Command { std: "docker" "inspect" "dab09dadb67c37539e6bac2edc745658b87c690dedcb2bad13233baebd639968", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dab09dadb67c37539e6bac2edc745658b87c690dedcb2bad13233baebd639968", kill_on_drop: false }`
[INFO] [stdout] dab09dadb67c37539e6bac2edc745658b87c690dedcb2bad13233baebd639968
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 35749d1d59ffe7c0363ed58c785cc4f68b08a8f421b2efcf466e2c269aa47465
[INFO] running `Command { std: "docker" "start" "-a" "35749d1d59ffe7c0363ed58c785cc4f68b08a8f421b2efcf466e2c269aa47465", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/etterna-593e396a5045d196)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stderr]    Doc-tests etterna
[INFO] [stdout] test note_subsets::tests::test_find_fastest_note_subset ... ok
[INFO] [stdout] test rating_calc::tests::test_everything ... ok
[INFO] [stdout] test rescore::tests::test_scoring_systems ... ok
[INFO] [stdout] test util::tests::test_extract_str_and_bstr ... ok
[INFO] [stdout] test util::tests::test_is_ascii_whitespace ... ok
[INFO] [stdout] test util::tests::test_is_equal_no_order_no_duplicates ... ok
[INFO] [stdout] test util::tests::test_first_and_last_and_count ... ok
[INFO] [stdout] test util::tests::test_mean ... ok
[INFO] [stdout] test util::tests::test_is_sorted ... ok
[INFO] [stdout] test util::tests::test_split_newlines ... ok
[INFO] [stdout] test util::tests::test_trim_bstr ... ok
[INFO] [stdout] test wife::tests::test_wife ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test src/lib.rs - SkillTimeline<T>::calculate (line 137) ... ignored
[INFO] [stdout] test src/structs.rs - structs::SimpleReplay::longest_combo (line 331) ... ignored
[INFO] [stdout] test src/skillsets.rs - skillsets::Skillset7::list (line 204) - compile ... ok
[INFO] [stdout] test src/skillsets.rs - skillsets::Skillset8::list (line 304) - compile ... ok
[INFO] [stdout] test src/skillsets.rs - skillsets::Skillset7::iter (line 227) - compile ... ok
[INFO] [stdout] test src/skillsets.rs - skillsets::Skillset8::iter (line 328) - compile ... ok
[INFO] [stdout] test src/structs.rs - structs::Hit::was_missed (line 487) ... ok
[INFO] [stdout] test src/skillsets.rs - skillsets::Skillset8::into_skillset7 (line 341) ... ok
[INFO] [stdout] test src/rate.rs - rate::Rate::as_f32 (line 49) ... ok
[INFO] [stdout] test src/structs.rs - structs::NoteRow::width (line 528) ... ok
[INFO] [stdout] test src/skillsets.rs - skillsets::Skillset8::from_user_input (line 279) ... ok
[INFO] [stdout] test src/skillsets.rs - skillsets::Skillset7::into_skillset8 (line 240) ... ok
[INFO] [stdout] test src/rate.rs - rate::Rate::as_x20 (line 60) ... ok
[INFO] [stdout] test src/structs.rs - structs::Hit::is_considered_miss (line 469) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out; finished in 1.60s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "35749d1d59ffe7c0363ed58c785cc4f68b08a8f421b2efcf466e2c269aa47465", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "35749d1d59ffe7c0363ed58c785cc4f68b08a8f421b2efcf466e2c269aa47465", kill_on_drop: false }`
[INFO] [stdout] 35749d1d59ffe7c0363ed58c785cc4f68b08a8f421b2efcf466e2c269aa47465