[INFO] fetching crate bip38 1.1.0...
[INFO] testing bip38-1.1.0 against 1.54.0 for beta-1.55-1
[INFO] extracting crate bip38 1.1.0 into /workspace/builds/worker-14/source
[INFO] validating manifest of crates.io crate bip38 1.1.0 on toolchain 1.54.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.54.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate bip38 1.1.0
[INFO] finished tweaking crates.io crate bip38 1.1.0
[INFO] tweaked toml for crates.io crate bip38 1.1.0 written to /workspace/builds/worker-14/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.54.0" "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" "+1.54.0" "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] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded scrypt v0.7.0
[INFO] [stderr]   Downloaded pbkdf2 v0.8.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 04969211be3749b409e02bcbc54fed2fc848ddda8aae5df85dfd93c3cdb219bf
[INFO] running `Command { std: "docker" "start" "-a" "04969211be3749b409e02bcbc54fed2fc848ddda8aae5df85dfd93c3cdb219bf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "04969211be3749b409e02bcbc54fed2fc848ddda8aae5df85dfd93c3cdb219bf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "04969211be3749b409e02bcbc54fed2fc848ddda8aae5df85dfd93c3cdb219bf", kill_on_drop: false }`
[INFO] [stdout] 04969211be3749b409e02bcbc54fed2fc848ddda8aae5df85dfd93c3cdb219bf
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/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=warn" "-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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 05a23a141104f4906710ccd988b5ac454b6981dc73d28bd20612ef94523c0515
[INFO] running `Command { std: "docker" "start" "-a" "05a23a141104f4906710ccd988b5ac454b6981dc73d28bd20612ef94523c0515", kill_on_drop: false }`
[INFO] [stderr]    Compiling subtle v2.4.1
[INFO] [stderr]    Compiling tinyvec_macros v0.1.0
[INFO] [stderr]    Compiling bs58 v0.4.0
[INFO] [stderr]    Compiling secp256k1-sys v0.4.1
[INFO] [stderr]    Compiling cipher v0.3.0
[INFO] [stderr]    Compiling tinyvec v1.3.1
[INFO] [stderr]    Compiling crypto-mac v0.11.1
[INFO] [stderr]    Compiling salsa20 v0.8.1
[INFO] [stderr]    Compiling aes v0.7.4
[INFO] [stderr]    Compiling hmac v0.11.0
[INFO] [stderr]    Compiling pbkdf2 v0.8.0
[INFO] [stderr]    Compiling scrypt v0.7.0
[INFO] [stderr]    Compiling unicode-normalization v0.1.19
[INFO] [stderr]    Compiling secp256k1 v0.20.3
[INFO] [stderr]    Compiling bip38 v1.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.58s
[INFO] running `Command { std: "docker" "inspect" "05a23a141104f4906710ccd988b5ac454b6981dc73d28bd20612ef94523c0515", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "05a23a141104f4906710ccd988b5ac454b6981dc73d28bd20612ef94523c0515", kill_on_drop: false }`
[INFO] [stdout] 05a23a141104f4906710ccd988b5ac454b6981dc73d28bd20612ef94523c0515
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/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=warn" "-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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 903975aad7791351476daf9df4466edb04a6a9d5d58848fb2a36922f84a56cac
[INFO] running `Command { std: "docker" "start" "-a" "903975aad7791351476daf9df4466edb04a6a9d5d58848fb2a36922f84a56cac", kill_on_drop: false }`
[INFO] [stderr]    Compiling bip38 v1.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.63s
[INFO] running `Command { std: "docker" "inspect" "903975aad7791351476daf9df4466edb04a6a9d5d58848fb2a36922f84a56cac", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "903975aad7791351476daf9df4466edb04a6a9d5d58848fb2a36922f84a56cac", kill_on_drop: false }`
[INFO] [stdout] 903975aad7791351476daf9df4466edb04a6a9d5d58848fb2a36922f84a56cac
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/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=warn" "-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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 57461d9fd9fa60e930f62cd9b6d79c9ba970361b21d7553f1d0dcc81bb0198d5
[INFO] running `Command { std: "docker" "start" "-a" "57461d9fd9fa60e930f62cd9b6d79c9ba970361b21d7553f1d0dcc81bb0198d5", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.57s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/bip38-53d40da46254a00d)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test tests::test_decode_wif ... ok
[INFO] [stdout] test tests::test_encode_base58ck ... ok
[INFO] [stdout] test tests::test_hash160 ... ok
[INFO] [stdout] test tests::test_hash256 ... ok
[INFO] [stdout] test tests::test_wif ... ok
[INFO] [stdout] test tests::test_p2wpkh ... ok
[INFO] [stdout] test tests::test_public ... ok
[INFO] [stdout] test tests::test_decrypt has been running for over 60 seconds
[INFO] [stdout] test tests::test_decrypt_to_wif has been running for over 60 seconds
[INFO] [stdout] test tests::test_encrypt has been running for over 60 seconds
[INFO] [stdout] test tests::test_encrypt_wif has been running for over 60 seconds
[INFO] [stdout] test tests::test_generate has been running for over 60 seconds
[INFO] [stdout] test tests::test_encrypt_wif ... ok
[INFO] [stdout] test tests::test_encrypt ... ok
[INFO] [stdout] test tests::test_generate ... ok
[INFO] [stdout] test tests::test_decrypt ... ok
[INFO] [stdout] test tests::test_decrypt_to_wif ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 686.84s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests bip38
[INFO] [stdout] 
[INFO] [stdout] running 21 tests
[INFO] [stdout] test src/lib.rs - Encrypt::encrypt (line 476) ... ok
[INFO] [stdout] test src/lib.rs - EncryptWif::encrypt_wif (line 540) ... ok
[INFO] [stdout] test src/lib.rs - EncryptWif::encrypt_wif (line 569) ... ok
[INFO] [stdout] test src/lib.rs - Decrypt::decrypt_to_wif (line 433) ... ok
[INFO] [stdout] test src/lib.rs - Decrypt::decrypt (line 348) ... ok
[INFO] [stdout] test src/lib.rs - (line 161) ... ok
[INFO] [stdout] test src/lib.rs - Encrypt::encrypt (line 487) ... ok
[INFO] [stdout] test src/lib.rs - (line 11) has been running for over 60 seconds
[INFO] [stdout] test src/lib.rs - (line 123) has been running for over 60 seconds
[INFO] [stdout] test src/lib.rs - (line 141) has been running for over 60 seconds
[INFO] [stdout] test src/lib.rs - (line 41) has been running for over 60 seconds
[INFO] [stdout] test src/lib.rs - (line 72) has been running for over 60 seconds
[INFO] [stdout] test src/lib.rs - (line 97) has been running for over 60 seconds
[INFO] [stdout] test src/lib.rs - Decrypt::decrypt (line 286) has been running for over 60 seconds
[INFO] [stdout] test src/lib.rs - Decrypt::decrypt (line 319) has been running for over 60 seconds
[INFO] [stdout] test src/lib.rs - Decrypt::decrypt_to_wif (line 368) has been running for over 60 seconds
[INFO] [stdout] test src/lib.rs - Decrypt::decrypt_to_wif (line 403) has been running for over 60 seconds
[INFO] [stdout] test src/lib.rs - Encrypt::encrypt (line 456) has been running for over 60 seconds
[INFO] [stdout] test src/lib.rs - EncryptWif::encrypt_wif (line 511) has been running for over 60 seconds
[INFO] [stdout] test src/lib.rs - Generate::generate (line 597) has been running for over 60 seconds
[INFO] [stdout] test src/lib.rs - Generate::generate (line 622) has been running for over 60 seconds
[INFO] [stdout] test src/lib.rs - Decrypt::decrypt (line 319) ... ok
[INFO] [stdout] test src/lib.rs - (line 141) ... ok
[INFO] [stdout] test src/lib.rs - EncryptWif::encrypt_wif (line 511) ... ok
[INFO] [stdout] test src/lib.rs - Decrypt::decrypt_to_wif (line 403) ... ok
[INFO] [stdout] test src/lib.rs - Generate::generate (line 622) ... ok
[INFO] [stdout] test src/lib.rs - (line 123) ... ok
[INFO] [stdout] test src/lib.rs - (line 97) ... ok
[INFO] [stdout] test src/lib.rs - Encrypt::encrypt (line 456) ... ok
[ERROR] error running command: command timed out after 900 seconds
[INFO] running `Command { std: "docker" "inspect" "57461d9fd9fa60e930f62cd9b6d79c9ba970361b21d7553f1d0dcc81bb0198d5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "57461d9fd9fa60e930f62cd9b6d79c9ba970361b21d7553f1d0dcc81bb0198d5", kill_on_drop: false }`
[INFO] [stdout] 57461d9fd9fa60e930f62cd9b6d79c9ba970361b21d7553f1d0dcc81bb0198d5
