[INFO] fetching crate rusty-logger 0.3.0... [INFO] testing rusty-logger-0.3.0 against master#caccb4d0368bd918ef6668af8e13834d07040417 for pr-146098-1 [INFO] extracting crate rusty-logger 0.3.0 into /workspace/builds/worker-0-tc1/source [INFO] started tweaking crates.io crate rusty-logger 0.3.0 [INFO] finished tweaking crates.io crate rusty-logger 0.3.0 [INFO] tweaked toml for crates.io crate rusty-logger 0.3.0 written to /workspace/builds/worker-0-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate rusty-logger 0.3.0 on toolchain caccb4d0368bd918ef6668af8e13834d07040417 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Locking 44 packages to latest compatible versions [INFO] [stderr] Adding colored v2.2.0 (available: v3.0.0) [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] bc2d7204144ea2647898d7ba4683a2a8006308f11ae5a5844837bb44de151b2a [INFO] running `Command { std: "docker" "start" "-a" "bc2d7204144ea2647898d7ba4683a2a8006308f11ae5a5844837bb44de151b2a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "bc2d7204144ea2647898d7ba4683a2a8006308f11ae5a5844837bb44de151b2a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "bc2d7204144ea2647898d7ba4683a2a8006308f11ae5a5844837bb44de151b2a", kill_on_drop: false }` [INFO] [stdout] bc2d7204144ea2647898d7ba4683a2a8006308f11ae5a5844837bb44de151b2a [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 25a246b63053342b3fab98d2da70a89dc4bbfcea7482bd256575ebc22babfbd4 [INFO] running `Command { std: "docker" "start" "-a" "25a246b63053342b3fab98d2da70a89dc4bbfcea7482bd256575ebc22babfbd4", kill_on_drop: false }` [INFO] [stderr] Compiling colored v2.2.0 [INFO] [stderr] Compiling chrono v0.4.42 [INFO] [stderr] Compiling rusty-logger v0.3.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.84s [INFO] running `Command { std: "docker" "inspect" "25a246b63053342b3fab98d2da70a89dc4bbfcea7482bd256575ebc22babfbd4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "25a246b63053342b3fab98d2da70a89dc4bbfcea7482bd256575ebc22babfbd4", kill_on_drop: false }` [INFO] [stdout] 25a246b63053342b3fab98d2da70a89dc4bbfcea7482bd256575ebc22babfbd4 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 1873c75d504b0b93de845be7563f5893f6a51fc709d695f2d0be65a227f86035 [INFO] running `Command { std: "docker" "start" "-a" "1873c75d504b0b93de845be7563f5893f6a51fc709d695f2d0be65a227f86035", kill_on_drop: false }` [INFO] [stderr] Compiling rusty-logger v0.3.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.52s [INFO] running `Command { std: "docker" "inspect" "1873c75d504b0b93de845be7563f5893f6a51fc709d695f2d0be65a227f86035", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "1873c75d504b0b93de845be7563f5893f6a51fc709d695f2d0be65a227f86035", kill_on_drop: false }` [INFO] [stdout] 1873c75d504b0b93de845be7563f5893f6a51fc709d695f2d0be65a227f86035 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 7581f9416d40dead8736907e8f97a8ab8950b8db212d59f8af206f3ebf518036 [INFO] running `Command { std: "docker" "start" "-a" "7581f9416d40dead8736907e8f97a8ab8950b8db212d59f8af206f3ebf518036", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rusty_logger-7e5860c7c1e891bb) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] [MAIN][18:33:09][INFO]: We will be testing a fibonnaci function [INFO] [stdout] [MAIN][18:33:09][INFO]: Starting fibonnaci(30) [INFO] [stdout] [MAIN][18:33:09][TIME]: fibonnaci - 2μs [INFO] [stdout] [MAIN][18:33:09][TIME]: wrap - 73μs [INFO] [stdout] [MAIN][18:33:09][INFO]: The result of the fibonnaci function until 30 is : 832040 [INFO] [stdout] test tests::log ... 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 rusty_logger [INFO] [stdout] [INFO] [stdout] running 11 tests [INFO] [stdout] test src/modules.rs - modules::Module (line 10) ... ok [INFO] [stdout] test src/logger.rs - logger::Logger::info (line 151) ... ok [INFO] [stdout] test src/logger.rs - logger::Logger::error (line 183) ... ok [INFO] [stdout] test src/logger.rs - logger::Logger::new (line 49) ... ok [INFO] [stdout] test src/logger.rs - logger::Logger::timer_log_and_reset (line 296) ... ok [INFO] [stdout] test src/logger.rs - logger::Logger::timer_log_and_stop (line 274) ... ok [INFO] [stdout] test src/logger.rs - logger::Logger::static_log (line 136) ... ok [INFO] [stdout] test src/logger.rs - logger::Logger::warn (line 167) ... ok [INFO] [stdout] test src/logger.rs - logger::Logger::timer_log (line 237) ... ok [INFO] [stdout] test src/logger.rs - logger::Logger (line 11) ... ok [INFO] [stdout] test src/logger.rs - logger::Logger::homemade (line 74) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.49s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "7581f9416d40dead8736907e8f97a8ab8950b8db212d59f8af206f3ebf518036", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "7581f9416d40dead8736907e8f97a8ab8950b8db212d59f8af206f3ebf518036", kill_on_drop: false }` [INFO] [stdout] 7581f9416d40dead8736907e8f97a8ab8950b8db212d59f8af206f3ebf518036