[INFO] fetching crate lightspeed_hash 0.42.0... [INFO] testing lightspeed_hash-0.42.0 against master#62efba8a050c64249dab942951bb28f710208bc8 for pr-90799 [INFO] extracting crate lightspeed_hash 0.42.0 into /workspace/builds/worker-1/source [INFO] validating manifest of crates.io crate lightspeed_hash 0.42.0 on toolchain 62efba8a050c64249dab942951bb28f710208bc8 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate lightspeed_hash 0.42.0 [INFO] finished tweaking crates.io crate lightspeed_hash 0.42.0 [INFO] tweaked toml for crates.io crate lightspeed_hash 0.42.0 written to /workspace/builds/worker-1/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 2663b9f6fbf3bc15da315ae7bc25ae197d3d3a9c41ed0f067808e22f88b42e82 [INFO] running `Command { std: "docker" "start" "-a" "2663b9f6fbf3bc15da315ae7bc25ae197d3d3a9c41ed0f067808e22f88b42e82", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "2663b9f6fbf3bc15da315ae7bc25ae197d3d3a9c41ed0f067808e22f88b42e82", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "2663b9f6fbf3bc15da315ae7bc25ae197d3d3a9c41ed0f067808e22f88b42e82", kill_on_drop: false }` [INFO] [stdout] 2663b9f6fbf3bc15da315ae7bc25ae197d3d3a9c41ed0f067808e22f88b42e82 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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" "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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] a6e2b19dcd1961566b360ad82c883177f74f6ba56992c0a1f666fe349b914db5 [INFO] running `Command { std: "docker" "start" "-a" "a6e2b19dcd1961566b360ad82c883177f74f6ba56992c0a1f666fe349b914db5", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling proc-macro2 v1.0.32 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling syn v1.0.82 [INFO] [stderr] Compiling autocfg v1.0.1 [INFO] [stderr] Compiling libc v0.2.108 [INFO] [stderr] Compiling memchr v2.4.1 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling serde v1.0.130 [INFO] [stderr] Compiling proc-macro2 v0.4.30 [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling unicode-xid v0.1.0 [INFO] [stderr] Compiling ucd-trie v0.1.3 [INFO] [stderr] Compiling ryu v1.0.6 [INFO] [stderr] Compiling tinyvec_macros v0.1.0 [INFO] [stderr] Compiling unicode-segmentation v1.8.0 [INFO] [stderr] Compiling syn v0.15.44 [INFO] [stderr] Compiling serde_json v1.0.72 [INFO] [stderr] Compiling typenum v1.14.0 [INFO] [stderr] Compiling maplit v1.0.2 [INFO] [stderr] Compiling matches v0.1.9 [INFO] [stderr] Compiling rustversion v1.0.5 [INFO] [stderr] Compiling itoa v0.4.8 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling unicode-bidi v0.3.7 [INFO] [stderr] Compiling async-trait v0.1.51 [INFO] [stderr] Compiling percent-encoding v2.1.0 [INFO] [stderr] Compiling ppv-lite86 v0.2.15 [INFO] [stderr] Compiling spin v0.5.2 [INFO] [stderr] Compiling base64 v0.13.0 [INFO] [stderr] Compiling untrusted v0.7.1 [INFO] [stderr] Compiling cfg-if v0.1.10 [INFO] [stderr] Compiling hashbrown v0.11.2 [INFO] [stderr] Compiling base64 v0.12.3 [INFO] [stderr] Compiling textwrap v0.14.2 [INFO] [stderr] Compiling opaque-debug v0.3.0 [INFO] [stderr] Compiling cpufeatures v0.2.1 [INFO] [stderr] Compiling proc-macro-error-attr v1.0.4 [INFO] [stderr] Compiling generic-array v0.14.4 [INFO] [stderr] Compiling proc-macro-error v1.0.4 [INFO] [stderr] Compiling ring v0.16.20 [INFO] [stderr] Compiling tinyvec v1.5.1 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling form_urlencoded v1.0.1 [INFO] [stderr] Compiling pest v2.1.3 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling num-bigint v0.2.6 [INFO] [stderr] Compiling indexmap v1.7.0 [INFO] [stderr] Compiling heck v0.3.3 [INFO] [stderr] Compiling unicode-normalization v0.1.19 [INFO] [stderr] Compiling quote v0.6.13 [INFO] [stderr] Compiling pest_meta v2.1.3 [INFO] [stderr] Compiling getrandom v0.2.3 [INFO] [stderr] Compiling time v0.1.43 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling uuid v0.8.2 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling aho-corasick v0.7.18 [INFO] [stderr] Compiling os_str_bytes v4.2.0 [INFO] [stderr] Compiling rand v0.8.4 [INFO] [stderr] Compiling idna v0.2.3 [INFO] [stderr] Compiling quote v1.0.10 [INFO] [stderr] Compiling block-buffer v0.9.0 [INFO] [stderr] Compiling digest v0.9.0 [INFO] [stderr] Compiling sha2 v0.9.8 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling url v2.2.2 [INFO] [stderr] Compiling serde_derive_internals v0.24.1 [INFO] [stderr] Compiling simple_asn1 v0.4.1 [INFO] [stderr] Compiling pem v0.8.3 [INFO] [stderr] Compiling pest_generator v2.1.3 [INFO] [stderr] Compiling validator_types v0.14.0 [INFO] [stderr] Compiling serde_derive v1.0.130 [INFO] [stderr] Compiling thiserror-impl v1.0.30 [INFO] [stderr] Compiling pest_derive v2.1.0 [INFO] [stderr] Compiling strum_macros v0.23.1 [INFO] [stderr] Compiling clap_derive v3.0.0-beta.5 [INFO] [stderr] Compiling strum v0.23.0 [INFO] [stderr] Compiling thiserror v1.0.30 [INFO] [stderr] Compiling typescript-definitions-derive-ufo-patch v0.1.11 [INFO] [stderr] Compiling clap v3.0.0-beta.5 [INFO] [stderr] Compiling typescript-definitions-ufo-patch v0.1.11 [INFO] [stderr] Compiling validator v0.14.0 [INFO] [stderr] Compiling jsonwebtoken v7.2.0 [INFO] [stderr] Compiling c3p0_common v0.63.1 [INFO] [stderr] Compiling lightspeed_core v0.42.0 [INFO] [stderr] Compiling lightspeed_hash v0.42.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 28.88s [INFO] running `Command { std: "docker" "inspect" "a6e2b19dcd1961566b360ad82c883177f74f6ba56992c0a1f666fe349b914db5", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a6e2b19dcd1961566b360ad82c883177f74f6ba56992c0a1f666fe349b914db5", kill_on_drop: false }` [INFO] [stdout] a6e2b19dcd1961566b360ad82c883177f74f6ba56992c0a1f666fe349b914db5 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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" "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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] f65d5f62f01a2b02bb44ab589fba472dd9c5cdd6b10ad2c0c16e612f4d7c7f68 [INFO] running `Command { std: "docker" "start" "-a" "f65d5f62f01a2b02bb44ab589fba472dd9c5cdd6b10ad2c0c16e612f4d7c7f68", kill_on_drop: false }` [INFO] [stderr] Compiling crossbeam-utils v0.8.5 [INFO] [stderr] Compiling ansi_term v0.12.1 [INFO] [stderr] Compiling tracing-core v0.1.21 [INFO] [stderr] Compiling thread_local v1.1.3 [INFO] [stderr] Compiling sharded-slab v0.1.4 [INFO] [stderr] Compiling tokio v1.14.0 [INFO] [stderr] Compiling time v0.3.5 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling pin-project-internal v1.0.8 [INFO] [stderr] Compiling tracing-attributes v0.1.18 [INFO] [stderr] Compiling tokio-macros v1.6.0 [INFO] [stderr] Compiling tracing-log v0.1.2 [INFO] [stderr] Compiling crossbeam-channel v0.5.1 [INFO] [stderr] Compiling tracing-subscriber v0.3.3 [INFO] [stderr] Compiling tracing v0.1.29 [INFO] [stderr] Compiling tracing-appender v0.2.0 [INFO] [stderr] Compiling pin-project v1.0.8 [INFO] [stderr] Compiling tracing-futures v0.2.5 [INFO] [stderr] Compiling lightspeed_logger v0.42.0 [INFO] [stderr] Compiling lightspeed_hash v0.42.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 11.14s [INFO] running `Command { std: "docker" "inspect" "f65d5f62f01a2b02bb44ab589fba472dd9c5cdd6b10ad2c0c16e612f4d7c7f68", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "f65d5f62f01a2b02bb44ab589fba472dd9c5cdd6b10ad2c0c16e612f4d7c7f68", kill_on_drop: false }` [INFO] [stdout] f65d5f62f01a2b02bb44ab589fba472dd9c5cdd6b10ad2c0c16e612f4d7c7f68 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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" "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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 87d8a9ba5eeec1dcc0e5f6720e5fdade5a8d19cbcb1c013e231fcb6a029bfa9d [INFO] running `Command { std: "docker" "start" "-a" "87d8a9ba5eeec1dcc0e5f6720e5fdade5a8d19cbcb1c013e231fcb6a029bfa9d", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.21s [INFO] [stdout] [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/lightspeed_hash-68307c8ba58f1870) [INFO] [stdout] running 1 test [INFO] [stderr] Running tests/hash_test.rs (/opt/rustwide/target/debug/deps/hash_test-6282610e29cc3b6f) [INFO] [stdout] test service::hash_service::test::should_hash_a_string ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Doc-tests lightspeed_hash [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] 2021-12-02T12:48:15.618106Z  INFO lightspeed_core: Creating CoreModule [INFO] [stdout] 2021-12-02T12:48:15.618227Z  INFO lightspeed_core: Starting CoreModule [INFO] [stdout] 2021-12-02T12:48:15.618256Z  INFO lightspeed_hash: Creating HashModule [INFO] [stdout] 2021-12-02T12:48:15.618281Z  INFO lightspeed_hash: Starting HashModule [INFO] [stdout] 2021-12-02T12:48:15.618329Z  INFO lightspeed_hash::service::validation_code_service: Generate validation code [INFO] [stdout] 2021-12-02T12:48:15.618722Z DEBUG lightspeed_hash::service::validation_code_service: Verify code 1638449295618 [INFO] [stdout] 2021-12-02T12:48:15.618900Z DEBUG lightspeed_hash::service::validation_code_service: Verify code abced [INFO] [stdout] 2021-12-02T12:48:15.619065Z DEBUG lightspeed_hash::service::validation_code_service: Verify code 1638449295618 [INFO] [stdout] 2021-12-02T12:48:15.619228Z DEBUG lightspeed_hash::service::validation_code_service: Verify code 1638449295618 [INFO] [stdout] 2021-12-02T12:48:15.624917Z DEBUG lightspeed_hash::service::validation_code_service: Verify code 1638449295618 [INFO] [stdout] 2021-12-02T12:48:15.625137Z DEBUG lightspeed_hash::service::validation_code_service: Verify code 1638449295618 [INFO] [stdout] test service::validation_code_service_it::should_generate_validation_code ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [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; finished in 0.00s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "87d8a9ba5eeec1dcc0e5f6720e5fdade5a8d19cbcb1c013e231fcb6a029bfa9d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "87d8a9ba5eeec1dcc0e5f6720e5fdade5a8d19cbcb1c013e231fcb6a029bfa9d", kill_on_drop: false }` [INFO] [stdout] 87d8a9ba5eeec1dcc0e5f6720e5fdade5a8d19cbcb1c013e231fcb6a029bfa9d