[INFO] fetching crate chrono-machines 0.3.0...
[INFO] testing chrono-machines-0.3.0 against try#8da20828b6ea601dfd8e2448cb50ace88876bd78 for pr-150933
[INFO] extracting crate chrono-machines 0.3.0 into /workspace/builds/worker-7-tc2/source
[INFO] started tweaking crates.io crate chrono-machines 0.3.0
[INFO] finished tweaking crates.io crate chrono-machines 0.3.0
[INFO] tweaked toml for crates.io crate chrono-machines 0.3.0 written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate chrono-machines 0.3.0 on toolchain 8da20828b6ea601dfd8e2448cb50ace88876bd78
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate chrono-machines 0.3.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 10a6596e637b27e54c133cb69f5c1de9731761d3dafe580ab8bd838ef77db4ed
[INFO] running `Command { std: "docker" "start" "-a" "10a6596e637b27e54c133cb69f5c1de9731761d3dafe580ab8bd838ef77db4ed", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "10a6596e637b27e54c133cb69f5c1de9731761d3dafe580ab8bd838ef77db4ed", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "10a6596e637b27e54c133cb69f5c1de9731761d3dafe580ab8bd838ef77db4ed", kill_on_drop: false }`
[INFO] [stdout] 10a6596e637b27e54c133cb69f5c1de9731761d3dafe580ab8bd838ef77db4ed
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 0423351b7a2bcbc1ef5a9e2601f919465baa26494aa1e9ce6ed1814a4a8ac4ba
[INFO] running `Command { std: "docker" "start" "-a" "0423351b7a2bcbc1ef5a9e2601f919465baa26494aa1e9ce6ed1814a4a8ac4ba", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.177
[INFO] [stderr]    Compiling zerocopy v0.8.27
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling rand_core v0.9.3
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling chrono-machines v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 3.90s
[INFO] running `Command { std: "docker" "inspect" "0423351b7a2bcbc1ef5a9e2601f919465baa26494aa1e9ce6ed1814a4a8ac4ba", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0423351b7a2bcbc1ef5a9e2601f919465baa26494aa1e9ce6ed1814a4a8ac4ba", kill_on_drop: false }`
[INFO] [stdout] 0423351b7a2bcbc1ef5a9e2601f919465baa26494aa1e9ce6ed1814a4a8ac4ba
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d4eb0cca3845b612bc8f700ea0a1d3b31862ab778862e09d6f6fd42b66ad8330
[INFO] running `Command { std: "docker" "start" "-a" "d4eb0cca3845b612bc8f700ea0a1d3b31862ab778862e09d6f6fd42b66ad8330", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.101
[INFO] [stderr]    Compiling unicode-ident v1.0.19
[INFO] [stderr]    Compiling quote v1.0.41
[INFO] [stderr]    Compiling syn v2.0.107
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling tokio v1.48.0
[INFO] [stderr]    Compiling chrono-machines v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 9.94s
[INFO] running `Command { std: "docker" "inspect" "d4eb0cca3845b612bc8f700ea0a1d3b31862ab778862e09d6f6fd42b66ad8330", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d4eb0cca3845b612bc8f700ea0a1d3b31862ab778862e09d6f6fd42b66ad8330", kill_on_drop: false }`
[INFO] [stdout] d4eb0cca3845b612bc8f700ea0a1d3b31862ab778862e09d6f6fd42b66ad8330
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 8d68fd066f3399404563dc191db5150df93709fe04d27ff506f580d07280672c
[INFO] running `Command { std: "docker" "start" "-a" "8d68fd066f3399404563dc191db5150df93709fe04d27ff506f580d07280672c", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/chrono_machines-fd5e2cb7ce9b69f4)
[INFO] [stdout] running 46 tests
[INFO] [stdout] test backoff::tests::test_jitter_application ... ok
[INFO] [stdout] test backoff::tests::test_fibonacci_sequence ... ok
[INFO] [stdout] test backoff::tests::test_exponential_backoff_builder ... ok
[INFO] [stdout] test backoff::tests::test_fibonacci_backoff ... ok
[INFO] [stdout] test policy::tests::test_global_registry_roundtrip ... ok
[INFO] [stdout] test policy::tests::test_registry_crud ... ok
[INFO] [stdout] test dsl::tests::test_retry_with_policy_missing ... ok
[INFO] [stdout] test backoff::tests::test_exponential_delays ... ok
[INFO] [stdout] test retry::tests::test_on_failure_callback_invoked ... ok
[INFO] [stdout] test retry::tests::test_on_success_callback_invoked ... ok
[INFO] [stdout] test retry::tests::test_retry_context_comprehensive ... ok
[INFO] [stdout] test retry::tests::test_retry_context_cumulative_accuracy ... ok
[INFO] [stdout] test retry::tests::test_all_extension_methods_produce_working_retries ... ok
[INFO] [stdout] test retry::tests::test_retry_exhausted ... ok
[INFO] [stdout] test retry::tests::test_retry_notify_callback ... ok
[INFO] [stdout] test retry::tests::test_retry_success_after_failures ... ok
[INFO] [stdout] test retry::tests::test_retry_success_on_first_attempt ... ok
[INFO] [stdout] test retry::tests::test_retry_context_on_success ... ok
[INFO] [stdout] test retry::tests::test_with_constant_std_sleeper ... ok
[INFO] [stdout] test retry::tests::test_with_constant_success ... ok
[INFO] [stdout] test retry::tests::test_with_exponential_chaining ... ok
[INFO] [stdout] test retry::tests::test_with_constant_uses_correct_delay ... ok
[INFO] [stdout] test retry::tests::test_with_exponential_exhausted ... ok
[INFO] [stdout] test retry::tests::test_with_exponential_retry_behavior ... ok
[INFO] [stdout] test retry::tests::test_with_exponential_success ... ok
[INFO] [stdout] test retry::tests::test_with_constant_chaining ... ok
[INFO] [stdout] test retry::tests::test_with_fibonacci_chaining ... ok
[INFO] [stdout] test retry::tests::test_retry_when_predicate ... ok
[INFO] [stdout] test retry::tests::test_with_fibonacci_exhausted ... ok
[INFO] [stdout] test retry::tests::test_with_fibonacci_retry_behavior ... ok
[INFO] [stdout] test retry::tests::test_with_fibonacci_std_sleeper ... ok
[INFO] [stdout] test retry::tests::test_with_fibonacci_success ... ok
[INFO] [stdout] test sleep::tests::test_fn_sleeper ... ok
[INFO] [stdout] test tests::test_jitter_factor ... ok
[INFO] [stdout] test tests::test_jitter_factor_clamping ... ok
[INFO] [stdout] test tests::test_policy_default ... ok
[INFO] [stdout] test tests::test_should_retry ... ok
[INFO] [stdout] test tests::test_zero_multiplier ... ok
[INFO] [stdout] test tests::test_max_delay_cap ... ok
[INFO] [stdout] test tests::test_calculate_delay_bounds ... ok
[INFO] [stdout] test retry::tests::test_constant_backoff_retry ... ok
[INFO] [stdout] test retry::tests::test_retry_with_std_sleeper ... ok
[INFO] [stdout] test sleep::tests::test_std_sleeper ... ok
[INFO] [stdout] test dsl::tests::test_retry_with_policy_success ... ok
[INFO] [stdout] test retry::tests::test_with_exponential_std_sleeper ... ok
[INFO] [stderr]    Doc-tests chrono_machines
[INFO] [stdout] test backoff::tests::test_constant_backoff ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 46 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stdout] test src/lib.rs - (line 15) ... ok
[INFO] [stdout] test src/backoff.rs - backoff::ExponentialBackoff (line 43) ... ok
[INFO] [stdout] test src/lib.rs - Policy::calculate_delay (line 121) ... ok
[INFO] [stdout] test src/retry.rs - retry::RetryBuilder<F,B,T,E,W>::call_with_sleeper (line 533) ... ok
[INFO] [stdout] test src/retry.rs - retry::RetryBuilder<F,B,T,E,W>::notify (line 433) ... ok
[INFO] [stdout] test src/backoff.rs - backoff::ConstantBackoff (line 150) ... ok
[INFO] [stdout] test src/retry.rs - retry::RetryableExt::with_constant (line 298) ... ok
[INFO] [stdout] test src/retry.rs - retry::RetryableExt (line 234) ... ok
[INFO] [stdout] test src/retry.rs - retry::Retryable (line 179) ... ok
[INFO] [stdout] test src/retry.rs - retry::RetryableExt::with_exponential (line 264) ... ok
[INFO] [stdout] test src/retry.rs - retry::RetryableExt::with_fibonacci (line 333) ... ok
[INFO] [stdout] test src/retry.rs - retry::RetryBuilder<F,B,T,E,W>::call (line 497) ... ok
[INFO] [stdout] test src/backoff.rs - backoff::FibonacciBackoff (line 236) ... ok
[INFO] [stdout] test src/sleep.rs - sleep::FnSleeper (line 49) ... ok
[INFO] [stdout] test src/sleep.rs - sleep::StdSleeper (line 24) ... ok
[INFO] [stdout] test src/retry.rs - retry::RetryBuilder<F,B,T,E,W>::when (line 391) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.68s; merged doctests compilation took 0.55s
[INFO] running `Command { std: "docker" "inspect" "8d68fd066f3399404563dc191db5150df93709fe04d27ff506f580d07280672c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8d68fd066f3399404563dc191db5150df93709fe04d27ff506f580d07280672c", kill_on_drop: false }`
[INFO] [stdout] 8d68fd066f3399404563dc191db5150df93709fe04d27ff506f580d07280672c