[INFO] cloning repository https://github.com/ahendriksen/n_longest_paths
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/ahendriksen/n_longest_paths" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fahendriksen%2Fn_longest_paths", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fahendriksen%2Fn_longest_paths'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 8ec12b8645db6616545b35ec0a757880a174d848
[INFO] testing ahendriksen/n_longest_paths against 1.55.0 for beta-1.56-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fahendriksen%2Fn_longest_paths" "/workspace/builds/worker-30/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-30/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/ahendriksen/n_longest_paths on toolchain 1.55.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.55.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/ahendriksen/n_longest_paths
[INFO] finished tweaking git repo https://github.com/ahendriksen/n_longest_paths
[INFO] tweaked toml for git repo https://github.com/ahendriksen/n_longest_paths written to /workspace/builds/worker-30/source/Cargo.toml
[INFO] crate git repo https://github.com/ahendriksen/n_longest_paths already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.55.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] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded pyo3-macros-backend v0.13.2
[INFO] [stderr]   Downloaded indoc v0.3.6
[INFO] [stderr]   Downloaded npy-derive v0.4.0
[INFO] [stderr]   Downloaded numpy v0.13.1
[INFO] [stderr]   Downloaded pyo3-macros v0.13.2
[INFO] [stderr]   Downloaded pyo3 v0.13.2
[INFO] [stderr]   Downloaded indoc-impl v0.3.6
[INFO] [stderr]   Downloaded npy v0.4.0
[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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] ee01ae1f4dddb06db4ba8fe3806aff90177517a9611d925009dbf1dfaf03d056
[INFO] running `Command { std: "docker" "start" "-a" "ee01ae1f4dddb06db4ba8fe3806aff90177517a9611d925009dbf1dfaf03d056", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ee01ae1f4dddb06db4ba8fe3806aff90177517a9611d925009dbf1dfaf03d056", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ee01ae1f4dddb06db4ba8fe3806aff90177517a9611d925009dbf1dfaf03d056", kill_on_drop: false }`
[INFO] [stdout] ee01ae1f4dddb06db4ba8fe3806aff90177517a9611d925009dbf1dfaf03d056
[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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2ea014af5f709dea0d081e68e43672325d611cc20f79acf2a7cf8fadcec86b2e
[INFO] running `Command { std: "docker" "start" "-a" "2ea014af5f709dea0d081e68e43672325d611cc20f79acf2a7cf8fadcec86b2e", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling syn v1.0.70
[INFO] [stderr]    Compiling libc v0.2.93
[INFO] [stderr]    Compiling unindent v0.1.7
[INFO] [stderr]    Compiling unicode-xid v0.1.0
[INFO] [stderr]    Compiling inventory v0.1.10
[INFO] [stderr]    Compiling pyo3 v0.13.2
[INFO] [stderr]    Compiling ndarray v0.14.0
[INFO] [stderr]    Compiling rawpointer v0.2.1
[INFO] [stderr]    Compiling vec_map v0.8.2
[INFO] [stderr]    Compiling strsim v0.8.0
[INFO] [stderr]    Compiling ansi_term v0.11.0
[INFO] [stderr]    Compiling proc-macro2 v1.0.26
[INFO] [stderr]    Compiling proc-macro-hack v0.5.19
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling crossbeam-utils v0.8.3
[INFO] [stderr]    Compiling num-integer v0.1.44
[INFO] [stderr]    Compiling lock_api v0.4.3
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling heck v0.3.2
[INFO] [stderr]    Compiling num-complex v0.3.1
[INFO] [stderr]    Compiling matrixmultiply v0.2.4
[INFO] [stderr]    Compiling proc-macro2 v0.2.3
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling quote v0.4.2
[INFO] [stderr]    Compiling syn v0.12.15
[INFO] [stderr]    Compiling parking_lot_core v0.8.3
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling memchr v1.0.2
[INFO] [stderr]    Compiling time v0.1.44
[INFO] [stderr]    Compiling clap v2.33.3
[INFO] [stderr]    Compiling nom v3.2.1
[INFO] [stderr]    Compiling paste-impl v0.1.18
[INFO] [stderr]    Compiling parking_lot v0.11.1
[INFO] [stderr]    Compiling crossbeam-channel v0.5.1
[INFO] [stderr]    Compiling paste v0.1.18
[INFO] [stderr]    Compiling pbr v1.0.4
[INFO] [stderr]    Compiling npy v0.4.0
[INFO] [stderr]    Compiling npy-derive v0.4.0
[INFO] [stderr]    Compiling pyo3-macros-backend v0.13.2
[INFO] [stderr]    Compiling ghost v0.1.2
[INFO] [stderr]    Compiling indoc-impl v0.3.6
[INFO] [stderr]    Compiling ctor v0.1.20
[INFO] [stderr]    Compiling inventory-impl v0.1.10
[INFO] [stderr]    Compiling pyo3-macros v0.13.2
[INFO] [stderr]    Compiling structopt-derive v0.4.14
[INFO] [stderr]    Compiling indoc v0.3.6
[INFO] [stderr]    Compiling structopt v0.3.21
[INFO] [stderr]    Compiling numpy v0.13.1
[INFO] [stderr]    Compiling n_longest_paths v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 22.89s
[INFO] running `Command { std: "docker" "inspect" "2ea014af5f709dea0d081e68e43672325d611cc20f79acf2a7cf8fadcec86b2e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2ea014af5f709dea0d081e68e43672325d611cc20f79acf2a7cf8fadcec86b2e", kill_on_drop: false }`
[INFO] [stdout] 2ea014af5f709dea0d081e68e43672325d611cc20f79acf2a7cf8fadcec86b2e
[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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 65acfdab2ff3374fce60c3cc427d1dfc71dc61f1bb82bebad599cdf632594070
[INFO] running `Command { std: "docker" "start" "-a" "65acfdab2ff3374fce60c3cc427d1dfc71dc61f1bb82bebad599cdf632594070", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde v1.0.125
[INFO] [stderr]    Compiling memchr v2.3.4
[INFO] [stderr]    Compiling plotters-backend v0.3.0
[INFO] [stderr]    Compiling serde_derive v1.0.125
[INFO] [stderr]    Compiling regex-syntax v0.6.23
[INFO] [stderr]    Compiling half v1.7.1
[INFO] [stderr]    Compiling oorandom v11.1.3
[INFO] [stderr]    Compiling regex-automata v0.1.9
[INFO] [stderr]    Compiling itertools v0.9.0
[INFO] [stderr]    Compiling itertools v0.10.0
[INFO] [stderr]    Compiling cast v0.2.5
[INFO] [stderr]    Compiling num_cpus v1.13.0
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.3
[INFO] [stderr]    Compiling plotters-svg v0.3.0
[INFO] [stderr]    Compiling crossbeam-deque v0.8.0
[INFO] [stderr]    Compiling plotters v0.3.0
[INFO] [stderr]    Compiling rayon-core v1.9.0
[INFO] [stderr]    Compiling csv-core v0.1.10
[INFO] [stderr]    Compiling criterion-plot v0.4.3
[INFO] [stderr]    Compiling rayon v1.5.0
[INFO] [stderr]    Compiling regex v1.4.6
[INFO] [stderr]    Compiling bstr v0.2.15
[INFO] [stderr]    Compiling serde_json v1.0.64
[INFO] [stderr]    Compiling serde_cbor v0.11.1
[INFO] [stderr]    Compiling csv v1.1.6
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling criterion v0.3.4
[INFO] [stderr]    Compiling n_longest_paths v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 42.32s
[INFO] running `Command { std: "docker" "inspect" "65acfdab2ff3374fce60c3cc427d1dfc71dc61f1bb82bebad599cdf632594070", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "65acfdab2ff3374fce60c3cc427d1dfc71dc61f1bb82bebad599cdf632594070", kill_on_drop: false }`
[INFO] [stdout] 65acfdab2ff3374fce60c3cc427d1dfc71dc61f1bb82bebad599cdf632594070
[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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3176986d9a76d31f6f7044f8edf512726f6b69862f7502bdf070a6ebb641d194
[INFO] running `Command { std: "docker" "start" "-a" "3176986d9a76d31f6f7044f8edf512726f6b69862f7502bdf070a6ebb641d194", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.24s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/n_longest_paths-efe7d9a75f97b87d)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] 
0 / 1 [---------------------------------------------------------] 0.00 % 0.00/s 
done                                                                            
0 / 2 [---------------------------------------------------------] 0.00 % 0.00/s 
Continuing with individual pruning!2 / 2 [================] 100.00 % 25967.28/s 
done                                                                            
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
2 / 3 [================================>----------------] 66.67 % 21005.98/s 0s 
Continuing with individual pruning!3 / 3 [================] 100.00 % 20782.68/s 
done                                                                            
0 / 4 [---------------------------------------------------------] 0.00 % 0.00/s 
2 / 4 [========================>------------------------] 50.00 % 26776.99/s 0s 
0 / 1 [---------------------------------------------------------] 0.00 % 0.00/s 
3 / 4 [====================================>------------] 75.00 % 26511.13/s 0s 
0 / 1 [---------------------------------------------------------] 0.00 % 0.00/s 
Continuing with individual pruning!4 / 4 [================] 100.00 % 25374.27/s 
done                                                                            
Continuing with individual pruning!0 / 1 [----------------------] 0.00 % 0.00/s 
Continuing with individual pruning!0 / 1 [----------------------] 0.00 % 0.00/s 
0 / 1 [---------------------------------------------------------] 0.00 % 0.00/s test fast_graph::tests::longest_path_consistent ... ignored
[INFO] [stdout] test tests::longest_path_consistent ... ignored
[INFO] [stdout] test tests::longest_paths_additive_works ... ok
[INFO] [stdout] 
Continuing with individual pruning!1 / 1 [=================] 100.00 % 4890.19/s 
Continuing with individual pruning!1 / 1 [=================] 100.00 % 2975.30/s 
Continuing with individual pruning!1 / 1 [=================] 100.00 % 2118.73/s 
done                                                                            
done                                                                            
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
done                                                                            test fast_graph::tests::fast_graph_skippable_works ... ok
[INFO] [stdout] 
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
2 / 5 [===================>------------------------------] 40.00 % 4766.67/s 0s test tests::longest_paths_mult_works ... ok
[INFO] [stdout] 
1 / 3 [================>---------------------------------] 33.33 % 8307.03/s 0s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
Continuing with individual pruning!3 / 3 [================] 100.00 % 14921.74/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
3 / 5 [=============================>--------------------] 60.00 % 5097.61/s 0s 
done                                                                            
0 / 1 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
4 / 5 [=======================================>----------] 80.00 % 5865.52/s 0s 
Continuing with individual pruning!1 / 1 [=================] 100.00 % 4469.29/s 
0 / 4 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
done                                                                            
1 / 4 [============>-------------------------------------] 25.00 % 9932.46/s 0s 
Continuing with individual pruning!5 / 5 [=================] 100.00 % 6681.45/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
done                                                                            
3 / 4 [====================================>------------] 75.00 % 16863.41/s 0s 
5 / 5 [====================================================] 100.00 % 9941.72/s 
0 / 2 [---------------------------------------------------------] 0.00 % 0.00/s 
Finished preparing.                                                             
Continuing with individual pruning!4 / 4 [================] 100.00 % 15221.86/s 
done                                                                            
0 / 1 [---------------------------------------------------------] 0.00 % 0.00/s 
1 / 2 [========================>-------------------------] 50.00 % 8911.07/s 0s 
0 / 1 [---------------------------------------------------------] 0.00 % 0.00/s test fast_graph::tests::fast_graph_works ... ok
[INFO] [stdout] 
Continuing with individual pruning!1 / 1 [=================] 100.00 % 7031.80/s 
done                                                                            
done                                                                            
Continuing with individual pruning!2 / 2 [=================] 100.00 % 7919.19/s 
done                                                                            
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 2 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
1 / 3 [================>---------------------------------] 33.33 % 6328.35/s 0s 
1 / 2 [========================>-------------------------] 50.00 % 4714.56/s 0s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
2 / 3 [=================================>----------------] 66.67 % 8017.99/s 0s 
done                                                                            
Continuing with individual pruning!2 / 3 [=========>-----] 66.67 % 5814.31/s 0s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
Continuing with individual pruning!3 / 3 [=================] 100.00 % 7806.02/s 
5 / 5 [===================================================] 100.00 % 10383.14/s 
Finished preparing.                                                             
done                                                                            
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 2 [---------------------------------------------------------] 0.00 % 0.00/s 
1 / 3 [================>---------------------------------] 33.33 % 8082.77/s 0s test fast_graph::tests::longest_paths_faster_works ... ok
[INFO] [stdout] 
Continuing with individual pruning!3 / 3 [================] 100.00 % 12906.00/s 
Continuing with individual pruning!2 / 2 [================] 100.00 % 11558.69/s 
done                                                                            
done                                                                            
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 4 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
1 / 4 [============>-------------------------------------] 25.00 % 8181.97/s 0s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
3 / 4 [====================================>------------] 75.00 % 13245.03/s 0s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
Continuing with individual pruning!4 / 4 [================] 100.00 % 13533.17/s 
5 / 5 [===================================================] 100.00 % 15189.26/s 
done                                                                            
Finished preparing.                                                             
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
2 / 3 [================================>----------------] 66.67 % 24289.53/s 0s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
Continuing with individual pruning!3 / 3 [================] 100.00 % 20419.28/s 
done                                                                            
1 / 5 [=========>----------------------------------------] 20.00 % 7390.98/s 0s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
3 / 5 [=============================>-------------------] 60.00 % 14039.03/s 0s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
4 / 5 [=======================================>---------] 80.00 % 13411.12/s 0s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
Continuing with individual pruning!5 / 5 [================] 100.00 % 12909.89/s 
done                                                                            
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
5 / 5 [===================================================] 100.00 % 15501.95/s test fast_graph::tests::fast_graph_mult_works ... ok
[INFO] [stdout] 
Finished preparing.                                                             
0 / 4 [---------------------------------------------------------] 0.00 % 0.00/s 
2 / 4 [========================>------------------------] 50.00 % 17488.63/s 0s 
3 / 4 [====================================>------------] 75.00 % 16868.15/s 0s 
Continuing with individual pruning!4 / 4 [================] 100.00 % 15339.78/s 
done                                                                            
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
5 / 5 [===================================================] 100.00 % 12804.75/s 
Finished preparing.                                                             
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
2 / 5 [===================>-----------------------------] 40.00 % 16479.89/s 0s 
3 / 5 [=============================>-------------------] 60.00 % 15398.83/s 0s 
4 / 5 [=======================================>---------] 80.00 % 15583.61/s 0s 
Continuing with individual pruning!5 / 5 [================] 100.00 % 15804.78/s 
done                                                                            
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
5 / 5 [===================================================] 100.00 % 20533.04/s 
Finished preparing.                                                             
0 / 1 [---------------------------------------------------------] 0.00 % 0.00/s 
Continuing with individual pruning!1 / 1 [================] 100.00 % 11024.14/s 
done                                                                            
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
5 / 5 [===================================================] 100.00 % 22139.57/s 
Finished preparing.                                                             
0 / 2 [---------------------------------------------------------] 0.00 % 0.00/s 
1 / 2 [========================>------------------------] 50.00 % 14496.96/s 0s 
done                                                                            
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
5 / 5 [===================================================] 100.00 % 16090.62/s 
Finished preparing.                                                             
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
1 / 3 [================>--------------------------------] 33.33 % 10875.48/s 0s 
Continuing with individual pruning!3 / 3 [================] 100.00 % 19016.23/s 
done                                                                            
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
5 / 5 [===================================================] 100.00 % 16239.57/s 
Finished preparing.                                                             
0 / 4 [---------------------------------------------------------] 0.00 % 0.00/s 
1 / 4 [============>------------------------------------] 25.00 % 10396.09/s 0s 
3 / 4 [====================================>------------] 75.00 % 18178.51/s 0s 
Continuing with individual pruning!4 / 4 [================] 100.00 % 18239.02/s 
done                                                                            
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
5 / 5 [===================================================] 100.00 % 23374.32/s 
Finished preparing.                                                             
0 / 5 [---------------------------------------------------------] 0.00 % 0.00/s 
1 / 5 [=========>---------------------------------------] 20.00 % 15085.23/s 0s 
3 / 5 [=============================>-------------------] 60.00 % 25900.03/s 0s 
4 / 5 [=======================================>---------] 80.00 % 24849.51/s 0s 
Continuing with individual pruning!5 / 5 [================] 100.00 % 24649.97/s 
done                                                                            
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
3 / 3 [===================================================] 100.00 % 19633.51/s 
Finished preparing.                                                             
0 / 1 [---------------------------------------------------------] 0.00 % 0.00/s 
Continuing with individual pruning!1 / 1 [================] 100.00 % 11016.73/s 
done                                                                            
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
3 / 3 [===================================================] 100.00 % 20679.53/s 
Finished preparing.                                                             
0 / 1 [---------------------------------------------------------] 0.00 % 0.00/s 
Continuing with individual pruning!1 / 1 [=================] 100.00 % 9733.31/s 
done                                                                            
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
3 / 3 [===================================================] 100.00 % 20278.49/s 
Finished preparing.                                                             
0 / 2 [---------------------------------------------------------] 0.00 % 0.00/s 
1 / 2 [========================>------------------------] 50.00 % 12866.70/s 0s 
Continuing with individual pruning!2 / 2 [================] 100.00 % 16298.72/s 
done                                                                            
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
3 / 3 [===================================================] 100.00 % 20631.32/s 
Finished preparing.                                                             
0 / 3 [---------------------------------------------------------] 0.00 % 0.00/s 
1 / 3 [================>--------------------------------] 33.33 % 14384.35/s 0s 
2 / 3 [================================>----------------] 66.67 % 18646.28/s 0s 
Continuing with individual pruning!2 / 3 [=========>----] 66.67 % 12852.64/s 0s 
Continuing with individual pruning!3 / 3 [================] 100.00 % 15006.75/s 
done                                                                            test tests::longest_paths_faster_works ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/n_longest_paths-719652ccf09f2770)
[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] [stderr]    Doc-tests n_longest_paths
[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" "3176986d9a76d31f6f7044f8edf512726f6b69862f7502bdf070a6ebb641d194", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3176986d9a76d31f6f7044f8edf512726f6b69862f7502bdf070a6ebb641d194", kill_on_drop: false }`
[INFO] [stdout] 3176986d9a76d31f6f7044f8edf512726f6b69862f7502bdf070a6ebb641d194