[INFO] fetching crate mr-ulid 1.1.1...
[INFO] testing mr-ulid-1.1.1 against master#9e136a30a965bf4e63f03095c57df7257bf96fd6 for pr-134530
[INFO] extracting crate mr-ulid 1.1.1 into /workspace/builds/worker-7-tc1/source
[INFO] validating manifest of crates.io crate mr-ulid 1.1.1 on toolchain 9e136a30a965bf4e63f03095c57df7257bf96fd6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate mr-ulid 1.1.1
[INFO] finished tweaking crates.io crate mr-ulid 1.1.1
[INFO] tweaked toml for crates.io crate mr-ulid 1.1.1 written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]      Locking 21 packages to latest compatible versions
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 8791854a5a6cca4a4aea5970356ff4bf2d4d54c313b7d74631e4869cb9ccce79
[INFO] running `Command { std: "docker" "start" "-a" "8791854a5a6cca4a4aea5970356ff4bf2d4d54c313b7d74631e4869cb9ccce79", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8791854a5a6cca4a4aea5970356ff4bf2d4d54c313b7d74631e4869cb9ccce79", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8791854a5a6cca4a4aea5970356ff4bf2d4d54c313b7d74631e4869cb9ccce79", kill_on_drop: false }`
[INFO] [stdout] 8791854a5a6cca4a4aea5970356ff4bf2d4d54c313b7d74631e4869cb9ccce79
[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=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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2a0d9fc38ee94b115641125934bb970b300dd128065b4a1daff5e20f9936f637
[INFO] running `Command { std: "docker" "start" "-a" "2a0d9fc38ee94b115641125934bb970b300dd128065b4a1daff5e20f9936f637", kill_on_drop: false }`
[INFO] [stderr]    Compiling mr-ulid v1.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.50s
[INFO] running `Command { std: "docker" "inspect" "2a0d9fc38ee94b115641125934bb970b300dd128065b4a1daff5e20f9936f637", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2a0d9fc38ee94b115641125934bb970b300dd128065b4a1daff5e20f9936f637", kill_on_drop: false }`
[INFO] [stdout] 2a0d9fc38ee94b115641125934bb970b300dd128065b4a1daff5e20f9936f637
[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=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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7414f65c6243e263b61b2f397d92399713fcfc850dc1878dba2f7e8cfe8ef0b9
[INFO] running `Command { std: "docker" "start" "-a" "7414f65c6243e263b61b2f397d92399713fcfc850dc1878dba2f7e8cfe8ef0b9", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde v1.0.216
[INFO] [stderr]    Compiling serde_derive v1.0.216
[INFO] [stderr]    Compiling serde_json v1.0.133
[INFO] [stderr]    Compiling mr-ulid v1.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 7.11s
[INFO] running `Command { std: "docker" "inspect" "7414f65c6243e263b61b2f397d92399713fcfc850dc1878dba2f7e8cfe8ef0b9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7414f65c6243e263b61b2f397d92399713fcfc850dc1878dba2f7e8cfe8ef0b9", kill_on_drop: false }`
[INFO] [stdout] 7414f65c6243e263b61b2f397d92399713fcfc850dc1878dba2f7e8cfe8ef0b9
[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=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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 45dd3ebc21a1ba8f6e61ffa50eb52eaf209a0f4c8cc7491b622e050258966d20
[INFO] running `Command { std: "docker" "start" "-a" "45dd3ebc21a1ba8f6e61ffa50eb52eaf209a0f4c8cc7491b622e050258966d20", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/mr_ulid-8956a78dccffad4a)
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stdout] test generator::tests::test_generator_overflow ... ok
[INFO] [stdout] test tests::test_debug_fmt ... ok
[INFO] [stdout] test tests::test_canonicalize ... ok
[INFO] [stdout] test tests::test_max ... ok
[INFO] [stdout] test tests::test_from_parts ... ok
[INFO] [stdout] test tests::test_parse ... ok
[INFO] [stdout] test tests::test_monotonicity ... ok
[INFO] [stdout] test tests::test_try_to_string ... ok
[INFO] [stdout] test tests::test_uniques ... ok
[INFO] [stdout] test tests::test_validate ... ok
[INFO] [stdout] test util::tests::test_timestamp_to_string ... ok
[INFO] [stdout] test tests::test_send_sync ... ok
[INFO] [stdout] test tests::test_timestamp ... ok
[INFO] [stdout] test tests::test_string_length ... ok
[INFO] [stdout] test generator::tests::test_debug ... ok
[INFO] [stdout] test tests::test_sizeof ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests mr_ulid
[INFO] [stdout] 
[INFO] [stdout] running 48 tests
[INFO] [stdout] test src/generator.rs - generator::NO_ENTROPY_SOURCE (line 120) - compile ... ok
[INFO] [stdout] test src/generator.rs - generator::EntropySource (line 17) - compile ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid (line 15) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid (line 24) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::MAX (line 59) ... ok
[INFO] [stdout] test src/lib.rs - (line 12) ... ok
[INFO] [stdout] test src/generator.rs - generator::STANDARD_ENTROPY_SOURCE (line 96) ... ok
[INFO] [stdout] test src/lib.rs - (line 64) ... ok
[INFO] [stdout] test src/lib.rs - (line 41) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::MIN (line 46) ... ok
[INFO] [stdout] test src/lib.rs - canonicalize (line 173) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::from_non_zero_u128 (line 379) ... ok
[INFO] [stdout] test src/lib.rs - validate (line 204) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::datetime (line 152) ... ok
[INFO] [stdout] test src/lib.rs - (line 26) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::from_bytes (line 286) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::from_zeroable_ulid (line 191) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::from_parts (line 232) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::from_u128 (line 331) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::to_zeroable_ulid (line 171) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::generate (line 80) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::try_datetime (line 431) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::timestamp (line 109) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::to_bytes (line 262) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::to_non_zero_u128 (line 355) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::try_generate (line 406) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::to_parts (line 209) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::randomness (line 127) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::MIN (line 37) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid (line 18) ... ok
[INFO] [stdout] test src/nonzero.rs - nonzero::Ulid::to_u128 (line 307) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::from_parts (line 271) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::MAX (line 50) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::generate (line 97) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::from_bytes (line 320) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::datetime (line 187) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::from_u128 (line 359) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::is_zero (line 125) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::timestamp (line 144) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::randomness (line 162) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::from_ulid (line 231) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::new (line 66) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::to_u128 (line 338) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::to_bytes (line 298) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::to_ulid (line 206) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::try_datetime (line 406) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::to_parts (line 249) ... ok
[INFO] [stdout] test src/zeroable.rs - zeroable::ZeroableUlid::try_generate (line 381) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 48 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.35s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "45dd3ebc21a1ba8f6e61ffa50eb52eaf209a0f4c8cc7491b622e050258966d20", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "45dd3ebc21a1ba8f6e61ffa50eb52eaf209a0f4c8cc7491b622e050258966d20", kill_on_drop: false }`
[INFO] [stdout] 45dd3ebc21a1ba8f6e61ffa50eb52eaf209a0f4c8cc7491b622e050258966d20