[INFO] fetching crate hifitime 0.1.5...
[INFO] extracting crate hifitime 0.1.5 into work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/reg/hifitime/0.1.5
[INFO] extracting crate hifitime 0.1.5 into work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/reg/hifitime/0.1.5
[INFO] validating manifest of hifitime-0.1.5 on toolchain master#c8865d8e195813ade6b84434ac9f8850e7112d1a
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] validating manifest of hifitime-0.1.5 on toolchain try#e212b7d492c96d3837691ba29d32d5f468933fb8
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started frobbing hifitime-0.1.5
[INFO] finished frobbing hifitime-0.1.5
[INFO] frobbed toml for hifitime-0.1.5 written to work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/reg/hifitime/0.1.5/Cargo.toml
[INFO] started frobbing hifitime-0.1.5
[INFO] finished frobbing hifitime-0.1.5
[INFO] frobbed toml for hifitime-0.1.5 written to work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/reg/hifitime/0.1.5/Cargo.toml
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] [stderr]     Blocking waiting for file lock on package cache lock
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing hifitime-0.1.5 against try#e212b7d492c96d3837691ba29d32d5f468933fb8 for pr-61629
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-4/try#e212b7d492c96d3837691ba29d32d5f468933fb8:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/reg/hifitime/0.1.5:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "build" "--frozen"`
[INFO] [stdout] a8064c3615a8427500ffd50045dd54bbe27cf45f9ca79f5812d400060bca3e9e
[INFO] running `"docker" "start" "-a" "a8064c3615a8427500ffd50045dd54bbe27cf45f9ca79f5812d400060bca3e9e"`
[INFO] [stderr]    Compiling hifitime v0.1.5 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.71s
[INFO] running `"docker" "inspect" "a8064c3615a8427500ffd50045dd54bbe27cf45f9ca79f5812d400060bca3e9e"`
[INFO] running `"docker" "rm" "-f" "a8064c3615a8427500ffd50045dd54bbe27cf45f9ca79f5812d400060bca3e9e"`
[INFO] [stdout] a8064c3615a8427500ffd50045dd54bbe27cf45f9ca79f5812d400060bca3e9e
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-4/try#e212b7d492c96d3837691ba29d32d5f468933fb8:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/reg/hifitime/0.1.5:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "test" "--frozen" "--no-run"`
[INFO] [stdout] 5cb0f9dbef9e50d7fddeff1d7fb4f58a3beb11ec669f53f7d796464355187a88
[INFO] running `"docker" "start" "-a" "5cb0f9dbef9e50d7fddeff1d7fb4f58a3beb11ec669f53f7d796464355187a88"`
[INFO] [stderr]    Compiling hifitime v0.1.5 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.07s
[INFO] running `"docker" "inspect" "5cb0f9dbef9e50d7fddeff1d7fb4f58a3beb11ec669f53f7d796464355187a88"`
[INFO] running `"docker" "rm" "-f" "5cb0f9dbef9e50d7fddeff1d7fb4f58a3beb11ec669f53f7d796464355187a88"`
[INFO] [stdout] 5cb0f9dbef9e50d7fddeff1d7fb4f58a3beb11ec669f53f7d796464355187a88
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-4/try#e212b7d492c96d3837691ba29d32d5f468933fb8:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/reg/hifitime/0.1.5:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "test" "--frozen"`
[INFO] [stdout] 5f76291217cd5f95c7ccfffb1b5b60823d7dcece0b6ae129ea7e0761fcb753fb
[INFO] running `"docker" "start" "-a" "5f76291217cd5f95c7ccfffb1b5b60823d7dcece0b6ae129ea7e0761fcb753fb"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/hifitime-6ed7c322d3d769af
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test error_unittest ... ok
[INFO] [stdout] test durations ... ok
[INFO] [stdout] test datetime::quorem_nominal_test ... ok
[INFO] [stdout] test instant::instant_unittest ... ok
[INFO] [stdout] test instant::era_unittest ... ok
[INFO] [stdout] test datetime::quorem_nil_den_test ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/datetime-308658c180bc10e7
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test datetime_extras ... ok
[INFO] [stdout] test datetime_invalid_dates ... ok
[INFO] [stdout] test datetime_time_varying_offset ... ok
[INFO] [stdout] test datetime_parsing ... ok
[INFO] [stdout] test datetime_valid_dates ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/julian-48dfdbc95004c879
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test epochs ... ok
[INFO] [stdout] test jd_tt ... ok
[INFO] [stdout] test reciprocity ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/lib-5d2ddf8423cfe2b0
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test datetime::datetime_invalid_dates ... ok
[INFO] [stdout] test datetime::datetime_time_varying_offset ... ok
[INFO] [stdout] test julian::jd_tt ... ok
[INFO] [stdout] test julian::epochs ... ok
[INFO] [stdout] test datetime::datetime_extras ... ok
[INFO] [stdout] test julian::reciprocity ... ok
[INFO] [stdout] test datetime::datetime_parsing ... ok
[INFO] [stdout] test datetime::datetime_valid_dates ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/sim-db4fa1a6509e903a
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests hifitime
[INFO] [stdout] 
[INFO] [stdout] running 22 tests
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::sub (line 649) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::at_noon (line 417) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::at_midnight (line 390) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::fmt (line 608) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::add (line 631) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::fmt (line 587) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::new (line 151) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::from_str (line 670) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::with_offset (line 266) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::FixedOffset::west_with_hours (line 103) ... ok
[INFO] [stdout] test src/instant.rs - instant::Era (line 17) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::FixedOffset::east_with_hours (line 80) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Offset (line 32) ... ok
[INFO] [stdout] test src/instant.rs - instant::Instant::from_precise_seconds (line 94) ... ok
[INFO] [stdout] test src/instant.rs - instant::Instant::now (line 136) ... ok
[INFO] [stdout] test src/instant.rs - instant::Instant::add (line 190) ... ok
[INFO] [stdout] test src/instant.rs - instant::Instant::new (line 52) ... ok
[INFO] [stdout] test src/instant.rs - instant::Instant::sub (line 255) ... ok
[INFO] [stdout] test src/instant.rs - instant::Instant::unix_epoch (line 119) ... ok
[INFO] [stdout] test src/lib.rs -  (line 49) ... ok
[INFO] [stdout] test src/instant.rs - instant::Instant::sub (line 320) ... ok
[INFO] [stdout] test src/lib.rs -  (line 55) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "5f76291217cd5f95c7ccfffb1b5b60823d7dcece0b6ae129ea7e0761fcb753fb"`
[INFO] running `"docker" "rm" "-f" "5f76291217cd5f95c7ccfffb1b5b60823d7dcece0b6ae129ea7e0761fcb753fb"`
[INFO] [stdout] 5f76291217cd5f95c7ccfffb1b5b60823d7dcece0b6ae129ea7e0761fcb753fb