[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 master#c8865d8e195813ade6b84434ac9f8850e7112d1a for pr-61629
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-3/master#c8865d8e195813ade6b84434ac9f8850e7112d1a:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/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" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "build" "--frozen"`
[INFO] [stdout] cd78bef325899d3bb81f9d6418ca7cad77673614dfe2a1ae1e84739f6bd781fe
[INFO] running `"docker" "start" "-a" "cd78bef325899d3bb81f9d6418ca7cad77673614dfe2a1ae1e84739f6bd781fe"`
[INFO] [stderr]    Compiling hifitime v0.1.5 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.20s
[INFO] running `"docker" "inspect" "cd78bef325899d3bb81f9d6418ca7cad77673614dfe2a1ae1e84739f6bd781fe"`
[INFO] running `"docker" "rm" "-f" "cd78bef325899d3bb81f9d6418ca7cad77673614dfe2a1ae1e84739f6bd781fe"`
[INFO] [stdout] cd78bef325899d3bb81f9d6418ca7cad77673614dfe2a1ae1e84739f6bd781fe
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-3/master#c8865d8e195813ade6b84434ac9f8850e7112d1a:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/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" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "test" "--frozen" "--no-run"`
[INFO] [stdout] 40dc03f8b1cd7559b20cb40ce699ff0a97e805e593ed5ce99256b87d9fbbc308
[INFO] running `"docker" "start" "-a" "40dc03f8b1cd7559b20cb40ce699ff0a97e805e593ed5ce99256b87d9fbbc308"`
[INFO] [stderr]    Compiling hifitime v0.1.5 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.59s
[INFO] running `"docker" "inspect" "40dc03f8b1cd7559b20cb40ce699ff0a97e805e593ed5ce99256b87d9fbbc308"`
[INFO] running `"docker" "rm" "-f" "40dc03f8b1cd7559b20cb40ce699ff0a97e805e593ed5ce99256b87d9fbbc308"`
[INFO] [stdout] 40dc03f8b1cd7559b20cb40ce699ff0a97e805e593ed5ce99256b87d9fbbc308
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-3/master#c8865d8e195813ade6b84434ac9f8850e7112d1a:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/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" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "test" "--frozen"`
[INFO] [stdout] dc6d4ecc410d4dd8886f2295bc4a22616a62d7bd174a49e8033190463a790b4f
[INFO] running `"docker" "start" "-a" "dc6d4ecc410d4dd8886f2295bc4a22616a62d7bd174a49e8033190463a790b4f"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/hifitime-673f857b2c48a966
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test error_unittest ... ok
[INFO] [stdout] test instant::era_unittest ... ok
[INFO] [stdout] test durations ... ok
[INFO] [stdout] test instant::instant_unittest ... ok
[INFO] [stdout] test datetime::quorem_nominal_test ... 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-1543ce5225883f56
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test datetime_invalid_dates ... ok
[INFO] [stdout] test datetime_time_varying_offset ... ok
[INFO] [stdout] test datetime_extras ... 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-9c8bf04d8a81654b
[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-bbd9b90a9de169fd
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test julian::jd_tt ... ok
[INFO] [stdout] test datetime::datetime_invalid_dates ... ok
[INFO] [stdout] test julian::reciprocity ... ok
[INFO] [stdout] test julian::epochs ... ok
[INFO] [stdout] test datetime::datetime_extras ... ok
[INFO] [stdout] test datetime::datetime_time_varying_offset ... 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-1e0e9de8e9f40240
[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::add (line 631) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::fmt (line 608) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::from_str (line 670) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::sub (line 649) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::at_midnight (line 390) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::fmt (line 587) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::at_noon (line 417) ... ok
[INFO] [stdout] test src/datetime.rs - datetime::Datetime::new (line 151) ... 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::Era (line 17) ... 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::Instant::add (line 190) ... ok
[INFO] [stdout] test src/instant.rs - instant::Instant::from_precise_seconds (line 94) ... ok
[INFO] [stdout] test src/instant.rs - instant::Instant::new (line 52) ... ok
[INFO] [stdout] test src/instant.rs - instant::Instant::now (line 136) ... ok
[INFO] [stdout] test src/instant.rs - instant::Instant::sub (line 255) ... ok
[INFO] [stdout] test src/instant.rs - instant::Instant::sub (line 320) ... ok
[INFO] [stdout] test src/lib.rs -  (line 49) ... ok
[INFO] [stdout] test src/instant.rs - instant::Instant::unix_epoch (line 119) ... 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" "dc6d4ecc410d4dd8886f2295bc4a22616a62d7bd174a49e8033190463a790b4f"`
[INFO] running `"docker" "rm" "-f" "dc6d4ecc410d4dd8886f2295bc4a22616a62d7bd174a49e8033190463a790b4f"`
[INFO] [stdout] dc6d4ecc410d4dd8886f2295bc4a22616a62d7bd174a49e8033190463a790b4f