[INFO] fetching crate libsw 3.2.4...
[INFO] testing libsw-3.2.4 against 1.69.0 for beta-1.70-1
[INFO] extracting crate libsw 3.2.4 into /workspace/builds/worker-7-tc1/source
[INFO] validating manifest of crates.io crate libsw 3.2.4 on toolchain 1.69.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.69.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate libsw 3.2.4
[INFO] finished tweaking crates.io crate libsw 3.2.4
[INFO] tweaked toml for crates.io crate libsw 3.2.4 written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" __CARGO_TEST_CHANNEL_OVERRIDE_DO_NOT_USE_THIS="nightly" "/workspace/cargo-home/bin/cargo" "+1.69.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.69.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded coarsetime v0.1.23
[INFO] [stderr]   Downloaded quanta v0.11.0
[INFO] [stderr]   Downloaded mach2 v0.4.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] a8ba99128a4d505ab74e85daee88409966443ea8c62725f4894182656b79eca3
[INFO] running `Command { std: "docker" "start" "-a" "a8ba99128a4d505ab74e85daee88409966443ea8c62725f4894182656b79eca3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a8ba99128a4d505ab74e85daee88409966443ea8c62725f4894182656b79eca3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a8ba99128a4d505ab74e85daee88409966443ea8c62725f4894182656b79eca3", kill_on_drop: false }`
[INFO] [stdout] a8ba99128a4d505ab74e85daee88409966443ea8c62725f4894182656b79eca3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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=warn" "-e" "RUSTDOCFLAGS=--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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 0abb3530cf42936e0ba2e4fd90e38014a90fddfa74b8f5a4b6287b3313494539
[INFO] running `Command { std: "docker" "start" "-a" "0abb3530cf42936e0ba2e4fd90e38014a90fddfa74b8f5a4b6287b3313494539", kill_on_drop: false }`
[INFO] [stderr]    Compiling libsw v3.2.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.13s
[INFO] running `Command { std: "docker" "inspect" "0abb3530cf42936e0ba2e4fd90e38014a90fddfa74b8f5a4b6287b3313494539", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0abb3530cf42936e0ba2e4fd90e38014a90fddfa74b8f5a4b6287b3313494539", kill_on_drop: false }`
[INFO] [stdout] 0abb3530cf42936e0ba2e4fd90e38014a90fddfa74b8f5a4b6287b3313494539
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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=warn" "-e" "RUSTDOCFLAGS=--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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5a2bd8f5349f92e20a2804ae725d11eb67bf69dc5c55ca0637f32e2e22d734e0
[INFO] running `Command { std: "docker" "start" "-a" "5a2bd8f5349f92e20a2804ae725d11eb67bf69dc5c55ca0637f32e2e22d734e0", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libsw v3.2.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.36s
[INFO] running `Command { std: "docker" "inspect" "5a2bd8f5349f92e20a2804ae725d11eb67bf69dc5c55ca0637f32e2e22d734e0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5a2bd8f5349f92e20a2804ae725d11eb67bf69dc5c55ca0637f32e2e22d734e0", kill_on_drop: false }`
[INFO] [stdout] 5a2bd8f5349f92e20a2804ae725d11eb67bf69dc5c55ca0637f32e2e22d734e0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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=warn" "-e" "RUSTDOCFLAGS=--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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] d5954966a10508cf7443f964d483f3270e7ce0871c19d3fc213c41a4d4b69d0d
[INFO] running `Command { std: "docker" "start" "-a" "d5954966a10508cf7443f964d483f3270e7ce0871c19d3fc213c41a4d4b69d0d", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/libsw-c2ac683157092de0)
[INFO] [stdout] running 37 tests
[INFO] [stdout] test tests::add ... ok
[INFO] [stdout] test tests::checked_add ... ok
[INFO] [stdout] test tests::checked_add_overflow ... ok
[INFO] [stdout] test tests::checked_sub ... ok
[INFO] [stdout] test tests::checked_stop_stops ... ok
[INFO] [stdout] test tests::checked_toggle ... ok
[INFO] [stdout] test tests::default ... ok
[INFO] [stdout] test tests::double_starts_stops_errs ... ok
[INFO] [stdout] test tests::elapsed_at_saturates ... ok
[INFO] [stdout] test tests::checked_sub_overflow ... ok
[INFO] [stdout] test tests::eq_correct ... ok
[INFO] [stdout] test tests::eq_running ... ok
[INFO] [stdout] test tests::hash_running ... ok
[INFO] [stdout] test tests::eq_properties ... ok
[INFO] [stdout] test tests::is_running ... ok
[INFO] [stdout] test tests::hash_and_eq ... ok
[INFO] [stdout] test tests::partial_eq ... ok
[INFO] [stdout] test tests::replace ... ok
[INFO] [stdout] test tests::is_stopped ... ok
[INFO] [stdout] test tests::set ... ok
[INFO] [stdout] test tests::add_overloaded_overflow - should panic ... ok
[INFO] [stdout] test tests::checked_elapsed_overflows ... ok
[INFO] [stdout] test tests::sub ... ok
[INFO] [stdout] test tests::checked_stop_overflows ... ok
[INFO] [stdout] test tests::sane_elapsed_while_stopped ... ok
[INFO] [stdout] test tests::reset ... ok
[INFO] [stdout] test tests::sane_elapsed_while_running ... ok
[INFO] [stdout] test tests::set_in_place ... ok
[INFO] [stdout] test tests::start_in_future ... ok
[INFO] [stdout] test tests::toggle ... ok
[INFO] [stdout] test tests::sub_overloaded_overflow - should panic ... ok
[INFO] [stdout] test tests::stop_before_last_start ... ok
[INFO] [stdout] test tests::sync_before_sub_checked - should panic ... ok
[INFO] [stdout] test tests::sync_before_sub_checked_overflow ... ok
[INFO] [stdout] test tests::sync_before_sub_saturating - should panic ... ok
[INFO] [stdout] test tests::sub_at ... ok
[INFO] [stdout] test tests::sub_at_earlier_anchor_behavior ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 37 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.30s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests libsw
[INFO] [stdout] 
[INFO] [stdout] running 36 tests
[INFO] [stdout] test src/error.rs - error::Error::expects_running (line 57) ... ok
[INFO] [stdout] test src/error.rs - error::Error::expects_stopped (line 76) ... ok
[INFO] [stdout] test src/guard.rs - guard::Guard<'sw,I>::new (line 69) ... ok
[INFO] [stdout] test src/error.rs - error::Error (line 22) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::checked_add (line 804) ... ok
[INFO] [stdout] test src/guard.rs - guard::Guard (line 36) ... ok
[INFO] [stdout] test src/guard.rs - guard::Guard<'sw,I>::inner (line 92) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::checked_stop (line 423) ... ok
[INFO] [stdout] test src/lib.rs - (line 21) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::checked_sub (line 833) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::elapsed_at (line 221) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::checked_elapsed (line 239) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::elapsed (line 194) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::checked_toggle (line 523) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::from_raw (line 125) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::from_raw (line 138) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::is_running (line 163) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::is_stopped (line 178) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::new_started (line 49) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::new (line 32) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::new_started_at (line 65) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::saturating_add (line 757) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::reset_in_place (line 617) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::replace (line 723) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::reset (line 600) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::set (line 659) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::saturating_sub (line 784) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::set_in_place (line 676) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::toggle (line 473) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::stop_at (line 392) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::start (line 285) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::toggle_at (line 497) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::with_elapsed (line 84) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::with_elapsed_started (line 101) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::start_at (line 316) ... ok
[INFO] [stdout] test src/stopwatch.rs - stopwatch::StopwatchImpl<I>::stop (line 357) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 36 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.32s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "d5954966a10508cf7443f964d483f3270e7ce0871c19d3fc213c41a4d4b69d0d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d5954966a10508cf7443f964d483f3270e7ce0871c19d3fc213c41a4d4b69d0d", kill_on_drop: false }`
[INFO] [stdout] d5954966a10508cf7443f964d483f3270e7ce0871c19d3fc213c41a4d4b69d0d
