[INFO] cloning repository https://github.com/aeubanks/itgrate [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/aeubanks/itgrate" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Faeubanks%2Fitgrate", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Faeubanks%2Fitgrate'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 9b36ec2cfe96eebe938f2d29e7701b62087d857b [INFO] testing aeubanks/itgrate against beta-2022-04-10 for beta-1.61-1 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Faeubanks%2Fitgrate" "/workspace/builds/worker-55/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-55/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/aeubanks/itgrate on toolchain beta-2022-04-10 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/aeubanks/itgrate [INFO] finished tweaking git repo https://github.com/aeubanks/itgrate [INFO] tweaked toml for git repo https://github.com/aeubanks/itgrate written to /workspace/builds/worker-55/source/Cargo.toml [INFO] crate git repo https://github.com/aeubanks/itgrate already has a lockfile, it will not be regenerated [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "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-55/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] f480969bc0eced5092a2f4938ac5417e96a80ee60ca03e2632dac39a91ca82c5 [INFO] running `Command { std: "docker" "start" "-a" "f480969bc0eced5092a2f4938ac5417e96a80ee60ca03e2632dac39a91ca82c5", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "f480969bc0eced5092a2f4938ac5417e96a80ee60ca03e2632dac39a91ca82c5", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "f480969bc0eced5092a2f4938ac5417e96a80ee60ca03e2632dac39a91ca82c5", kill_on_drop: false }` [INFO] [stdout] f480969bc0eced5092a2f4938ac5417e96a80ee60ca03e2632dac39a91ca82c5 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] e37b07c717db83696176e2fb417ba4193880717722df90e1c725157ec290f817 [INFO] running `Command { std: "docker" "start" "-a" "e37b07c717db83696176e2fb417ba4193880717722df90e1c725157ec290f817", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling libc v0.2.79 [INFO] [stderr] Compiling maybe-uninit v2.0.0 [INFO] [stderr] Compiling getrandom v0.1.15 [INFO] [stderr] Compiling syn v1.0.42 [INFO] [stderr] Compiling rayon-core v1.8.1 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling ppv-lite86 v0.2.9 [INFO] [stderr] Compiling byteorder v1.3.4 [INFO] [stderr] Compiling either v1.6.1 [INFO] [stderr] Compiling fixedbitset v0.2.0 [INFO] [stderr] Compiling strsim v0.8.0 [INFO] [stderr] Compiling anyhow v1.0.33 [INFO] [stderr] Compiling ansi_term v0.11.0 [INFO] [stderr] Compiling regex-syntax v0.6.18 [INFO] [stderr] Compiling historian v4.0.3 [INFO] [stderr] Compiling crossbeam-utils v0.7.2 [INFO] [stderr] Compiling memoffset v0.5.6 [INFO] [stderr] Compiling crossbeam-epoch v0.8.2 [INFO] [stderr] Compiling rayon v1.4.1 [INFO] [stderr] Compiling num-traits v0.2.12 [INFO] [stderr] Compiling textwrap v0.11.0 [INFO] [stderr] Compiling aho-corasick v0.7.13 [INFO] [stderr] Compiling petgraph v0.5.1 [INFO] [stderr] Compiling gnuplot v0.0.37 [INFO] [stderr] Compiling daggy v0.7.0 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling clap v2.33.3 [INFO] [stderr] Compiling rand_core v0.5.1 [INFO] [stderr] Compiling rand_pcg v0.2.1 [INFO] [stderr] Compiling rand_chacha v0.2.2 [INFO] [stderr] Compiling crossbeam-channel v0.4.4 [INFO] [stderr] Compiling rand v0.7.3 [INFO] [stderr] Compiling noisy_float v0.1.13 [INFO] [stderr] Compiling regex v1.3.9 [INFO] [stderr] Compiling crossbeam-deque v0.7.3 [INFO] [stderr] Compiling proc-macro-error v1.0.4 [INFO] [stderr] Compiling structopt-derive v0.4.12 [INFO] [stderr] Compiling oxigen v2.1.0 [INFO] [stderr] Compiling structopt v0.3.19 [INFO] [stderr] Compiling itgrate v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 23.33s [INFO] running `Command { std: "docker" "inspect" "e37b07c717db83696176e2fb417ba4193880717722df90e1c725157ec290f817", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e37b07c717db83696176e2fb417ba4193880717722df90e1c725157ec290f817", kill_on_drop: false }` [INFO] [stdout] e37b07c717db83696176e2fb417ba4193880717722df90e1c725157ec290f817 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 7eac0a717b723dad68f55edc655d5b91e382e531dd1c523da60bde74fbcfeb01 [INFO] running `Command { std: "docker" "start" "-a" "7eac0a717b723dad68f55edc655d5b91e382e531dd1c523da60bde74fbcfeb01", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling serde v1.0.116 [INFO] [stderr] Compiling semver-parser v0.7.0 [INFO] [stderr] Compiling ryu v1.0.5 [INFO] [stderr] Compiling itoa v0.4.6 [INFO] [stderr] Compiling serde_json v1.0.58 [INFO] [stderr] Compiling serde_derive v1.0.116 [INFO] [stderr] Compiling half v1.6.0 [INFO] [stderr] Compiling oorandom v11.1.2 [INFO] [stderr] Compiling itertools v0.9.0 [INFO] [stderr] Compiling regex-automata v0.1.9 [INFO] [stderr] Compiling csv-core v0.1.10 [INFO] [stderr] Compiling plotters v0.2.15 [INFO] [stderr] Compiling semver v0.9.0 [INFO] [stderr] Compiling rustc_version v0.2.3 [INFO] [stderr] Compiling cast v0.2.3 [INFO] [stderr] Compiling criterion-plot v0.4.3 [INFO] [stderr] Compiling bstr v0.2.13 [INFO] [stderr] Compiling serde_cbor v0.11.1 [INFO] [stderr] Compiling csv v1.1.3 [INFO] [stderr] Compiling tinytemplate v1.1.0 [INFO] [stderr] Compiling criterion v0.3.3 [INFO] [stderr] Compiling itgrate v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 1m 01s [INFO] [stderr] Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/itgrate-5281b023e1e97938) [INFO] [stderr] Executable tests/basic.rs (/opt/rustwide/target/debug/deps/basic-61f2992ed64acc0b) [INFO] [stderr] Executable tests/chart_comparisons.rs (/opt/rustwide/target/debug/deps/chart_comparisons-865975bf53144b28) [INFO] [stderr] Executable tests/common.rs (/opt/rustwide/target/debug/deps/common-02c9853636a42a5e) [INFO] running `Command { std: "docker" "inspect" "7eac0a717b723dad68f55edc655d5b91e382e531dd1c523da60bde74fbcfeb01", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "7eac0a717b723dad68f55edc655d5b91e382e531dd1c523da60bde74fbcfeb01", kill_on_drop: false }` [INFO] [stdout] 7eac0a717b723dad68f55edc655d5b91e382e531dd1c523da60bde74fbcfeb01 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 8f56fb142bb6f515589efef09c67ab1cee621df0ad74d24cbd3e8d32f878152b [INFO] running `Command { std: "docker" "start" "-a" "8f56fb142bb6f515589efef09c67ab1cee621df0ad74d24cbd3e8d32f878152b", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 13.24s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/itgrate-5281b023e1e97938) [INFO] [stdout] [INFO] [stdout] running 13 tests [INFO] [stdout] test note::test_pos_distance ... ok [INFO] [stdout] test note_pos::test_col_to_pos ... ok [INFO] [stdout] test rate::test_get_ancestor ... ok [INFO] [stdout] test smparser::test_bpm_measure_to_time ... ok [INFO] [stdout] test smparser::test_parse_sm ... ok [INFO] [stdout] test smparser::test_lines ... ok [INFO] [stdout] test rate::test_find_best_nodes ... ok [INFO] [stdout] test rate::test_create_descendents ... ok [INFO] [stdout] test rate::state::test_state_step ... ok [INFO] [stdout] test rate::test_remove_all_descendents ... ok [INFO] [stdout] test rate::test_descendents ... ok [INFO] [stdout] test smparser::test_full_name ... ok [INFO] [stdout] Generation Solutions Last progress Progress avg Progress std Progress max Progress min Progress p10 Progress p25 Progress median Progress p75 Progress p90 Fitness avg Fitness std Fitness max Fitness min Fitness p10 Fitness p25 Fitness median Fitness p75 Fitness p90 [INFO] [stdout] 1 0 -1.393081784248352 -1.393081784248352 NaN -1.393081784248352 -1.393081784248352 1.3869108535242765 1.3869108535242765 1.3869108535242765 1.3869108535242765 1.3869108535242765 -1.4385731630027294 0.0029725559050316278 -1.393081784248352 -1.447412133216858 1.4108997064172097 1.4351296512898744 1.4351296512898744 1.4351296512898744 1.4351296512898744 [INFO] [stdout] 2 0 0 -0.696540892124176 0.9850575763894647 0 -1.393081784248352 0 0 0 1.3869108535242765 1.3869108535242765 -1.4278142005205154 0.004116360540537383 -1.393081784248352 -1.4568724632263184 1.3869108535242765 1.4108997064172097 1.4351296512898744 1.4351296512898744 1.4351296512898744 [INFO] [stdout] test optimize::sanity ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.63s [INFO] [stdout] [INFO] [stderr] Running tests/basic.rs (/opt/rustwide/target/debug/deps/basic-61f2992ed64acc0b) [INFO] [stdout] [INFO] [stdout] running 8 tests [INFO] [stdout] test common::test_create_notes ... ok [INFO] [stdout] test empty ... ok [INFO] [stdout] test more_is_harder ... ok [INFO] [stdout] test rating_at_notes_same_len_as_notes ... ok [INFO] [stdout] test one_note_after_break_doesnt_affect_difficulty ... ok [INFO] [stdout] test fatigue_keeps_increasing_in_unbroken_stream ... ok [INFO] [stdout] test faster_is_harder ... ok [INFO] [stdout] test farther_is_harder ... ok [INFO] [stderr] Running tests/chart_comparisons.rs (/opt/rustwide/target/debug/deps/chart_comparisons-865975bf53144b28) [INFO] [stdout] [INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.39s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test two_measures_of_240_is_harder_than_eight_measures_of_120 ... ignored, currently failing? [INFO] [stdout] test common::test_create_notes ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/common.rs (/opt/rustwide/target/debug/deps/common-02c9853636a42a5e) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test test_create_notes ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Doc-tests itgrate [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "8f56fb142bb6f515589efef09c67ab1cee621df0ad74d24cbd3e8d32f878152b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8f56fb142bb6f515589efef09c67ab1cee621df0ad74d24cbd3e8d32f878152b", kill_on_drop: false }` [INFO] [stdout] 8f56fb142bb6f515589efef09c67ab1cee621df0ad74d24cbd3e8d32f878152b