[INFO] cloning repository https://github.com/kernelmachine/cargo-profiler [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/kernelmachine/cargo-profiler" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkernelmachine%2Fcargo-profiler", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkernelmachine%2Fcargo-profiler'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 08362dcc996d21bdba6e737f29e574dfc8e1a35c [INFO] testing kernelmachine/cargo-profiler against master#a77da2d454e6caa227a85b16410b95f93495e7e0 for pr-91031 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkernelmachine%2Fcargo-profiler" "/workspace/builds/worker-32/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-32/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/kernelmachine/cargo-profiler 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/kernelmachine/cargo-profiler [INFO] finished tweaking git repo https://github.com/kernelmachine/cargo-profiler [INFO] tweaked toml for git repo https://github.com/kernelmachine/cargo-profiler written to /workspace/builds/worker-32/source/Cargo.toml [INFO] crate git repo https://github.com/kernelmachine/cargo-profiler 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] [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-32/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-32/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] [stdout] 549586e14bf806ed07b3a0583ad725243bd81e790eb080ebbc9cc86a8ddfe98c [INFO] running `Command { std: "docker" "start" "-a" "549586e14bf806ed07b3a0583ad725243bd81e790eb080ebbc9cc86a8ddfe98c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "549586e14bf806ed07b3a0583ad725243bd81e790eb080ebbc9cc86a8ddfe98c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "549586e14bf806ed07b3a0583ad725243bd81e790eb080ebbc9cc86a8ddfe98c", kill_on_drop: false }` [INFO] [stdout] 549586e14bf806ed07b3a0583ad725243bd81e790eb080ebbc9cc86a8ddfe98c [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-32/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-32/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] 5a4204d99bcdeab09acf0f2f2000b09d825e180419f2c617c0771c255bb2b127 [INFO] running `Command { std: "docker" "start" "-a" "5a4204d99bcdeab09acf0f2f2000b09d825e180419f2c617c0771c255bb2b127", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling autocfg v0.1.7 [INFO] [stderr] Compiling proc-macro2 v1.0.27 [INFO] [stderr] Compiling syn v1.0.73 [INFO] [stderr] Compiling serde_derive v1.0.122 [INFO] [stderr] Compiling memchr v2.2.1 [INFO] [stderr] Compiling libc v0.2.65 [INFO] [stderr] Compiling serde v1.0.122 [INFO] [stderr] Compiling ryu v1.0.2 [INFO] [stderr] Compiling serde_json v1.0.60 [INFO] [stderr] Compiling ndarray v0.13.1 [INFO] [stderr] Compiling rawpointer v0.2.1 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling unicode-width v0.1.6 [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling itoa v0.4.4 [INFO] [stderr] Compiling textwrap v0.11.0 [INFO] [stderr] Compiling matrixmultiply v0.2.3 [INFO] [stderr] Compiling thread_local v1.0.1 [INFO] [stderr] Compiling num-traits v0.2.8 [INFO] [stderr] Compiling num-integer v0.1.41 [INFO] [stderr] Compiling num-complex v0.2.3 [INFO] [stderr] Compiling quote v1.0.2 [INFO] [stderr] Compiling aho-corasick v0.7.6 [INFO] [stderr] Compiling atty v0.2.13 [INFO] [stderr] Compiling clap v2.33.0 [INFO] [stderr] Compiling regex v1.4.2 [INFO] [stderr] Compiling cargo-profiler v0.2.0 (/opt/rustwide/workdir) [INFO] [stdout] warning: multiple lines skipped by escaped newline [INFO] [stdout] --> src/display.rs:62:89 [INFO] [stdout] | [INFO] [stdout] 62 | \n\x1b[32mTotal LL D-Cache Misses\x1b[0m...{} ({}%)\t\x1b[0m\n\n\ [INFO] [stdout] | _________________________________________________________________________________________^ [INFO] [stdout] 63 | | [INFO] [stdout] 64 | | ", [INFO] [stdout] | |____________________^ skipping everything up to and including this point [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stdout] --> src/err.rs:128:48 [INFO] [stdout] | [INFO] [stdout] 128 | ProfError::IOError(ref err) => err.description(), [INFO] [stdout] | ^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(deprecated)]` on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: unused return value of `collect` that must be used [INFO] [stdout] --> src/parse/cachegrind.rs:136:13 [INFO] [stdout] | [INFO] [stdout] 136 | func.to_mut().drain(idx..).collect::(); [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_must_use)]` on by default [INFO] [stdout] = note: if you really need to exhaust the iterator, consider `.for_each(drop)` instead [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: unused return value of `collect` that must be used [INFO] [stdout] --> src/parse/callgrind.rs:86:13 [INFO] [stdout] | [INFO] [stdout] 86 | func.to_mut().drain(idx..).collect::(); [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: if you really need to exhaust the iterator, consider `.for_each(drop)` instead [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: 4 warnings emitted [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 2m 07s [INFO] running `Command { std: "docker" "inspect" "5a4204d99bcdeab09acf0f2f2000b09d825e180419f2c617c0771c255bb2b127", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "5a4204d99bcdeab09acf0f2f2000b09d825e180419f2c617c0771c255bb2b127", kill_on_drop: false }` [INFO] [stdout] 5a4204d99bcdeab09acf0f2f2000b09d825e180419f2c617c0771c255bb2b127 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-32/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-32/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] [stdout] b7bd58cce1c7d624e401fb1e6fe5cb09fbf8e834469215a4358319e51198c79e [INFO] running `Command { std: "docker" "start" "-a" "b7bd58cce1c7d624e401fb1e6fe5cb09fbf8e834469215a4358319e51198c79e", kill_on_drop: false }` [INFO] [stderr] Compiling cargo-profiler v0.2.0 (/opt/rustwide/workdir) [INFO] [stdout] warning: multiple lines skipped by escaped newline [INFO] [stdout] --> src/display.rs:62:89 [INFO] [stdout] | [INFO] [stdout] 62 | \n\x1b[32mTotal LL D-Cache Misses\x1b[0m...{} ({}%)\t\x1b[0m\n\n\ [INFO] [stdout] | _________________________________________________________________________________________^ [INFO] [stdout] 63 | | [INFO] [stdout] 64 | | ", [INFO] [stdout] | |____________________^ skipping everything up to and including this point [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stdout] --> src/err.rs:128:48 [INFO] [stdout] | [INFO] [stdout] 128 | ProfError::IOError(ref err) => err.description(), [INFO] [stdout] | ^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(deprecated)]` on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: unused return value of `collect` that must be used [INFO] [stdout] --> src/parse/cachegrind.rs:136:13 [INFO] [stdout] | [INFO] [stdout] 136 | func.to_mut().drain(idx..).collect::(); [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_must_use)]` on by default [INFO] [stdout] = note: if you really need to exhaust the iterator, consider `.for_each(drop)` instead [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: unused return value of `collect` that must be used [INFO] [stdout] --> src/parse/callgrind.rs:86:13 [INFO] [stdout] | [INFO] [stdout] 86 | func.to_mut().drain(idx..).collect::(); [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: if you really need to exhaust the iterator, consider `.for_each(drop)` instead [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: 4 warnings emitted [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 1.63s [INFO] running `Command { std: "docker" "inspect" "b7bd58cce1c7d624e401fb1e6fe5cb09fbf8e834469215a4358319e51198c79e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "b7bd58cce1c7d624e401fb1e6fe5cb09fbf8e834469215a4358319e51198c79e", kill_on_drop: false }` [INFO] [stdout] b7bd58cce1c7d624e401fb1e6fe5cb09fbf8e834469215a4358319e51198c79e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-32/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-32/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] [stdout] c87a218b521d9020b84e26811d548bb80cb56a0808b3e9f9008e362c8ec28c6a [INFO] running `Command { std: "docker" "start" "-a" "c87a218b521d9020b84e26811d548bb80cb56a0808b3e9f9008e362c8ec28c6a", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] warning: multiple lines skipped by escaped newline [INFO] [stderr] --> src/display.rs:62:89 [INFO] [stderr] | [INFO] [stderr] 62 | \n\x1b[32mTotal LL D-Cache Misses\x1b[0m...{} ({}%)\t\x1b[0m\n\n\ [INFO] [stderr] | _________________________________________________________________________________________^ [INFO] [stderr] 63 | | [INFO] [stderr] 64 | | ", [INFO] [stderr] | |____________________^ skipping everything up to and including this point [INFO] [stderr] [INFO] [stderr] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stderr] --> src/err.rs:128:48 [INFO] [stderr] | [INFO] [stderr] 128 | ProfError::IOError(ref err) => err.description(), [INFO] [stderr] | ^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(deprecated)]` on by default [INFO] [stderr] [INFO] [stderr] warning: unused return value of `collect` that must be used [INFO] [stderr] --> src/parse/cachegrind.rs:136:13 [INFO] [stderr] | [INFO] [stderr] 136 | func.to_mut().drain(idx..).collect::(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(unused_must_use)]` on by default [INFO] [stderr] = note: if you really need to exhaust the iterator, consider `.for_each(drop)` instead [INFO] [stderr] [INFO] [stderr] warning: unused return value of `collect` that must be used [INFO] [stderr] --> src/parse/callgrind.rs:86:13 [INFO] [stderr] | [INFO] [stderr] 86 | func.to_mut().drain(idx..).collect::(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: if you really need to exhaust the iterator, consider `.for_each(drop)` instead [INFO] [stderr] [INFO] [stderr] warning: `cargo-profiler` (bin "cargo-profiler" test) generated 4 warnings [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 1m 39s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/cargo_profiler-d51e86fc9deab80b) [INFO] [stdout] [INFO] [stdout] running 14 tests [INFO] [stdout] test argparse::test::test_get_binary ... ok [INFO] [stdout] test argparse::test::test_get_num ... ok [INFO] [stdout] test parse::cachegrind::test::test_cachegrind_parse_3 ... ok [INFO] [stdout] test parse::callgrind::test::test_callgrind_parse_1 ... ok [INFO] [stdout] test cargo::test::test_build_binary ... ok [INFO] [stdout] test parse::callgrind::test::test_callgrind_parse_3 ... ok [INFO] [stdout] test cargo::test::test_find_target ... ok [INFO] [stdout] test parse::cachegrind::test::test_cachegrind_parse_2 ... ok [INFO] [stdout] test argparse::test::test_get_profiler ... ok [INFO] [stdout] test parse::cachegrind::test::test_cachegrind_parse_1 ... ok [INFO] [stdout] test argparse::test::test_get_sort_metric ... ok [INFO] [stdout] test cargo::test::test_get_package_name ... ok [INFO] [stdout] test parse::callgrind::test::test_callgrind_parse_2 ... ok [INFO] [stdout] test display::test::test_fmt_thousands_sep ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "c87a218b521d9020b84e26811d548bb80cb56a0808b3e9f9008e362c8ec28c6a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c87a218b521d9020b84e26811d548bb80cb56a0808b3e9f9008e362c8ec28c6a", kill_on_drop: false }` [INFO] [stdout] c87a218b521d9020b84e26811d548bb80cb56a0808b3e9f9008e362c8ec28c6a