[INFO] fetching crate perftool 0.2.0...
[INFO] testing perftool-0.2.0 against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] extracting crate perftool 0.2.0 into /workspace/builds/worker-90/source
[INFO] validating manifest of crates.io crate perftool 0.2.0 on toolchain 722e1797249a965b6335aebd65d777f917e498f1
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate perftool 0.2.0
[INFO] finished tweaking crates.io crate perftool 0.2.0
[INFO] tweaked toml for crates.io crate perftool 0.2.0 written to /workspace/builds/worker-90/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "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" "+722e1797249a965b6335aebd65d777f917e498f1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded bytes v0.6.0
[INFO] [stderr]   Downloaded tokio-macros v0.3.2
[INFO] [stderr]   Downloaded tokio v0.3.7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-90/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-90/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" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] d6f86f371b3231d331299d14431e32307020952106daebe1981176289e4d66b2
[INFO] running `Command { std: "docker" "start" "-a" "d6f86f371b3231d331299d14431e32307020952106daebe1981176289e4d66b2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d6f86f371b3231d331299d14431e32307020952106daebe1981176289e4d66b2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d6f86f371b3231d331299d14431e32307020952106daebe1981176289e4d66b2", kill_on_drop: false }`
[INFO] [stdout] d6f86f371b3231d331299d14431e32307020952106daebe1981176289e4d66b2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-90/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-90/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" "+722e1797249a965b6335aebd65d777f917e498f1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 736d5e4345506672b78a2eaad898051c43826d4a5024e9dc444e8f8b92801233
[INFO] running `Command { std: "docker" "start" "-a" "736d5e4345506672b78a2eaad898051c43826d4a5024e9dc444e8f8b92801233", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.108
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling autocfg v1.0.1
[INFO] [stderr]    Compiling proc-macro2 v1.0.32
[INFO] [stderr]    Compiling memchr v2.4.1
[INFO] [stderr]    Compiling unicode-xid v0.2.2
[INFO] [stderr]    Compiling proc-macro-hack v0.5.19
[INFO] [stderr]    Compiling futures-channel v0.3.17
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling proc-macro-nested v0.1.7
[INFO] [stderr]    Compiling parking_lot_core v0.8.5
[INFO] [stderr]    Compiling slab v0.4.5
[INFO] [stderr]    Compiling futures-sink v0.3.17
[INFO] [stderr]    Compiling scopeguard v1.1.0
[INFO] [stderr]    Compiling futures-io v0.3.17
[INFO] [stderr]    Compiling smallvec v1.7.0
[INFO] [stderr]    Compiling humantime v2.1.0
[INFO] [stderr]    Compiling bytes v0.6.0
[INFO] [stderr]    Compiling termcolor v1.1.2
[INFO] [stderr]    Compiling once_cell v1.8.0
[INFO] [stderr]    Compiling instant v0.1.12
[INFO] [stderr]    Compiling lock_api v0.4.5
[INFO] [stderr]    Compiling futures-macro v0.3.17
[INFO] [stderr]    Compiling futures-util v0.3.17
[INFO] [stderr]    Compiling tokio v0.3.7
[INFO] [stderr]    Compiling aho-corasick v0.7.18
[INFO] [stderr]    Compiling quote v1.0.10
[INFO] [stderr]    Compiling getrandom v0.2.3
[INFO] [stderr]    Compiling num_cpus v1.13.0
[INFO] [stderr]    Compiling signal-hook-registry v1.4.0
[INFO] [stderr]    Compiling mio v0.7.14
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling syn v1.0.81
[INFO] [stderr]    Compiling rand_core v0.6.3
[INFO] [stderr]    Compiling parking_lot v0.11.2
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling regex v1.5.4
[INFO] [stderr]    Compiling rand v0.8.4
[INFO] [stderr]    Compiling env_logger v0.8.4
[INFO] [stderr]    Compiling tokio-macros v0.3.2
[INFO] [stderr]    Compiling futures-executor v0.3.17
[INFO] [stderr]    Compiling futures v0.3.17
[INFO] [stderr]    Compiling perftool v0.2.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused import: `rand::Rng`
[INFO] [stdout]  --> src/lib.rs:4:5
[INFO] [stdout]   |
[INFO] [stdout] 4 | use rand::Rng;
[INFO] [stdout]   |     ^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 20.59s
[INFO] running `Command { std: "docker" "inspect" "736d5e4345506672b78a2eaad898051c43826d4a5024e9dc444e8f8b92801233", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "736d5e4345506672b78a2eaad898051c43826d4a5024e9dc444e8f8b92801233", kill_on_drop: false }`
[INFO] [stdout] 736d5e4345506672b78a2eaad898051c43826d4a5024e9dc444e8f8b92801233
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-90/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-90/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" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 14a02caa4abab06d792c348dbb82293cc684bd2d4e1d8b2f6e18078ad3463694
[INFO] running `Command { std: "docker" "start" "-a" "14a02caa4abab06d792c348dbb82293cc684bd2d4e1d8b2f6e18078ad3463694", kill_on_drop: false }`
[INFO] [stderr]    Compiling perftool v0.2.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused import: `rand::Rng`
[INFO] [stdout]  --> src/lib.rs:4:5
[INFO] [stdout]   |
[INFO] [stdout] 4 | use rand::Rng;
[INFO] [stdout]   |     ^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: panic message is not a string literal
[INFO] [stdout]    --> src/lib.rs:167:44
[INFO] [stdout]     |
[INFO] [stdout] 167 |             Ok(Err(msg)) => assert!(false, msg),
[INFO] [stdout]     |                                            ^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(non_fmt_panics)]` on by default
[INFO] [stdout]     = note: this usage of assert!() is deprecated; it will be a hard error in Rust 2021
[INFO] [stdout]     = note: for more information, see <https://doc.rust-lang.org/nightly/edition-guide/rust-2021/panic-macro-consistency.html>
[INFO] [stdout] help: add a "{}" format string to Display the message
[INFO] [stdout]     |
[INFO] [stdout] 167 |             Ok(Err(msg)) => assert!(false, "{}", msg),
[INFO] [stdout]     |                                            +++++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.61s
[INFO] running `Command { std: "docker" "inspect" "14a02caa4abab06d792c348dbb82293cc684bd2d4e1d8b2f6e18078ad3463694", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "14a02caa4abab06d792c348dbb82293cc684bd2d4e1d8b2f6e18078ad3463694", kill_on_drop: false }`
[INFO] [stdout] 14a02caa4abab06d792c348dbb82293cc684bd2d4e1d8b2f6e18078ad3463694
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-90/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-90/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" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 166c9fdf8aea095ded725778f2baba4bc9822f8e269e78258b0586cd7da62d79
[INFO] running `Command { std: "docker" "start" "-a" "166c9fdf8aea095ded725778f2baba4bc9822f8e269e78258b0586cd7da62d79", kill_on_drop: false }`
[INFO] [stderr] warning: unused import: `rand::Rng`
[INFO] [stderr]  --> src/lib.rs:4:5
[INFO] [stderr]   |
[INFO] [stderr] 4 | use rand::Rng;
[INFO] [stderr]   |     ^^^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: panic message is not a string literal
[INFO] [stderr]    --> src/lib.rs:167:44
[INFO] [stderr]     |
[INFO] [stderr] 167 |             Ok(Err(msg)) => assert!(false, msg),
[INFO] [stderr]     |                                            ^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(non_fmt_panics)]` on by default
[INFO] [stderr]     = note: this usage of assert!() is deprecated; it will be a hard error in Rust 2021
[INFO] [stderr]     = note: for more information, see <https://doc.rust-lang.org/nightly/edition-guide/rust-2021/panic-macro-consistency.html>
[INFO] [stderr] help: add a "{}" format string to Display the message
[INFO] [stderr]     |
[INFO] [stderr] 167 |             Ok(Err(msg)) => assert!(false, "{}", msg),
[INFO] [stderr]     |                                            +++++
[INFO] [stderr] 
[INFO] [stderr] warning: `perftool` (lib) generated 1 warning
[INFO] [stderr] warning: `perftool` (lib test) generated 1 warning
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/perftool-2d1297f4529e0a79)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr] [2021-11-21T04:32:38Z DEBUG perftool] starting ramp up
[INFO] [stderr] [2021-11-21T04:32:38Z INFO  perftool::tests] test waiting for ramp up to finish
[INFO] [stderr] [2021-11-21T04:32:38Z DEBUG perftool] actual #workers - 0, expected #workers - 1
[INFO] [stderr] [2021-11-21T04:32:38Z INFO  perftool::tests] hello, 207, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:39Z DEBUG perftool] actual #workers - 1, expected #workers - 2
[INFO] [stderr] [2021-11-21T04:32:39Z INFO  perftool::tests] hello, 215, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:39Z DEBUG perftool] actual #workers - 2, expected #workers - 3
[INFO] [stderr] [2021-11-21T04:32:39Z INFO  perftool::tests] hello, 239, my name is JORA
[INFO] [stderr] [2021-11-21T04:32:40Z DEBUG perftool] actual #workers - 3, expected #workers - 4
[INFO] [stderr] [2021-11-21T04:32:40Z INFO  perftool::tests] hello, 171, my name is VASEA
[INFO] [stderr] [2021-11-21T04:32:40Z INFO  perftool::tests] I'm done, 207
[INFO] [stderr] [2021-11-21T04:32:40Z DEBUG perftool] actual #workers - 3, expected #workers - 4
[INFO] [stderr] [2021-11-21T04:32:40Z INFO  perftool::tests] hello, 34, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:40Z DEBUG perftool] actual #workers - 4, expected #workers - 5
[INFO] [stderr] [2021-11-21T04:32:40Z INFO  perftool::tests] hello, 11, my name is KOLEA
[INFO] [stderr] [2021-11-21T04:32:41Z INFO  perftool::tests] I'm done, 215
[INFO] [stderr] [2021-11-21T04:32:41Z DEBUG perftool] actual #workers - 4, expected #workers - 5
[INFO] [stderr] [2021-11-21T04:32:41Z INFO  perftool::tests] hello, 76, my name is JORA
[INFO] [stderr] [2021-11-21T04:32:41Z DEBUG perftool] actual #workers - 5, expected #workers - 6
[INFO] [stderr] [2021-11-21T04:32:41Z INFO  perftool::tests] hello, 227, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:41Z INFO  perftool::tests] I'm done, 239
[INFO] [stderr] [2021-11-21T04:32:41Z DEBUG perftool] actual #workers - 5, expected #workers - 6
[INFO] [stderr] [2021-11-21T04:32:41Z INFO  perftool::tests] hello, 68, my name is KOLEA
[INFO] [stderr] [2021-11-21T04:32:42Z DEBUG perftool] actual #workers - 6, expected #workers - 7
[INFO] [stderr] [2021-11-21T04:32:42Z INFO  perftool::tests] hello, 173, my name is FEDEA
[INFO] [stderr] [2021-11-21T04:32:42Z INFO  perftool::tests] I'm done, 171
[INFO] [stderr] [2021-11-21T04:32:42Z DEBUG perftool] actual #workers - 6, expected #workers - 7
[INFO] [stderr] [2021-11-21T04:32:42Z INFO  perftool::tests] hello, 215, my name is KOLEA
[INFO] [stderr] [2021-11-21T04:32:42Z DEBUG perftool] actual #workers - 7, expected #workers - 8
[INFO] [stderr] [2021-11-21T04:32:42Z INFO  perftool::tests] hello, 43, my name is VANEA
[INFO] [stderr] [2021-11-21T04:32:42Z INFO  perftool::tests] I'm done, 34
[INFO] [stderr] [2021-11-21T04:32:42Z DEBUG perftool] actual #workers - 7, expected #workers - 8
[INFO] [stderr] [2021-11-21T04:32:42Z INFO  perftool::tests] hello, 27, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:42Z INFO  perftool::tests] I'm done, 11
[INFO] [stderr] [2021-11-21T04:32:42Z DEBUG perftool] actual #workers - 7, expected #workers - 8
[INFO] [stderr] [2021-11-21T04:32:42Z INFO  perftool::tests] hello, 106, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:43Z DEBUG perftool] actual #workers - 8, expected #workers - 9
[INFO] [stderr] [2021-11-21T04:32:43Z INFO  perftool::tests] hello, 121, my name is KOLEA
[INFO] [stderr] [2021-11-21T04:32:43Z INFO  perftool::tests] I'm done, 76
[INFO] [stderr] [2021-11-21T04:32:43Z DEBUG perftool] actual #workers - 8, expected #workers - 9
[INFO] [stderr] [2021-11-21T04:32:43Z INFO  perftool::tests] hello, 76, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:43Z INFO  perftool::tests] I'm done, 227
[INFO] [stderr] [2021-11-21T04:32:43Z DEBUG perftool] actual #workers - 8, expected #workers - 9
[INFO] [stderr] [2021-11-21T04:32:43Z INFO  perftool::tests] hello, 254, my name is VANEA
[INFO] [stderr] [2021-11-21T04:32:43Z INFO  perftool::tests] test starts checkng actual wps
[INFO] [stderr] [2021-11-21T04:32:43Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:43Z INFO  perftool::tests] hello, 85, my name is VASEA
[INFO] [stderr] [2021-11-21T04:32:43Z INFO  perftool::tests] I'm done, 68
[INFO] [stderr] [2021-11-21T04:32:43Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:43Z INFO  perftool::tests] hello, 74, my name is FEDEA
[INFO] [stderr] [2021-11-21T04:32:44Z INFO  perftool::tests] I'm done, 173
[INFO] [stderr] [2021-11-21T04:32:44Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:44Z INFO  perftool::tests] hello, 103, my name is VASEA
[INFO] [stderr] [2021-11-21T04:32:44Z DEBUG perftool] ramp up done
[INFO] [stderr] [2021-11-21T04:32:44Z DEBUG perftool] starting test with constant load
[INFO] [stderr] [2021-11-21T04:32:44Z INFO  perftool::tests] I'm done, 215
[INFO] [stderr] [2021-11-21T04:32:44Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:44Z INFO  perftool::tests] hello, 137, my name is VANEA
[INFO] [stderr] [2021-11-21T04:32:44Z INFO  perftool::tests] I'm done, 43
[INFO] [stderr] [2021-11-21T04:32:44Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:44Z INFO  perftool::tests] hello, 2, my name is KOLEA
[INFO] [stderr] [2021-11-21T04:32:44Z INFO  perftool::tests] I'm done, 27
[INFO] [stderr] [2021-11-21T04:32:44Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:44Z INFO  perftool::tests] hello, 99, my name is VANEA
[INFO] [stderr] [2021-11-21T04:32:44Z INFO  perftool::tests] I'm done, 106
[INFO] [stderr] [2021-11-21T04:32:44Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:44Z INFO  perftool::tests] hello, 146, my name is FEDEA
[INFO] [stderr] [2021-11-21T04:32:45Z INFO  perftool::tests] I'm done, 121
[INFO] [stderr] [2021-11-21T04:32:45Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:45Z INFO  perftool::tests] hello, 97, my name is JORA
[INFO] [stderr] [2021-11-21T04:32:45Z INFO  perftool::tests] I'm done, 76
[INFO] [stderr] [2021-11-21T04:32:45Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:45Z INFO  perftool::tests] hello, 228, my name is JORA
[INFO] [stderr] [2021-11-21T04:32:45Z INFO  perftool::tests] I'm done, 254
[INFO] [stderr] [2021-11-21T04:32:45Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:45Z INFO  perftool::tests] hello, 13, my name is JORA
[INFO] [stderr] [2021-11-21T04:32:45Z INFO  perftool::tests] I'm done, 85
[INFO] [stderr] [2021-11-21T04:32:45Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:45Z INFO  perftool::tests] hello, 10, my name is VASEA
[INFO] [stderr] [2021-11-21T04:32:45Z INFO  perftool::tests] I'm done, 74
[INFO] [stderr] [2021-11-21T04:32:45Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:45Z INFO  perftool::tests] hello, 177, my name is JORA
[INFO] [stderr] [2021-11-21T04:32:46Z INFO  perftool::tests] I'm done, 103
[INFO] [stderr] [2021-11-21T04:32:46Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:46Z INFO  perftool::tests] hello, 197, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:46Z INFO  perftool::tests] I'm done, 137
[INFO] [stderr] [2021-11-21T04:32:46Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:46Z INFO  perftool::tests] hello, 190, my name is JORA
[INFO] [stderr] [2021-11-21T04:32:46Z INFO  perftool::tests] I'm done, 2
[INFO] [stderr] [2021-11-21T04:32:46Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:46Z INFO  perftool::tests] hello, 200, my name is VANEA
[INFO] [stderr] [2021-11-21T04:32:46Z INFO  perftool::tests] I'm done, 99
[INFO] [stderr] [2021-11-21T04:32:46Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:46Z INFO  perftool::tests] hello, 90, my name is KOLEA
[INFO] [stderr] [2021-11-21T04:32:46Z INFO  perftool::tests] I'm done, 146
[INFO] [stderr] [2021-11-21T04:32:46Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:46Z INFO  perftool::tests] hello, 243, my name is VASEA
[INFO] [stderr] [2021-11-21T04:32:47Z INFO  perftool::tests] I'm done, 97
[INFO] [stderr] [2021-11-21T04:32:47Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:47Z INFO  perftool::tests] hello, 156, my name is JORA
[INFO] [stderr] [2021-11-21T04:32:47Z INFO  perftool::tests] I'm done, 228
[INFO] [stderr] [2021-11-21T04:32:47Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:47Z INFO  perftool::tests] hello, 75, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:47Z INFO  perftool::tests] I'm done, 13
[INFO] [stderr] [2021-11-21T04:32:47Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:47Z INFO  perftool::tests] hello, 158, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:47Z INFO  perftool::tests] I'm done, 10
[INFO] [stderr] [2021-11-21T04:32:47Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:47Z INFO  perftool::tests] hello, 83, my name is FEDEA
[INFO] [stderr] [2021-11-21T04:32:47Z INFO  perftool::tests] I'm done, 177
[INFO] [stderr] [2021-11-21T04:32:47Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:47Z INFO  perftool::tests] hello, 181, my name is KOLEA
[INFO] [stderr] [2021-11-21T04:32:48Z INFO  perftool::tests] I'm done, 197
[INFO] [stderr] [2021-11-21T04:32:48Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:48Z INFO  perftool::tests] hello, 1, my name is JORA
[INFO] [stderr] [2021-11-21T04:32:48Z INFO  perftool::tests] I'm done, 190
[INFO] [stderr] [2021-11-21T04:32:48Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:48Z INFO  perftool::tests] hello, 118, my name is FEDEA
[INFO] [stderr] [2021-11-21T04:32:48Z INFO  perftool::tests] I'm done, 200
[INFO] [stderr] [2021-11-21T04:32:48Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:48Z INFO  perftool::tests] hello, 97, my name is VANEA
[INFO] [stderr] [2021-11-21T04:32:48Z INFO  perftool::tests] I'm done, 90
[INFO] [stderr] [2021-11-21T04:32:48Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:48Z INFO  perftool::tests] hello, 106, my name is KOLEA
[INFO] [stderr] [2021-11-21T04:32:48Z INFO  perftool::tests] I'm done, 243
[INFO] [stderr] [2021-11-21T04:32:48Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:48Z INFO  perftool::tests] hello, 113, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:49Z INFO  perftool::tests] I'm done, 156
[INFO] [stderr] [2021-11-21T04:32:49Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:49Z INFO  perftool::tests] hello, 189, my name is FEDEA
[INFO] [stderr] [2021-11-21T04:32:49Z INFO  perftool::tests] I'm done, 75
[INFO] [stderr] [2021-11-21T04:32:49Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:49Z INFO  perftool::tests] hello, 236, my name is KOLEA
[INFO] [stderr] [2021-11-21T04:32:49Z INFO  perftool::tests] I'm done, 158
[INFO] [stderr] [2021-11-21T04:32:49Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:49Z INFO  perftool::tests] hello, 184, my name is JORA
[INFO] [stderr] [2021-11-21T04:32:49Z INFO  perftool::tests] I'm done, 83
[INFO] [stderr] [2021-11-21T04:32:49Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:49Z INFO  perftool::tests] hello, 206, my name is VASEA
[INFO] [stderr] [2021-11-21T04:32:49Z INFO  perftool::tests] I'm done, 181
[INFO] [stderr] [2021-11-21T04:32:49Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:49Z INFO  perftool::tests] hello, 108, my name is FEDEA
[INFO] [stderr] [2021-11-21T04:32:50Z INFO  perftool::tests] I'm done, 1
[INFO] [stderr] [2021-11-21T04:32:50Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:50Z INFO  perftool::tests] hello, 218, my name is VANEA
[INFO] [stderr] [2021-11-21T04:32:50Z INFO  perftool::tests] I'm done, 118
[INFO] [stderr] [2021-11-21T04:32:50Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:50Z INFO  perftool::tests] hello, 196, my name is KOLEA
[INFO] [stderr] [2021-11-21T04:32:50Z INFO  perftool::tests] I'm done, 97
[INFO] [stderr] [2021-11-21T04:32:50Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:50Z INFO  perftool::tests] hello, 45, my name is VASEA
[INFO] [stderr] [2021-11-21T04:32:50Z INFO  perftool::tests] I'm done, 106
[INFO] [stderr] [2021-11-21T04:32:50Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:50Z INFO  perftool::tests] hello, 73, my name is VANEA
[INFO] [stderr] [2021-11-21T04:32:50Z INFO  perftool::tests] I'm done, 113
[INFO] [stderr] [2021-11-21T04:32:50Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:50Z INFO  perftool::tests] hello, 7, my name is JORA
[INFO] [stderr] [2021-11-21T04:32:51Z INFO  perftool::tests] I'm done, 189
[INFO] [stderr] [2021-11-21T04:32:51Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:51Z INFO  perftool::tests] hello, 138, my name is FEDEA
[INFO] [stderr] [2021-11-21T04:32:51Z INFO  perftool::tests] I'm done, 236
[INFO] [stderr] [2021-11-21T04:32:51Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:51Z INFO  perftool::tests] hello, 192, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:51Z INFO  perftool::tests] I'm done, 184
[INFO] [stderr] [2021-11-21T04:32:51Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:51Z INFO  perftool::tests] hello, 72, my name is FEDEA
[INFO] [stderr] [2021-11-21T04:32:51Z INFO  perftool::tests] I'm done, 206
[INFO] [stderr] [2021-11-21T04:32:51Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:51Z INFO  perftool::tests] hello, 47, my name is JORA
[INFO] [stderr] [2021-11-21T04:32:51Z INFO  perftool::tests] I'm done, 108
[INFO] [stderr] [2021-11-21T04:32:51Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:51Z INFO  perftool::tests] hello, 16, my name is VANEA
[INFO] [stderr] [2021-11-21T04:32:52Z INFO  perftool::tests] I'm done, 218
[INFO] [stderr] [2021-11-21T04:32:52Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:52Z INFO  perftool::tests] hello, 55, my name is KOLEA
[INFO] [stderr] [2021-11-21T04:32:52Z INFO  perftool::tests] I'm done, 196
[INFO] [stderr] [2021-11-21T04:32:52Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:52Z INFO  perftool::tests] hello, 133, my name is KOLEA
[INFO] [stderr] [2021-11-21T04:32:52Z INFO  perftool::tests] I'm done, 45
[INFO] [stderr] [2021-11-21T04:32:52Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:52Z INFO  perftool::tests] hello, 67, my name is FEDEA
[INFO] [stderr] [2021-11-21T04:32:52Z INFO  perftool::tests] I'm done, 73
[INFO] [stderr] [2021-11-21T04:32:52Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:52Z INFO  perftool::tests] hello, 37, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:52Z INFO  perftool::tests] I'm done, 7
[INFO] [stderr] [2021-11-21T04:32:52Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:52Z INFO  perftool::tests] hello, 121, my name is VASEA
[INFO] [stderr] [2021-11-21T04:32:53Z INFO  perftool::tests] I'm done, 138
[INFO] [stderr] [2021-11-21T04:32:53Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:53Z INFO  perftool::tests] hello, 245, my name is JORA
[INFO] [stderr] [2021-11-21T04:32:53Z INFO  perftool::tests] I'm done, 192
[INFO] [stderr] [2021-11-21T04:32:53Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:53Z INFO  perftool::tests] hello, 1, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:53Z INFO  perftool::tests] I'm done, 72
[INFO] [stderr] [2021-11-21T04:32:53Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:53Z INFO  perftool::tests] hello, 182, my name is JORA
[INFO] [stderr] [2021-11-21T04:32:53Z INFO  perftool::tests] I'm done, 47
[INFO] [stderr] [2021-11-21T04:32:53Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:53Z INFO  perftool::tests] hello, 157, my name is VASEA
[INFO] [stderr] [2021-11-21T04:32:53Z INFO  perftool::tests] I'm done, 16
[INFO] [stderr] [2021-11-21T04:32:53Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:53Z INFO  perftool::tests] hello, 243, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:54Z INFO  perftool::tests] I'm done, 55
[INFO] [stderr] [2021-11-21T04:32:54Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:54Z INFO  perftool::tests] hello, 76, my name is KOLEA
[INFO] [stderr] [2021-11-21T04:32:54Z INFO  perftool::tests] I'm done, 133
[INFO] [stderr] [2021-11-21T04:32:54Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:54Z INFO  perftool::tests] hello, 192, my name is KOLEA
[INFO] [stderr] [2021-11-21T04:32:54Z INFO  perftool::tests] I'm done, 67
[INFO] [stderr] [2021-11-21T04:32:54Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:54Z INFO  perftool::tests] hello, 193, my name is VASEA
[INFO] [stderr] [2021-11-21T04:32:54Z INFO  perftool::tests] I'm done, 37
[INFO] [stderr] [2021-11-21T04:32:54Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:54Z INFO  perftool::tests] hello, 127, my name is JORA
[INFO] [stderr] [2021-11-21T04:32:54Z INFO  perftool::tests] I'm done, 121
[INFO] [stderr] [2021-11-21T04:32:54Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:54Z INFO  perftool::tests] hello, 26, my name is KOLEA
[INFO] [stderr] [2021-11-21T04:32:55Z INFO  perftool::tests] I'm done, 245
[INFO] [stderr] [2021-11-21T04:32:55Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:55Z INFO  perftool::tests] hello, 120, my name is FEDEA
[INFO] [stderr] [2021-11-21T04:32:55Z INFO  perftool::tests] I'm done, 1
[INFO] [stderr] [2021-11-21T04:32:55Z DEBUG perftool] actual #workers - 9, expected #workers - 10
[INFO] [stderr] [2021-11-21T04:32:55Z INFO  perftool::tests] hello, 48, my name is PETEA
[INFO] [stderr] [2021-11-21T04:32:55Z DEBUG perftool] test done, waiting for workers to finish
[INFO] [stderr] [2021-11-21T04:32:55Z INFO  perftool::tests] I'm done, 182
[INFO] [stderr] [2021-11-21T04:32:55Z INFO  perftool::tests] I'm done, 157
[INFO] [stderr] [2021-11-21T04:32:55Z INFO  perftool::tests] I'm done, 243
[INFO] [stderr] [2021-11-21T04:32:56Z INFO  perftool::tests] I'm done, 76
[INFO] [stderr] [2021-11-21T04:32:56Z INFO  perftool::tests] I'm done, 192
[INFO] [stderr] [2021-11-21T04:32:56Z INFO  perftool::tests] I'm done, 193
[INFO] [stderr] [2021-11-21T04:32:56Z INFO  perftool::tests] I'm done, 127
[INFO] [stderr] [2021-11-21T04:32:56Z INFO  perftool::tests] I'm done, 26
[INFO] [stderr] [2021-11-21T04:32:57Z INFO  perftool::tests] I'm done, 120
[INFO] [stderr] [2021-11-21T04:32:57Z INFO  perftool::tests] I'm done, 48
[INFO] [stderr] [2021-11-21T04:32:57Z DEBUG perftool] all workers done
[INFO] [stdout] test tests::test_simple ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 18.66s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests perftool
[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" "166c9fdf8aea095ded725778f2baba4bc9822f8e269e78258b0586cd7da62d79", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "166c9fdf8aea095ded725778f2baba4bc9822f8e269e78258b0586cd7da62d79", kill_on_drop: false }`
[INFO] [stdout] 166c9fdf8aea095ded725778f2baba4bc9822f8e269e78258b0586cd7da62d79