[INFO] fetching crate cryptoki 0.2.0...
[INFO] testing cryptoki-0.2.0 against try#8262275854dc0e5381c9d42d56257d94932c5a87 for pr-90799
[INFO] extracting crate cryptoki 0.2.0 into /workspace/builds/worker-8/source
[INFO] validating manifest of crates.io crate cryptoki 0.2.0 on toolchain 8262275854dc0e5381c9d42d56257d94932c5a87
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate cryptoki 0.2.0
[INFO] finished tweaking crates.io crate cryptoki 0.2.0
[INFO] tweaked toml for crates.io crate cryptoki 0.2.0 written to /workspace/builds/worker-8/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "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 cryptoki-sys v0.1.2
[INFO] [stderr]   Downloaded psa-crypto v0.9.1
[INFO] [stderr]   Downloaded psa-crypto-sys v0.9.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 7ff7c68a8550968d47790a20b6ec97de892c1a0e5832166adfe90b65f76c4532
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "7ff7c68a8550968d47790a20b6ec97de892c1a0e5832166adfe90b65f76c4532", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "7ff7c68a8550968d47790a20b6ec97de892c1a0e5832166adfe90b65f76c4532", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7ff7c68a8550968d47790a20b6ec97de892c1a0e5832166adfe90b65f76c4532", kill_on_drop: false }`
[INFO] [stdout] 7ff7c68a8550968d47790a20b6ec97de892c1a0e5832166adfe90b65f76c4532
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] dca1f2550ce0fa772ac69e7c17279e40dc58321eda8a97cc723e66de4015f369
[INFO] running `Command { std: "docker" "start" "-a" "dca1f2550ce0fa772ac69e7c17279e40dc58321eda8a97cc723e66de4015f369", kill_on_drop: false }`
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling zeroize v1.3.0
[INFO] [stderr]    Compiling libloading v0.7.2
[INFO] [stderr]    Compiling cryptoki-sys v0.1.2
[INFO] [stderr]    Compiling syn v1.0.82
[INFO] [stderr]    Compiling secrecy v0.7.0
[INFO] [stderr]    Compiling derivative v2.2.0
[INFO] [stderr]    Compiling cryptoki v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 24.26s
[INFO] running `Command { std: "docker" "inspect" "dca1f2550ce0fa772ac69e7c17279e40dc58321eda8a97cc723e66de4015f369", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dca1f2550ce0fa772ac69e7c17279e40dc58321eda8a97cc723e66de4015f369", kill_on_drop: false }`
[INFO] [stdout] dca1f2550ce0fa772ac69e7c17279e40dc58321eda8a97cc723e66de4015f369
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5ad45c288eeb76a7f2ecc3079fd3a15af5fcf41a977d4b5dd37132beb081d815
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "5ad45c288eeb76a7f2ecc3079fd3a15af5fcf41a977d4b5dd37132beb081d815", kill_on_drop: false }`
[INFO] [stderr]    Compiling parking_lot_core v0.8.5
[INFO] [stderr]    Compiling autocfg v1.0.1
[INFO] [stderr]    Compiling scopeguard v1.1.0
[INFO] [stderr]    Compiling smallvec v1.7.0
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling instant v0.1.12
[INFO] [stderr]    Compiling serial_test_derive v0.5.1
[INFO] [stderr]    Compiling lock_api v0.4.5
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling parking_lot v0.11.2
[INFO] [stderr]    Compiling serial_test v0.5.1
[INFO] [stderr]    Compiling cryptoki v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 11.47s
[INFO] running `Command { std: "docker" "inspect" "5ad45c288eeb76a7f2ecc3079fd3a15af5fcf41a977d4b5dd37132beb081d815", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5ad45c288eeb76a7f2ecc3079fd3a15af5fcf41a977d4b5dd37132beb081d815", kill_on_drop: false }`
[INFO] [stdout] 5ad45c288eeb76a7f2ecc3079fd3a15af5fcf41a977d4b5dd37132beb081d815
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 28d22f5466dd90270cfa8c852c01716cdc2485c3272ded59b8ff400de06d3156
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "28d22f5466dd90270cfa8c852c01716cdc2485c3272ded59b8ff400de06d3156", kill_on_drop: false }`
[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] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/cryptoki-23aa1cf6251ac417)
[INFO] [stderr]      Running tests/basic.rs (/opt/rustwide/target/debug/deps/basic-b9a8719cbe7cb930)
[INFO] [stdout] test derive_key ... FAILED
[INFO] [stderr] error: test failed, to rerun pass '--test basic'
[INFO] [stdout] test encrypt_decrypt ... FAILED
[INFO] [stdout] test sign_verify ... FAILED
[INFO] [stdout] test login_feast ... FAILED
[INFO] [stdout] test import_export ... FAILED
[INFO] [stdout] test get_token_info ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- derive_key stdout ----
[INFO] [stdout] thread 'derive_key' panicked at 'called `Result::unwrap()` on an `Err` value: LibraryLoading(DlOpen { desc: "/usr/local/lib/softhsm/libsofthsm2.so: cannot open shared object file: No such file or directory" })', tests/common.rs:15:6
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5589ee728adc - std::backtrace_rs::backtrace::libunwind::trace::h793e05efd273d0f4
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
[INFO] [stdout]    1:     0x5589ee728adc - std::backtrace_rs::backtrace::trace_unsynchronized::h640b7b86ff610c77
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5589ee728adc - std::sys_common::backtrace::_print_fmt::h362fa2a4f354f877
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x5589ee728adc - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hf439e5ed84c74abd
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x5589ee74ba2c - core::fmt::write::h72801a82c94e6ff1
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/fmt/mod.rs:1149:17
[INFO] [stdout]    5:     0x5589ee724a85 - std::io::Write::write_fmt::h54337adeb3504c03
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/io/mod.rs:1697:15
[INFO] [stdout]    6:     0x5589ee72a580 - std::sys_common::backtrace::_print::hb29ddd998d02631c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x5589ee72a580 - std::sys_common::backtrace::print::h81965e3d7c90fbb6
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x5589ee72a580 - std::panicking::default_hook::{{closure}}::h84db205ab6674b38
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:211:50
[INFO] [stdout]    9:     0x5589ee72a166 - std::panicking::default_hook::h1bf8bb4159936bca
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:225:9
[INFO] [stdout]   10:     0x5589ee72ac34 - std::panicking::rust_panic_with_hook::hf8e86850fbbd03b1
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:606:17
[INFO] [stdout]   11:     0x5589ee72a710 - std::panicking::begin_panic_handler::{{closure}}::h590a0d6060ff866e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:502:13
[INFO] [stdout]   12:     0x5589ee728f94 - std::sys_common::backtrace::__rust_end_short_backtrace::h260b8bd1c848a03c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:139:18
[INFO] [stdout]   13:     0x5589ee72a679 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:498:5
[INFO] [stdout]   14:     0x5589ee6588f1 - core::panicking::panic_fmt::h7b8580d81fcbbacd
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panicking.rs:106:14
[INFO] [stdout]   15:     0x5589ee6589e3 - core::result::unwrap_failed::h885d3f7beb571353
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/result.rs:1613:5
[INFO] [stdout]   16:     0x5589ee66349c - core::result::Result<T,E>::unwrap::h1f89162e80250ab0
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/result.rs:1295:23
[INFO] [stdout]   17:     0x5589ee665e1d - basic::common::init_pins::h5464a6ea9a559003
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/common.rs:11:18
[INFO] [stdout]   18:     0x5589ee65b464 - basic::derive_key::{{closure}}::h96f0a0b73108d1e2
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:130:26
[INFO] [stdout]   19:     0x5589ee65dd0e - core::ops::function::FnOnce::call_once::h087c715e32f58c30
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x5589ee6a700d - serial_test::serial_core::h169206bc74b89f71
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/serial_test-0.5.1/src/lib.rs:64:5
[INFO] [stdout]   21:     0x5589ee65b429 - basic::derive_key::h025124dc57358350
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:128:1
[INFO] [stdout]   22:     0x5589ee65b3fa - basic::derive_key::{{closure}}::h1b7fc935a1868b09
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:129:1
[INFO] [stdout]   23:     0x5589ee65e0de - core::ops::function::FnOnce::call_once::hd49c643ee9e3cb30
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   24:     0x5589ee69d9e3 - core::ops::function::FnOnce::call_once::h24a32b9da1a40fdb
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   25:     0x5589ee69d9e3 - test::__rust_begin_short_backtrace::h3c3a0492fb4a12eb
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:585:5
[INFO] [stdout]   26:     0x5589ee69c5f7 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h9a8e38435f73d5e0
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   27:     0x5589ee69c5f7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb23d7496a0e6d1b4
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   28:     0x5589ee69c5f7 - std::panicking::try::do_call::ha2bb9825b32d2cc2
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40
[INFO] [stdout]   29:     0x5589ee69c5f7 - std::panicking::try::hdc38a574bbebc53e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19
[INFO] [stdout]   30:     0x5589ee69c5f7 - std::panic::catch_unwind::hc45ed246595c621c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14
[INFO] [stdout]   31:     0x5589ee69c5f7 - test::run_test_in_process::h4249138faaea8d54
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:608:18
[INFO] [stdout]   32:     0x5589ee69c5f7 - test::run_test::run_test_inner::{{closure}}::h3c1b37669f6e9fd7
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:500:39
[INFO] [stdout]   33:     0x5589ee66989e - test::run_test::run_test_inner::{{closure}}::h388760469edd5c24
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:527:37
[INFO] [stdout]   34:     0x5589ee66989e - std::sys_common::backtrace::__rust_begin_short_backtrace::hbbaecdcfad18643e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:123:18
[INFO] [stdout]   35:     0x5589ee66e5f8 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h09cd3ca65896da91
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:484:17
[INFO] [stdout]   36:     0x5589ee66e5f8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hc52dbb4f9088d18b
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   37:     0x5589ee66e5f8 - std::panicking::try::do_call::h4485cfee22b11c08
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40
[INFO] [stdout]   38:     0x5589ee66e5f8 - std::panicking::try::hb62aa8549e20c08b
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19
[INFO] [stdout]   39:     0x5589ee66e5f8 - std::panic::catch_unwind::ha322c7a5bc666762
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14
[INFO] [stdout]   40:     0x5589ee66e5f8 - std::thread::Builder::spawn_unchecked::{{closure}}::h1076fc1398603b77
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:483:30
[INFO] [stdout]   41:     0x5589ee66e5f8 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h911e510344167353
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   42:     0x5589ee72f733 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h771719d52c343434
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   43:     0x5589ee72f733 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf441746dfa4b0f57
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   44:     0x5589ee72f733 - std::sys::unix::thread::Thread::new::thread_start::hfd168f9d312b29ca
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys/unix/thread.rs:106:17
[INFO] [stdout]   45:     0x7f5edeb80609 - start_thread
[INFO] [stdout]   46:     0x7f5ede958293 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- encrypt_decrypt stdout ----
[INFO] [stdout] thread 'encrypt_decrypt' panicked at 'called `Result::unwrap()` on an `Err` value: LibraryLoading(DlOpen { desc: "/usr/local/lib/softhsm/libsofthsm2.so: cannot open shared object file: No such file or directory" })', tests/common.rs:15:6
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5589ee728adc - std::backtrace_rs::backtrace::libunwind::trace::h793e05efd273d0f4
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
[INFO] [stdout]    1:     0x5589ee728adc - std::backtrace_rs::backtrace::trace_unsynchronized::h640b7b86ff610c77
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5589ee728adc - std::sys_common::backtrace::_print_fmt::h362fa2a4f354f877
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x5589ee728adc - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hf439e5ed84c74abd
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x5589ee74ba2c - core::fmt::write::h72801a82c94e6ff1
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/fmt/mod.rs:1149:17
[INFO] [stdout]    5:     0x5589ee724a85 - std::io::Write::write_fmt::h54337adeb3504c03
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/io/mod.rs:1697:15
[INFO] [stdout]    6:     0x5589ee72a580 - std::sys_common::backtrace::_print::hb29ddd998d02631c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x5589ee72a580 - std::sys_common::backtrace::print::h81965e3d7c90fbb6
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x5589ee72a580 - std::panicking::default_hook::{{closure}}::h84db205ab6674b38
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:211:50
[INFO] [stdout]    9:     0x5589ee72a166 - std::panicking::default_hook::h1bf8bb4159936bca
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:225:9
[INFO] [stdout]   10:     0x5589ee72ac34 - std::panicking::rust_panic_with_hook::hf8e86850fbbd03b1
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:606:17
[INFO] [stdout]   11:     0x5589ee72a710 - std::panicking::begin_panic_handler::{{closure}}::h590a0d6060ff866e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:502:13
[INFO] [stdout]   12:     0x5589ee728f94 - std::sys_common::backtrace::__rust_end_short_backtrace::h260b8bd1c848a03c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:139:18
[INFO] [stdout]   13:     0x5589ee72a679 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:498:5
[INFO] [stdout]   14:     0x5589ee6588f1 - core::panicking::panic_fmt::h7b8580d81fcbbacd
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panicking.rs:106:14
[INFO] [stdout]   15:     0x5589ee6589e3 - core::result::unwrap_failed::h885d3f7beb571353
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/result.rs:1613:5
[INFO] [stdout]   16:     0x5589ee66349c - core::result::Result<T,E>::unwrap::h1f89162e80250ab0
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/result.rs:1295:23
[INFO] [stdout]   17:     0x5589ee665e1d - basic::common::init_pins::h5464a6ea9a559003
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/common.rs:11:18
[INFO] [stdout]   18:     0x5589ee65a9f4 - basic::encrypt_decrypt::{{closure}}::h8b75725430f46604
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:70:26
[INFO] [stdout]   19:     0x5589ee65e05e - core::ops::function::FnOnce::call_once::hd1d43dc1cc0d1132
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x5589ee6a700d - serial_test::serial_core::h169206bc74b89f71
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/serial_test-0.5.1/src/lib.rs:64:5
[INFO] [stdout]   21:     0x5589ee65a9c9 - basic::encrypt_decrypt::h89106f17122e27c0
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:68:1
[INFO] [stdout]   22:     0x5589ee65a99a - basic::encrypt_decrypt::{{closure}}::hfa89f34e8e165b15
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:69:1
[INFO] [stdout]   23:     0x5589ee65ddfe - core::ops::function::FnOnce::call_once::h1e5ccd3897281230
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   24:     0x5589ee69d9e3 - core::ops::function::FnOnce::call_once::h24a32b9da1a40fdb
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   25:     0x5589ee69d9e3 - test::__rust_begin_short_backtrace::h3c3a0492fb4a12eb
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:585:5
[INFO] [stdout]   26:     0x5589ee69c5f7 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h9a8e38435f73d5e0
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   27:     0x5589ee69c5f7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb23d7496a0e6d1b4
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   28:     0x5589ee69c5f7 - std::panicking::try::do_call::ha2bb9825b32d2cc2
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40
[INFO] [stdout]   29:     0x5589ee69c5f7 - std::panicking::try::hdc38a574bbebc53e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19
[INFO] [stdout]   30:     0x5589ee69c5f7 - std::panic::catch_unwind::hc45ed246595c621c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14
[INFO] [stdout]   31:     0x5589ee69c5f7 - test::run_test_in_process::h4249138faaea8d54
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:608:18
[INFO] [stdout]   32:     0x5589ee69c5f7 - test::run_test::run_test_inner::{{closure}}::h3c1b37669f6e9fd7
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:500:39
[INFO] [stdout]   33:     0x5589ee66989e - test::run_test::run_test_inner::{{closure}}::h388760469edd5c24
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:527:37
[INFO] [stdout]   34:     0x5589ee66989e - std::sys_common::backtrace::__rust_begin_short_backtrace::hbbaecdcfad18643e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:123:18
[INFO] [stdout]   35:     0x5589ee66e5f8 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h09cd3ca65896da91
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:484:17
[INFO] [stdout]   36:     0x5589ee66e5f8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hc52dbb4f9088d18b
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   37:     0x5589ee66e5f8 - std::panicking::try::do_call::h4485cfee22b11c08
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40
[INFO] [stdout]   38:     0x5589ee66e5f8 - std::panicking::try::hb62aa8549e20c08b
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19
[INFO] [stdout]   39:     0x5589ee66e5f8 - std::panic::catch_unwind::ha322c7a5bc666762
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14
[INFO] [stdout]   40:     0x5589ee66e5f8 - std::thread::Builder::spawn_unchecked::{{closure}}::h1076fc1398603b77
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:483:30
[INFO] [stdout]   41:     0x5589ee66e5f8 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h911e510344167353
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   42:     0x5589ee72f733 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h771719d52c343434
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   43:     0x5589ee72f733 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf441746dfa4b0f57
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   44:     0x5589ee72f733 - std::sys::unix::thread::Thread::new::thread_start::hfd168f9d312b29ca
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys/unix/thread.rs:106:17
[INFO] [stdout]   45:     0x7f5edeb80609 - start_thread
[INFO] [stdout]   46:     0x7f5ede958293 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sign_verify stdout ----
[INFO] [stdout] thread 'sign_verify' panicked at 'called `Result::unwrap()` on an `Err` value: LibraryLoading(DlOpen { desc: "/usr/local/lib/softhsm/libsofthsm2.so: cannot open shared object file: No such file or directory" })', tests/common.rs:15:6
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5589ee728adc - std::backtrace_rs::backtrace::libunwind::trace::h793e05efd273d0f4
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
[INFO] [stdout]    1:     0x5589ee728adc - std::backtrace_rs::backtrace::trace_unsynchronized::h640b7b86ff610c77
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5589ee728adc - std::sys_common::backtrace::_print_fmt::h362fa2a4f354f877
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x5589ee728adc - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hf439e5ed84c74abd
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x5589ee74ba2c - core::fmt::write::h72801a82c94e6ff1
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/fmt/mod.rs:1149:17
[INFO] [stdout]    5:     0x5589ee724a85 - std::io::Write::write_fmt::h54337adeb3504c03
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/io/mod.rs:1697:15
[INFO] [stdout]    6:     0x5589ee72a580 - std::sys_common::backtrace::_print::hb29ddd998d02631c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x5589ee72a580 - std::sys_common::backtrace::print::h81965e3d7c90fbb6
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x5589ee72a580 - std::panicking::default_hook::{{closure}}::h84db205ab6674b38
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:211:50
[INFO] [stdout]    9:     0x5589ee72a166 - std::panicking::default_hook::h1bf8bb4159936bca
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:225:9
[INFO] [stdout]   10:     0x5589ee72ac34 - std::panicking::rust_panic_with_hook::hf8e86850fbbd03b1
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:606:17
[INFO] [stdout]   11:     0x5589ee72a710 - std::panicking::begin_panic_handler::{{closure}}::h590a0d6060ff866e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:502:13
[INFO] [stdout]   12:     0x5589ee728f94 - std::sys_common::backtrace::__rust_end_short_backtrace::h260b8bd1c848a03c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:139:18
[INFO] [stdout]   13:     0x5589ee72a679 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:498:5
[INFO] [stdout]   14:     0x5589ee6588f1 - core::panicking::panic_fmt::h7b8580d81fcbbacd
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panicking.rs:106:14
[INFO] [stdout]   15:     0x5589ee6589e3 - core::result::unwrap_failed::h885d3f7beb571353
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/result.rs:1613:5
[INFO] [stdout]   16:     0x5589ee66349c - core::result::Result<T,E>::unwrap::h1f89162e80250ab0
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/result.rs:1295:23
[INFO] [stdout]   17:     0x5589ee665e1d - basic::common::init_pins::h5464a6ea9a559003
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/common.rs:11:18
[INFO] [stdout]   18:     0x5589ee65a1c4 - basic::sign_verify::{{closure}}::h42bb73bc67ae5e76
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:17:26
[INFO] [stdout]   19:     0x5589ee65e11e - core::ops::function::FnOnce::call_once::hfcd901224a467300
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x5589ee6a700d - serial_test::serial_core::h169206bc74b89f71
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/serial_test-0.5.1/src/lib.rs:64:5
[INFO] [stdout]   21:     0x5589ee65a199 - basic::sign_verify::h8c36a32f76346249
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:15:1
[INFO] [stdout]   22:     0x5589ee65a16a - basic::sign_verify::{{closure}}::ha2f48c30b6992b20
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:16:1
[INFO] [stdout]   23:     0x5589ee65de3e - core::ops::function::FnOnce::call_once::h29508164d72f83c0
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   24:     0x5589ee69d9e3 - core::ops::function::FnOnce::call_once::h24a32b9da1a40fdb
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   25:     0x5589ee69d9e3 - test::__rust_begin_short_backtrace::h3c3a0492fb4a12eb
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:585:5
[INFO] [stdout]   26:     0x5589ee69c5f7 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h9a8e38435f73d5e0
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   27:     0x5589ee69c5f7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb23d7496a0e6d1b4
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   28:     0x5589ee69c5f7 - std::panicking::try::do_call::ha2bb9825b32d2cc2
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40
[INFO] [stdout]   29:     0x5589ee69c5f7 - std::panicking::try::hdc38a574bbebc53e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19
[INFO] [stdout]   30:     0x5589ee69c5f7 - std::panic::catch_unwind::hc45ed246595c621c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14
[INFO] [stdout]   31:     0x5589ee69c5f7 - test::run_test_in_process::h4249138faaea8d54
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:608:18
[INFO] [stdout]   32:     0x5589ee69c5f7 - test::run_test::run_test_inner::{{closure}}::h3c1b37669f6e9fd7
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:500:39
[INFO] [stdout]   33:     0x5589ee66989e - test::run_test::run_test_inner::{{closure}}::h388760469edd5c24
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:527:37
[INFO] [stdout]   34:     0x5589ee66989e - std::sys_common::backtrace::__rust_begin_short_backtrace::hbbaecdcfad18643e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:123:18
[INFO] [stdout]   35:     0x5589ee66e5f8 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h09cd3ca65896da91
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:484:17
[INFO] [stdout]   36:     0x5589ee66e5f8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hc52dbb4f9088d18b
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   37:     0x5589ee66e5f8 - std::panicking::try::do_call::h4485cfee22b11c08
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40
[INFO] [stdout]   38:     0x5589ee66e5f8 - std::panicking::try::hb62aa8549e20c08b
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19
[INFO] [stdout]   39:     0x5589ee66e5f8 - std::panic::catch_unwind::ha322c7a5bc666762
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14
[INFO] [stdout]   40:     0x5589ee66e5f8 - std::thread::Builder::spawn_unchecked::{{closure}}::h1076fc1398603b77
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:483:30
[INFO] [stdout]   41:     0x5589ee66e5f8 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h911e510344167353
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   42:     0x5589ee72f733 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h771719d52c343434
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   43:     0x5589ee72f733 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf441746dfa4b0f57
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   44:     0x5589ee72f733 - std::sys::unix::thread::Thread::new::thread_start::hfd168f9d312b29ca
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys/unix/thread.rs:106:17
[INFO] [stdout]   45:     0x7f5edeb80609 - start_thread
[INFO] [stdout]   46:     0x7f5ede958293 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- login_feast stdout ----
[INFO] [stdout] thread 'login_feast' panicked at 'called `Result::unwrap()` on an `Err` value: LibraryLoading(DlOpen { desc: "/usr/local/lib/softhsm/libsofthsm2.so: cannot open shared object file: No such file or directory" })', tests/common.rs:15:6
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5589ee728adc - std::backtrace_rs::backtrace::libunwind::trace::h793e05efd273d0f4
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
[INFO] [stdout]    1:     0x5589ee728adc - std::backtrace_rs::backtrace::trace_unsynchronized::h640b7b86ff610c77
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5589ee728adc - std::sys_common::backtrace::_print_fmt::h362fa2a4f354f877
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x5589ee728adc - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hf439e5ed84c74abd
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x5589ee74ba2c - core::fmt::write::h72801a82c94e6ff1
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/fmt/mod.rs:1149:17
[INFO] [stdout]    5:     0x5589ee724a85 - std::io::Write::write_fmt::h54337adeb3504c03
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/io/mod.rs:1697:15
[INFO] [stdout]    6:     0x5589ee72a580 - std::sys_common::backtrace::_print::hb29ddd998d02631c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x5589ee72a580 - std::sys_common::backtrace::print::h81965e3d7c90fbb6
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x5589ee72a580 - std::panicking::default_hook::{{closure}}::h84db205ab6674b38
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:211:50
[INFO] [stdout]    9:     0x5589ee72a166 - std::panicking::default_hook::h1bf8bb4159936bca
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:225:9
[INFO] [stdout]   10:     0x5589ee72ac34 - std::panicking::rust_panic_with_hook::hf8e86850fbbd03b1
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:606:17
[INFO] [stdout]   11:     0x5589ee72a710 - std::panicking::begin_panic_handler::{{closure}}::h590a0d6060ff866e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:502:13
[INFO] [stdout]   12:     0x5589ee728f94 - std::sys_common::backtrace::__rust_end_short_backtrace::h260b8bd1c848a03c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:139:18
[INFO] [stdout]   13:     0x5589ee72a679 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:498:5
[INFO] [stdout]   14:     0x5589ee6588f1 - core::panicking::panic_fmt::h7b8580d81fcbbacd
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panicking.rs:106:14
[INFO] [stdout]   15:     0x5589ee6589e3 - core::result::unwrap_failed::h885d3f7beb571353
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/result.rs:1613:5
[INFO] [stdout]   16:     0x5589ee66349c - core::result::Result<T,E>::unwrap::h1f89162e80250ab0
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/result.rs:1295:23
[INFO] [stdout]   17:     0x5589ee665e1d - basic::common::init_pins::h5464a6ea9a559003
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/common.rs:11:18
[INFO] [stdout]   18:     0x5589ee65d734 - basic::login_feast::{{closure}}::h7fcd85ed958f70d1
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:299:26
[INFO] [stdout]   19:     0x5589ee65e01e - core::ops::function::FnOnce::call_once::hc74226753a8d387a
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x5589ee6a700d - serial_test::serial_core::h169206bc74b89f71
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/serial_test-0.5.1/src/lib.rs:64:5
[INFO] [stdout]   21:     0x5589ee65d4e9 - basic::login_feast::h4575751e9632c6a3
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:295:1
[INFO] [stdout]   22:     0x5589ee65d4ba - basic::login_feast::{{closure}}::h5ce05a69c67ea6da
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:296:1
[INFO] [stdout]   23:     0x5589ee65e09e - core::ops::function::FnOnce::call_once::hd29726b8268de58f
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   24:     0x5589ee69d9e3 - core::ops::function::FnOnce::call_once::h24a32b9da1a40fdb
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   25:     0x5589ee69d9e3 - test::__rust_begin_short_backtrace::h3c3a0492fb4a12eb
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:585:5
[INFO] [stdout]   26:     0x5589ee69c5f7 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h9a8e38435f73d5e0
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   27:     0x5589ee69c5f7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb23d7496a0e6d1b4
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   28:     0x5589ee69c5f7 - std::panicking::try::do_call::ha2bb9825b32d2cc2
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40
[INFO] [stdout]   29:     0x5589ee69c5f7 - std::panicking::try::hdc38a574bbebc53e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19
[INFO] [stdout]   30:     0x5589ee69c5f7 - std::panic::catch_unwind::hc45ed246595c621c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14
[INFO] [stdout]   31:     0x5589ee69c5f7 - test::run_test_in_process::h4249138faaea8d54
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:608:18
[INFO] [stdout]   32:     0x5589ee69c5f7 - test::run_test::run_test_inner::{{closure}}::h3c1b37669f6e9fd7
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:500:39
[INFO] [stdout]   33:     0x5589ee66989e - test::run_test::run_test_inner::{{closure}}::h388760469edd5c24
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:527:37
[INFO] [stdout]   34:     0x5589ee66989e - std::sys_common::backtrace::__rust_begin_short_backtrace::hbbaecdcfad18643e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:123:18
[INFO] [stdout]   35:     0x5589ee66e5f8 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h09cd3ca65896da91
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:484:17
[INFO] [stdout]   36:     0x5589ee66e5f8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hc52dbb4f9088d18b
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   37:     0x5589ee66e5f8 - std::panicking::try::do_call::h4485cfee22b11c08
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40
[INFO] [stdout]   38:     0x5589ee66e5f8 - std::panicking::try::hb62aa8549e20c08b
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19
[INFO] [stdout]   39:     0x5589ee66e5f8 - std::panic::catch_unwind::ha322c7a5bc666762
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14
[INFO] [stdout]   40:     0x5589ee66e5f8 - std::thread::Builder::spawn_unchecked::{{closure}}::h1076fc1398603b77
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:483:30
[INFO] [stdout]   41:     0x5589ee66e5f8 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h911e510344167353
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   42:     0x5589ee72f733 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h771719d52c343434
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   43:     0x5589ee72f733 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf441746dfa4b0f57
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   44:     0x5589ee72f733 - std::sys::unix::thread::Thread::new::thread_start::hfd168f9d312b29ca
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys/unix/thread.rs:106:17
[INFO] [stdout]   45:     0x7f5edeb80609 - start_thread
[INFO] [stdout]   46:     0x7f5ede958293 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- import_export stdout ----
[INFO] [stdout] thread 'import_export' panicked at 'called `Result::unwrap()` on an `Err` value: LibraryLoading(DlOpen { desc: "/usr/local/lib/softhsm/libsofthsm2.so: cannot open shared object file: No such file or directory" })', tests/common.rs:15:6
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5589ee728adc - std::backtrace_rs::backtrace::libunwind::trace::h793e05efd273d0f4
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
[INFO] [stdout]    1:     0x5589ee728adc - std::backtrace_rs::backtrace::trace_unsynchronized::h640b7b86ff610c77
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5589ee728adc - std::sys_common::backtrace::_print_fmt::h362fa2a4f354f877
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x5589ee728adc - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hf439e5ed84c74abd
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x5589ee74ba2c - core::fmt::write::h72801a82c94e6ff1
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/fmt/mod.rs:1149:17
[INFO] [stdout]    5:     0x5589ee724a85 - std::io::Write::write_fmt::h54337adeb3504c03
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/io/mod.rs:1697:15
[INFO] [stdout]    6:     0x5589ee72a580 - std::sys_common::backtrace::_print::hb29ddd998d02631c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x5589ee72a580 - std::sys_common::backtrace::print::h81965e3d7c90fbb6
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x5589ee72a580 - std::panicking::default_hook::{{closure}}::h84db205ab6674b38
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:211:50
[INFO] [stdout]    9:     0x5589ee72a166 - std::panicking::default_hook::h1bf8bb4159936bca
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:225:9
[INFO] [stdout]   10:     0x5589ee72ac34 - std::panicking::rust_panic_with_hook::hf8e86850fbbd03b1
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:606:17
[INFO] [stdout]   11:     0x5589ee72a710 - std::panicking::begin_panic_handler::{{closure}}::h590a0d6060ff866e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:502:13
[INFO] [stdout]   12:     0x5589ee728f94 - std::sys_common::backtrace::__rust_end_short_backtrace::h260b8bd1c848a03c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:139:18
[INFO] [stdout]   13:     0x5589ee72a679 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:498:5
[INFO] [stdout]   14:     0x5589ee6588f1 - core::panicking::panic_fmt::h7b8580d81fcbbacd
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panicking.rs:106:14
[INFO] [stdout]   15:     0x5589ee6589e3 - core::result::unwrap_failed::h885d3f7beb571353
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/result.rs:1613:5
[INFO] [stdout]   16:     0x5589ee66349c - core::result::Result<T,E>::unwrap::h1f89162e80250ab0
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/result.rs:1295:23
[INFO] [stdout]   17:     0x5589ee665e1d - basic::common::init_pins::h5464a6ea9a559003
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/common.rs:11:18
[INFO] [stdout]   18:     0x5589ee65c6ac - basic::import_export::{{closure}}::h1ade1e5ef2ee29f5
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:228:26
[INFO] [stdout]   19:     0x5589ee65debe - core::ops::function::FnOnce::call_once::h695bfc71b8627907
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x5589ee6a700d - serial_test::serial_core::h169206bc74b89f71
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/serial_test-0.5.1/src/lib.rs:64:5
[INFO] [stdout]   21:     0x5589ee65c679 - basic::import_export::h882193e262c53918
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:226:1
[INFO] [stdout]   22:     0x5589ee65c64a - basic::import_export::{{closure}}::h3230ba9531e56a1f
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:227:1
[INFO] [stdout]   23:     0x5589ee65dfce - core::ops::function::FnOnce::call_once::hc0a8813e55aef273
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   24:     0x5589ee69d9e3 - core::ops::function::FnOnce::call_once::h24a32b9da1a40fdb
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   25:     0x5589ee69d9e3 - test::__rust_begin_short_backtrace::h3c3a0492fb4a12eb
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:585:5
[INFO] [stdout]   26:     0x5589ee69c5f7 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h9a8e38435f73d5e0
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   27:     0x5589ee69c5f7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb23d7496a0e6d1b4
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   28:     0x5589ee69c5f7 - std::panicking::try::do_call::ha2bb9825b32d2cc2
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40
[INFO] [stdout]   29:     0x5589ee69c5f7 - std::panicking::try::hdc38a574bbebc53e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19
[INFO] [stdout]   30:     0x5589ee69c5f7 - std::panic::catch_unwind::hc45ed246595c621c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14
[INFO] [stdout]   31:     0x5589ee69c5f7 - test::run_test_in_process::h4249138faaea8d54
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:608:18
[INFO] [stdout]   32:     0x5589ee69c5f7 - test::run_test::run_test_inner::{{closure}}::h3c1b37669f6e9fd7
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:500:39
[INFO] [stdout]   33:     0x5589ee66989e - test::run_test::run_test_inner::{{closure}}::h388760469edd5c24
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:527:37
[INFO] [stdout]   34:     0x5589ee66989e - std::sys_common::backtrace::__rust_begin_short_backtrace::hbbaecdcfad18643e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:123:18
[INFO] [stdout]   35:     0x5589ee66e5f8 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h09cd3ca65896da91
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:484:17
[INFO] [stdout]   36:     0x5589ee66e5f8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hc52dbb4f9088d18b
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   37:     0x5589ee66e5f8 - std::panicking::try::do_call::h4485cfee22b11c08
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40
[INFO] [stdout]   38:     0x5589ee66e5f8 - std::panicking::try::hb62aa8549e20c08b
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19
[INFO] [stdout]   39:     0x5589ee66e5f8 - std::panic::catch_unwind::ha322c7a5bc666762
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14
[INFO] [stdout]   40:     0x5589ee66e5f8 - std::thread::Builder::spawn_unchecked::{{closure}}::h1076fc1398603b77
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:483:30
[INFO] [stdout]   41:     0x5589ee66e5f8 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h911e510344167353
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   42:     0x5589ee72f733 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h771719d52c343434
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   43:     0x5589ee72f733 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf441746dfa4b0f57
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   44:     0x5589ee72f733 - std::sys::unix::thread::Thread::new::thread_start::hfd168f9d312b29ca
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys/unix/thread.rs:106:17
[INFO] [stdout]   45:     0x7f5edeb80609 - start_thread
[INFO] [stdout]   46:     0x7f5ede958293 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- get_token_info stdout ----
[INFO] [stdout] thread 'get_token_info' panicked at 'called `Result::unwrap()` on an `Err` value: LibraryLoading(DlOpen { desc: "/usr/local/lib/softhsm/libsofthsm2.so: cannot open shared object file: No such file or directory" })', tests/common.rs:15:6
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5589ee728adc - std::backtrace_rs::backtrace::libunwind::trace::h793e05efd273d0f4
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
[INFO] [stdout]    1:     0x5589ee728adc - std::backtrace_rs::backtrace::trace_unsynchronized::h640b7b86ff610c77
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5589ee728adc - std::sys_common::backtrace::_print_fmt::h362fa2a4f354f877
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x5589ee728adc - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hf439e5ed84c74abd
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x5589ee74ba2c - core::fmt::write::h72801a82c94e6ff1
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/fmt/mod.rs:1149:17
[INFO] [stdout]    5:     0x5589ee724a85 - std::io::Write::write_fmt::h54337adeb3504c03
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/io/mod.rs:1697:15
[INFO] [stdout]    6:     0x5589ee72a580 - std::sys_common::backtrace::_print::hb29ddd998d02631c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x5589ee72a580 - std::sys_common::backtrace::print::h81965e3d7c90fbb6
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x5589ee72a580 - std::panicking::default_hook::{{closure}}::h84db205ab6674b38
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:211:50
[INFO] [stdout]    9:     0x5589ee72a166 - std::panicking::default_hook::h1bf8bb4159936bca
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:225:9
[INFO] [stdout]   10:     0x5589ee72ac34 - std::panicking::rust_panic_with_hook::hf8e86850fbbd03b1
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:606:17
[INFO] [stdout]   11:     0x5589ee72a710 - std::panicking::begin_panic_handler::{{closure}}::h590a0d6060ff866e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:502:13
[INFO] [stdout]   12:     0x5589ee728f94 - std::sys_common::backtrace::__rust_end_short_backtrace::h260b8bd1c848a03c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:139:18
[INFO] [stdout]   13:     0x5589ee72a679 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:498:5
[INFO] [stdout]   14:     0x5589ee6588f1 - core::panicking::panic_fmt::h7b8580d81fcbbacd
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panicking.rs:106:14
[INFO] [stdout]   15:     0x5589ee6589e3 - core::result::unwrap_failed::h885d3f7beb571353
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/result.rs:1613:5
[INFO] [stdout]   16:     0x5589ee66349c - core::result::Result<T,E>::unwrap::h1f89162e80250ab0
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/result.rs:1295:23
[INFO] [stdout]   17:     0x5589ee665e1d - basic::common::init_pins::h5464a6ea9a559003
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/common.rs:11:18
[INFO] [stdout]   18:     0x5589ee65d30c - basic::get_token_info::{{closure}}::h88e3acad554c0aca
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:289:26
[INFO] [stdout]   19:     0x5589ee65de7e - core::ops::function::FnOnce::call_once::h2e87aeaf9de7ffa3
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x5589ee6a700d - serial_test::serial_core::h169206bc74b89f71
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/serial_test-0.5.1/src/lib.rs:64:5
[INFO] [stdout]   21:     0x5589ee65d2e9 - basic::get_token_info::h6f33a4ceca20a9b9
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:287:1
[INFO] [stdout]   22:     0x5589ee65d2ba - basic::get_token_info::{{closure}}::h55c4894570c98650
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/basic.rs:288:1
[INFO] [stdout]   23:     0x5589ee65dd4e - core::ops::function::FnOnce::call_once::h17b2103800898b1b
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   24:     0x5589ee69d9e3 - core::ops::function::FnOnce::call_once::h24a32b9da1a40fdb
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   25:     0x5589ee69d9e3 - test::__rust_begin_short_backtrace::h3c3a0492fb4a12eb
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:585:5
[INFO] [stdout]   26:     0x5589ee69c5f7 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h9a8e38435f73d5e0
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   27:     0x5589ee69c5f7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb23d7496a0e6d1b4
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   28:     0x5589ee69c5f7 - std::panicking::try::do_call::ha2bb9825b32d2cc2
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40
[INFO] [stdout]   29:     0x5589ee69c5f7 - std::panicking::try::hdc38a574bbebc53e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19
[INFO] [stdout]   30:     0x5589ee69c5f7 - std::panic::catch_unwind::hc45ed246595c621c
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14
[INFO] [stdout]   31:     0x5589ee69c5f7 - test::run_test_in_process::h4249138faaea8d54
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:608:18
[INFO] [stdout]   32:     0x5589ee69c5f7 - test::run_test::run_test_inner::{{closure}}::h3c1b37669f6e9fd7
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:500:39
[INFO] [stdout]   33:     0x5589ee66989e - test::run_test::run_test_inner::{{closure}}::h388760469edd5c24
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:527:37
[INFO] [stdout]   34:     0x5589ee66989e - std::sys_common::backtrace::__rust_begin_short_backtrace::hbbaecdcfad18643e
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:123:18
[INFO] [stdout]   35:     0x5589ee66e5f8 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h09cd3ca65896da91
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:484:17
[INFO] [stdout]   36:     0x5589ee66e5f8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hc52dbb4f9088d18b
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   37:     0x5589ee66e5f8 - std::panicking::try::do_call::h4485cfee22b11c08
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40
[INFO] [stdout]   38:     0x5589ee66e5f8 - std::panicking::try::hb62aa8549e20c08b
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19
[INFO] [stdout]   39:     0x5589ee66e5f8 - std::panic::catch_unwind::ha322c7a5bc666762
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14
[INFO] [stdout]   40:     0x5589ee66e5f8 - std::thread::Builder::spawn_unchecked::{{closure}}::h1076fc1398603b77
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:483:30
[INFO] [stdout]   41:     0x5589ee66e5f8 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h911e510344167353
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   42:     0x5589ee72f733 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h771719d52c343434
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   43:     0x5589ee72f733 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf441746dfa4b0f57
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   44:     0x5589ee72f733 - std::sys::unix::thread::Thread::new::thread_start::hfd168f9d312b29ca
[INFO] [stdout]                                at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys/unix/thread.rs:106:17
[INFO] [stdout]   45:     0x7f5edeb80609 - start_thread
[INFO] [stdout]   46:     0x7f5ede958293 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     derive_key
[INFO] [stdout]     encrypt_decrypt
[INFO] [stdout]     get_token_info
[INFO] [stdout]     import_export
[INFO] [stdout]     login_feast
[INFO] [stdout]     sign_verify
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 6 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "28d22f5466dd90270cfa8c852c01716cdc2485c3272ded59b8ff400de06d3156", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "28d22f5466dd90270cfa8c852c01716cdc2485c3272ded59b8ff400de06d3156", kill_on_drop: false }`
[INFO] [stdout] 28d22f5466dd90270cfa8c852c01716cdc2485c3272ded59b8ff400de06d3156