[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 master#a77da2d454e6caa227a85b16410b95f93495e7e0 for pr-91031
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Faeubanks%2Fitgrate" "/workspace/builds/worker-1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-1/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/aeubanks/itgrate on toolchain a77da2d454e6caa227a85b16410b95f93495e7e0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "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-1/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" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 9a2d4f045b0d216ebd0550014f8cf47b54d50e7684f01586eef10aec46395b3e
[INFO] running `Command { std: "docker" "start" "-a" "9a2d4f045b0d216ebd0550014f8cf47b54d50e7684f01586eef10aec46395b3e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9a2d4f045b0d216ebd0550014f8cf47b54d50e7684f01586eef10aec46395b3e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9a2d4f045b0d216ebd0550014f8cf47b54d50e7684f01586eef10aec46395b3e", kill_on_drop: false }`
[INFO] [stdout] 9a2d4f045b0d216ebd0550014f8cf47b54d50e7684f01586eef10aec46395b3e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 0ce98e5c254924a1e90389ebb09fb1e31b3a0dbb34857d535a879c563747213f
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "0ce98e5c254924a1e90389ebb09fb1e31b3a0dbb34857d535a879c563747213f", kill_on_drop: false }`
[INFO] [stderr]    Compiling autocfg v1.0.1
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling maybe-uninit v2.0.0
[INFO] [stderr]    Compiling version_check v0.9.2
[INFO] [stderr]    Compiling unicode-xid v0.2.1
[INFO] [stderr]    Compiling getrandom v0.1.15
[INFO] [stderr]    Compiling syn v1.0.42
[INFO] [stderr]    Compiling scopeguard v1.1.0
[INFO] [stderr]    Compiling memchr v2.3.3
[INFO] [stderr]    Compiling ppv-lite86 v0.2.9
[INFO] [stderr]    Compiling unicode-width v0.1.8
[INFO] [stderr]    Compiling unicode-segmentation v1.6.0
[INFO] [stderr]    Compiling byteorder v1.3.4
[INFO] [stderr]    Compiling hashbrown v0.9.1
[INFO] [stderr]    Compiling vec_map v0.8.2
[INFO] [stderr]    Compiling either v1.6.1
[INFO] [stderr]    Compiling anyhow v1.0.33
[INFO] [stderr]    Compiling regex-syntax v0.6.18
[INFO] [stderr]    Compiling historian v4.0.3
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling thread_local v1.0.1
[INFO] [stderr]    Compiling proc-macro2 v1.0.24
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling clap v2.33.3
[INFO] [stderr]    Compiling heck v0.3.1
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling rand_core v0.5.1
[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 indexmap v1.6.0
[INFO] [stderr]    Compiling rayon v1.4.1
[INFO] [stderr]    Compiling num-traits v0.2.12
[INFO] [stderr]    Compiling aho-corasick v0.7.13
[INFO] [stderr]    Compiling quote v1.0.7
[INFO] [stderr]    Compiling rand_pcg v0.2.1
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling gnuplot v0.0.37
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling petgraph v0.5.1
[INFO] [stderr]    Compiling crossbeam-channel v0.4.4
[INFO] [stderr]    Compiling crossbeam-deque v0.7.3
[INFO] [stderr]    Compiling rayon-core v1.8.1
[INFO] [stderr]    Compiling noisy_float v0.1.13
[INFO] [stderr]    Compiling regex v1.3.9
[INFO] [stderr]    Compiling daggy v0.7.0
[INFO] [stderr]    Compiling oxigen v2.1.0
[INFO] [stderr]    Compiling structopt-derive v0.4.12
[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 1m 36s
[INFO] running `Command { std: "docker" "inspect" "0ce98e5c254924a1e90389ebb09fb1e31b3a0dbb34857d535a879c563747213f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0ce98e5c254924a1e90389ebb09fb1e31b3a0dbb34857d535a879c563747213f", kill_on_drop: false }`
[INFO] [stdout] 0ce98e5c254924a1e90389ebb09fb1e31b3a0dbb34857d535a879c563747213f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 2dddf9465b4a1ecaddf894755cb54969d619bf3634f2763076a619ee6c9db9a7
[INFO] running `Command { std: "docker" "start" "-a" "2dddf9465b4a1ecaddf894755cb54969d619bf3634f2763076a619ee6c9db9a7", kill_on_drop: false }`
[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 serde_json v1.0.58
[INFO] [stderr]    Compiling itoa v0.4.6
[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 13s
[INFO] running `Command { std: "docker" "inspect" "2dddf9465b4a1ecaddf894755cb54969d619bf3634f2763076a619ee6c9db9a7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2dddf9465b4a1ecaddf894755cb54969d619bf3634f2763076a619ee6c9db9a7", kill_on_drop: false }`
[INFO] [stdout] 2dddf9465b4a1ecaddf894755cb54969d619bf3634f2763076a619ee6c9db9a7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 2b15175d7eed8c3fc6321c1265b3abdf975bb2e31f7a31f35d85591e00d52340
[INFO] running `Command { std: "docker" "start" "-a" "2b15175d7eed8c3fc6321c1265b3abdf975bb2e31f7a31f35d85591e00d52340", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3m 13s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/itgrate-b2d3e1e1b98dbee8)
[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 smparser::test_bpm_measure_to_time ... ok
[INFO] [stdout] test rate::state::test_state_step ... ok
[INFO] [stdout] test rate::test_get_ancestor ... ok
[INFO] [stdout] test rate::test_find_best_nodes ... ok
[INFO] [stdout] test rate::test_descendents ... ok
[INFO] [stdout] test rate::test_remove_all_descendents ... ok
[INFO] [stdout] test rate::test_create_descendents ... 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] test smparser::test_lines ... ok
[INFO] [stdout] test smparser::test_parse_sm ... ok
[INFO] [stdout] test smparser::test_full_name ... ok
[INFO] [stdout] 1	0	-1.395466685295105	-1.395466685295105	NaN	-1.395466685295105	-1.395466685295105	1.3869108535242765	1.3869108535242765	1.3869108535242765	1.3869108535242765	1.3869108535242765	-1.4403416439890862	0.0027744100426626895	-1.395466685295105	-1.4490747451782227	1.4108997064172097	1.4351296512898744	1.4351296512898744	1.4351296512898744	1.4351296512898744
[INFO] [stdout] 2	0	0.033623456954956055	-0.6809216141700745	1.010519330511866	0.033623456954956055	-1.395466685295105	0.030454533953516938	0.030454533953516938	0.030454533953516938	1.3869108535242765	1.3869108535242765	-1.427701260894537	0.004351153983585641	-1.361843228340149	-1.450345754623413	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 0.04s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/basic.rs (/opt/rustwide/target/debug/deps/basic-c20b7a6fd3e264ea)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test empty ... ok
[INFO] [stdout] test common::test_create_notes ... ok
[INFO] [stdout] test more_is_harder ... ok
[INFO] [stdout] test fatigue_keeps_increasing_in_unbroken_stream ... 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 faster_is_harder ... ok
[INFO] [stdout] test farther_is_harder ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/chart_comparisons.rs (/opt/rustwide/target/debug/deps/chart_comparisons-331b70d2f5fd1095)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stderr]      Running tests/common.rs (/opt/rustwide/target/debug/deps/common-37345926e29345d6)
[INFO] [stdout] test two_measures_of_240_is_harder_than_eight_measures_of_120 ... ignored
[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] [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" "2b15175d7eed8c3fc6321c1265b3abdf975bb2e31f7a31f35d85591e00d52340", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2b15175d7eed8c3fc6321c1265b3abdf975bb2e31f7a31f35d85591e00d52340", kill_on_drop: false }`
[INFO] [stdout] 2b15175d7eed8c3fc6321c1265b3abdf975bb2e31f7a31f35d85591e00d52340