[INFO] fetching crate timelane 0.1.1...
[INFO] testing timelane-0.1.1 against try#b83b707f97d809763b7861afa7638871f3339a33 for pr-145838-1
[INFO] extracting crate timelane 0.1.1 into /workspace/builds/worker-7-tc2/source
[INFO] started tweaking crates.io crate timelane 0.1.1
[INFO] finished tweaking crates.io crate timelane 0.1.1
[INFO] tweaked toml for crates.io crate timelane 0.1.1 written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate timelane 0.1.1 on toolchain b83b707f97d809763b7861afa7638871f3339a33
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "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" "+b83b707f97d809763b7861afa7638871f3339a33" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 1ce9545e4111c61faed4e9f87d128a74c4feff90a25affed344a26f7205f14e7
[INFO] running `Command { std: "docker" "start" "-a" "1ce9545e4111c61faed4e9f87d128a74c4feff90a25affed344a26f7205f14e7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1ce9545e4111c61faed4e9f87d128a74c4feff90a25affed344a26f7205f14e7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1ce9545e4111c61faed4e9f87d128a74c4feff90a25affed344a26f7205f14e7", kill_on_drop: false }`
[INFO] [stdout] 1ce9545e4111c61faed4e9f87d128a74c4feff90a25affed344a26f7205f14e7
[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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6924dca3b97d2a72ee2e669f1527a0c3b5d6372687ac81d6bbd22939104f674b
[INFO] running `Command { std: "docker" "start" "-a" "6924dca3b97d2a72ee2e669f1527a0c3b5d6372687ac81d6bbd22939104f674b", kill_on_drop: false }`
[INFO] [stderr]    Compiling timelane v0.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.20s
[INFO] running `Command { std: "docker" "inspect" "6924dca3b97d2a72ee2e669f1527a0c3b5d6372687ac81d6bbd22939104f674b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6924dca3b97d2a72ee2e669f1527a0c3b5d6372687ac81d6bbd22939104f674b", kill_on_drop: false }`
[INFO] [stdout] 6924dca3b97d2a72ee2e669f1527a0c3b5d6372687ac81d6bbd22939104f674b
[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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 99383b1689b5a92917330410e0fd6d5dec28b0c9d8d1a6003950dbb5f8d63c54
[INFO] running `Command { std: "docker" "start" "-a" "99383b1689b5a92917330410e0fd6d5dec28b0c9d8d1a6003950dbb5f8d63c54", kill_on_drop: false }`
[INFO] [stderr]    Compiling timelane v0.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.53s
[INFO] running `Command { std: "docker" "inspect" "99383b1689b5a92917330410e0fd6d5dec28b0c9d8d1a6003950dbb5f8d63c54", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "99383b1689b5a92917330410e0fd6d5dec28b0c9d8d1a6003950dbb5f8d63c54", kill_on_drop: false }`
[INFO] [stdout] 99383b1689b5a92917330410e0fd6d5dec28b0c9d8d1a6003950dbb5f8d63c54
[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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 4442fd4f58841f76b5044067e247f691601f67c800200f5923042ee6059910b2
[INFO] running `Command { std: "docker" "start" "-a" "4442fd4f58841f76b5044067e247f691601f67c800200f5923042ee6059910b2", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/timelane-b837edf550405146)
[INFO] [stdout] running 50 tests
[INFO] [stdout] test tests::day_0_is_hour_minus_24 ... ok
[INFO] [stdout] test tests::days_1_to_31_are_month_1 ... ok
[INFO] [stdout] test tests::divide_towards_negative_infinity_rounds_down ... ok
[INFO] [stdout] test tests::day_1_is_hour_0 ... ok
[INFO] [stdout] test tests::days_minus_30_to_0_are_month_0 ... ok
[INFO] [stdout] test tests::leap_years_have_29_days_in_february ... ok
[INFO] [stdout] test tests::minute_1_is_second_60 ... ok
[INFO] [stdout] test tests::minute_60_is_hour_1 ... ok
[INFO] [stdout] test tests::leap_years_are_every_4_years_except_100_except_400 ... ok
[INFO] [stdout] test tests::hour_24_is_day_2 ... ok
[INFO] [stdout] test tests::hours_0_to_23_are_day_1 ... ok
[INFO] [stdout] test tests::epoch_year_is_month_1 ... ok
[INFO] [stdout] test tests::minutes_0_to_59_is_hour_0 ... ok
[INFO] [stdout] test tests::hour_0_is_minute_0 ... ok
[INFO] [stdout] test tests::divide_towards_positive_infinity_rounds_up ... ok
[INFO] [stdout] test tests::day_2_is_hour_24 ... ok
[INFO] [stdout] test tests::leap_seconds_are_at_end_of_december_in_sixteen_years ... ok
[INFO] [stdout] test tests::hour_1_is_minute_60 ... ok
[INFO] [stdout] test tests::minute_0_is_second_0 ... ok
[INFO] [stdout] test tests::month_0_is_day_minus_30 ... ok
[INFO] [stdout] test tests::month_13_is_year_after_epoch_year ... ok
[INFO] [stdout] test tests::month_1_is_day_1 ... ok
[INFO] [stdout] test tests::minutes_with_leap_seconds_are_61_seconds_at_end_of_december_in_sixteen_years ... ok
[INFO] [stdout] test tests::leap_seconds_are_at_end_of_june_in_eleven_years ... ok
[INFO] [stdout] test tests::day_32_is_month_2 ... ok
[INFO] [stdout] test tests::minutes_with_leap_seconds_are_61_seconds_at_end_of_june_in_eleven_years ... ok
[INFO] [stdout] test tests::month_1_to_12_are_epoch_year ... ok
[INFO] [stdout] test tests::month_2_is_day_32 ... ok
[INFO] [stdout] test tests::month_2_of_year_100_is_28_days ... ok
[INFO] [stdout] test tests::month_2_of_year_400_is_29_days ... ok
[INFO] [stdout] test tests::normal_years_have_standard_month_lengths ... ok
[INFO] [stdout] test tests::second_60_is_minute_1 ... ok
[INFO] [stdout] test tests::year_0_is_leap_year ... ok
[INFO] [stdout] test tests::year_1_is_not_leap_year ... ok
[INFO] [stdout] test tests::year_400_is_leap_year ... ok
[INFO] [stdout] test tests::year_before_epoch_year_is_month_minus_11 ... ok
[INFO] [stdout] test tests::year_minus_100_is_not_leap_year ... ok
[INFO] [stdout] test tests::year_minus_4_is_leap_year ... ok
[INFO] [stdout] test tests::year_minus_400_is_leap_year ... ok
[INFO] [stdout] test tests::second_to_minute_up_roundtrip_near_limits ... ok
[INFO] [stdout] test tests::month_2_of_year_4_is_29_days ... ok
[INFO] [stdout] test tests::year_4_is_leap_year ... ok
[INFO] [stdout] test tests::year_after_epoch_year_is_month_13 ... ok
[INFO] [stdout] test tests::month_2_of_year_1_is_28_days ... ok
[INFO] [stdout] test tests::month_minus_11_to_0_is_year_before_epoch_year ... ok
[INFO] [stdout] test tests::seconds_0_to_59_are_minute_0 ... ok
[INFO] [stdout] test tests::year_100_is_not_leap_year ... ok
[INFO] [stdout] test tests::second_to_minute_roundtrip_near_limits ... ok
[INFO] [stdout] test tests::days_of_leap_year_match_leap_year_months ... ok
[INFO] [stdout] test tests::days_of_normal_year_match_standard_months ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 50 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.20s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests timelane
[INFO] [stdout] 
[INFO] [stdout] running 26 tests
[INFO] [stdout] test src/lib.rs - hour_to_day_up (line 295) ... ok
[INFO] [stdout] test src/lib.rs - day_to_month (line 317) ... ok
[INFO] [stdout] test src/lib.rs - day_to_month_up (line 348) ... ok
[INFO] [stdout] test src/lib.rs - minute_to_second (line 176) ... ok
[INFO] [stdout] test src/lib.rs - minute_to_hour_up (line 255) ... ok
[INFO] [stdout] test src/lib.rs - leap_days_before_year (line 461) ... ok
[INFO] [stdout] test src/lib.rs - minute_to_hour (line 237) ... ok
[INFO] [stdout] test src/lib.rs - month_to_year_up (line 430) ... ok
[INFO] [stdout] test src/lib.rs - month_to_year (line 405) ... ok
[INFO] [stdout] test src/lib.rs - hour_to_day (line 275) ... ok
[INFO] [stdout] test src/lib.rs - hour_to_minute (line 158) ... ok
[INFO] [stdout] test src/lib.rs - second_to_minute (line 194) ... ok
[INFO] [stdout] test src/lib.rs - second_to_minute_up (line 216) ... ok
[INFO] [stdout] test src/lib.rs - day_to_hour (line 141) ... ok
[INFO] [stdout] test src/subsecond.rs - subsecond::millisecond_to_second_up (line 126) ... ok
[INFO] [stdout] test src/lib.rs - year_to_month (line 94) ... ok
[INFO] [stdout] test src/subsecond.rs - subsecond::nanosecond_to_second (line 16) ... ok
[INFO] [stdout] test src/lib.rs - month_to_day (line 113) ... ok
[INFO] [stdout] test src/subsecond.rs - subsecond::second_to_microsecond (line 95) ... ok
[INFO] [stdout] test src/lib.rs - leap_seconds_before_minute (line 485) ... ok
[INFO] [stdout] test src/subsecond.rs - subsecond::millisecond_to_second (line 110) ... ok
[INFO] [stdout] test src/subsecond.rs - subsecond::microsecond_to_second_up (line 79) ... ok
[INFO] [stdout] test src/subsecond.rs - subsecond::nanosecond_to_second_up (line 32) ... ok
[INFO] [stdout] test src/subsecond.rs - subsecond::second_to_millisecond (line 142) ... ok
[INFO] [stdout] test src/subsecond.rs - subsecond::microsecond_to_second (line 63) ... ok
[INFO] [stdout] test src/subsecond.rs - subsecond::second_to_nanosecond (line 48) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.02s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "4442fd4f58841f76b5044067e247f691601f67c800200f5923042ee6059910b2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4442fd4f58841f76b5044067e247f691601f67c800200f5923042ee6059910b2", kill_on_drop: false }`
[INFO] [stdout] 4442fd4f58841f76b5044067e247f691601f67c800200f5923042ee6059910b2