[INFO] fetching crate cryptoki 0.10.1...
[INFO] testing cryptoki-0.10.1 against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate cryptoki 0.10.1 into /workspace/builds/worker-3-tc1/source
[INFO] started tweaking crates.io crate cryptoki 0.10.1
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate cryptoki 0.10.1
[INFO] tweaked toml for crates.io crate cryptoki 0.10.1 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate cryptoki 0.10.1 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate cryptoki 0.10.1 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded serial_test v0.5.1
[INFO] [stderr]   Downloaded testresult v0.4.1
[INFO] [stderr]   Downloaded serial_test_derive v0.5.1
[INFO] [stderr]   Downloaded libloading v0.8.6
[INFO] [stderr]   Downloaded syn v2.0.50
[INFO] [stderr]   Downloaded bindgen v0.70.1
[INFO] [stderr]   Downloaded cryptoki-sys v0.4.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 2c1be6eeaaf256f71ea38f58486018a6d7fe2634c704f63e82022db098b2523f
[INFO] running `Command { std: "docker" "start" "2c1be6eeaaf256f71ea38f58486018a6d7fe2634c704f63e82022db098b2523f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2c1be6eeaaf256f71ea38f58486018a6d7fe2634c704f63e82022db098b2523f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "2c1be6eeaaf256f71ea38f58486018a6d7fe2634c704f63e82022db098b2523f" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2c1be6eeaaf256f71ea38f58486018a6d7fe2634c704f63e82022db098b2523f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "2c1be6eeaaf256f71ea38f58486018a6d7fe2634c704f63e82022db098b2523f" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling cryptoki-sys v0.4.0
[INFO] [stderr]    Compiling zeroize v1.7.0
[INFO] [stderr]    Compiling log v0.4.20
[INFO] [stderr]    Compiling libloading v0.8.6
[INFO] [stderr]    Compiling secrecy v0.8.0
[INFO] [stderr]    Compiling cryptoki v0.10.1 (/opt/rustwide/workdir)
[INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing
[INFO] [stdout]    --> src/session/object_management.rs:227:25
[INFO] [stdout]     |
[INFO] [stdout] 227 |     pub fn iter_objects(&self, template: &[Attribute]) -> Result<ObjectHandleIterator> {
[INFO] [stdout]     |                         ^^^^^ the lifetime is elided here        ^^^^^^^^^^^^^^^^^^^^ the same lifetime is hidden here
[INFO] [stdout]     |
[INFO] [stdout]     = help: the same lifetime is referred to in inconsistent ways, making the signature confusing
[INFO] [stdout]     = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default
[INFO] [stdout] help: use `'_` for type paths
[INFO] [stdout]     |
[INFO] [stdout] 227 |     pub fn iter_objects(&self, template: &[Attribute]) -> Result<ObjectHandleIterator<'_>> {
[INFO] [stdout]     |                                                                                      ++++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing
[INFO] [stdout]    --> src/session/object_management.rs:248:9
[INFO] [stdout]     |
[INFO] [stdout] 248 |         &self,
[INFO] [stdout]     |         ^^^^^ the lifetime is elided here
[INFO] [stdout] ...
[INFO] [stdout] 251 |     ) -> Result<ObjectHandleIterator> {
[INFO] [stdout]     |                 ^^^^^^^^^^^^^^^^^^^^ the same lifetime is hidden here
[INFO] [stdout]     |
[INFO] [stdout]     = help: the same lifetime is referred to in inconsistent ways, making the signature confusing
[INFO] [stdout] help: use `'_` for type paths
[INFO] [stdout]     |
[INFO] [stdout] 251 |     ) -> Result<ObjectHandleIterator<'_>> {
[INFO] [stdout]     |                                     ++++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 4.09s
[INFO] running `Command { std: "docker" "inspect" "2c1be6eeaaf256f71ea38f58486018a6d7fe2634c704f63e82022db098b2523f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "2c1be6eeaaf256f71ea38f58486018a6d7fe2634c704f63e82022db098b2523f" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.153
[INFO] [stderr]    Compiling lock_api v0.4.11
[INFO] [stderr]    Compiling parking_lot_core v0.8.6
[INFO] [stderr]    Compiling instant v0.1.12
[INFO] [stderr]    Compiling smallvec v1.13.1
[INFO] [stderr]    Compiling num-traits v0.2.18
[INFO] [stderr]    Compiling testresult v0.4.1
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing
[INFO] [stdout]    --> src/session/object_management.rs:227:25
[INFO] [stdout]     |
[INFO] [stdout] 227 |     pub fn iter_objects(&self, template: &[Attribute]) -> Result<ObjectHandleIterator> {
[INFO] [stdout]     |                         ^^^^^ the lifetime is elided here        ^^^^^^^^^^^^^^^^^^^^ the same lifetime is hidden here
[INFO] [stdout]     |
[INFO] [stdout]     = help: the same lifetime is referred to in inconsistent ways, making the signature confusing
[INFO] [stdout]     = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default
[INFO] [stdout] help: use `'_` for type paths
[INFO] [stdout]     |
[INFO] [stdout] 227 |     pub fn iter_objects(&self, template: &[Attribute]) -> Result<ObjectHandleIterator<'_>> {
[INFO] [stdout]     |                                                                                      ++++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing
[INFO] [stdout]    --> src/session/object_management.rs:248:9
[INFO] [stdout]     |
[INFO] [stdout] 248 |         &self,
[INFO] [stdout]     |         ^^^^^ the lifetime is elided here
[INFO] [stdout] ...
[INFO] [stdout] 251 |     ) -> Result<ObjectHandleIterator> {
[INFO] [stdout]     |                 ^^^^^^^^^^^^^^^^^^^^ the same lifetime is hidden here
[INFO] [stdout]     |
[INFO] [stdout]     = help: the same lifetime is referred to in inconsistent ways, making the signature confusing
[INFO] [stdout] help: use `'_` for type paths
[INFO] [stdout]     |
[INFO] [stdout] 251 |     ) -> Result<ObjectHandleIterator<'_>> {
[INFO] [stdout]     |                                     ++++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling parking_lot v0.11.2
[INFO] [stderr]    Compiling serial_test_derive v0.5.1
[INFO] [stderr]    Compiling serial_test v0.5.1
[INFO] [stderr]    Compiling cryptoki v0.10.1 (/opt/rustwide/workdir)
[INFO] [stdout] warning: variable does not need to be mutable
[INFO] [stdout]     --> tests/basic.rs:1200:9
[INFO] [stdout]      |
[INFO] [stdout] 1200 |     let mut priv_attribs = [
[INFO] [stdout]      |         ----^^^^^^^^^^^^
[INFO] [stdout]      |         |
[INFO] [stdout]      |         help: remove this `mut`
[INFO] [stdout]      |
[INFO] [stdout]      = note: `#[warn(unused_mut)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing
[INFO] [stdout]    --> src/session/object_management.rs:227:25
[INFO] [stdout]     |
[INFO] [stdout] 227 |     pub fn iter_objects(&self, template: &[Attribute]) -> Result<ObjectHandleIterator> {
[INFO] [stdout]     |                         ^^^^^ the lifetime is elided here        ^^^^^^^^^^^^^^^^^^^^ the same lifetime is hidden here
[INFO] [stdout]     |
[INFO] [stdout]     = help: the same lifetime is referred to in inconsistent ways, making the signature confusing
[INFO] [stdout]     = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default
[INFO] [stdout] help: use `'_` for type paths
[INFO] [stdout]     |
[INFO] [stdout] 227 |     pub fn iter_objects(&self, template: &[Attribute]) -> Result<ObjectHandleIterator<'_>> {
[INFO] [stdout]     |                                                                                      ++++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing
[INFO] [stdout]    --> src/session/object_management.rs:248:9
[INFO] [stdout]     |
[INFO] [stdout] 248 |         &self,
[INFO] [stdout]     |         ^^^^^ the lifetime is elided here
[INFO] [stdout] ...
[INFO] [stdout] 251 |     ) -> Result<ObjectHandleIterator> {
[INFO] [stdout]     |                 ^^^^^^^^^^^^^^^^^^^^ the same lifetime is hidden here
[INFO] [stdout]     |
[INFO] [stdout]     = help: the same lifetime is referred to in inconsistent ways, making the signature confusing
[INFO] [stdout] help: use `'_` for type paths
[INFO] [stdout]     |
[INFO] [stdout] 251 |     ) -> Result<ObjectHandleIterator<'_>> {
[INFO] [stdout]     |                                     ++++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 10.61s
[INFO] running `Command { std: "docker" "inspect" "2c1be6eeaaf256f71ea38f58486018a6d7fe2634c704f63e82022db098b2523f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "2c1be6eeaaf256f71ea38f58486018a6d7fe2634c704f63e82022db098b2523f" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing
[INFO] [stderr]    --> src/session/object_management.rs:227:25
[INFO] [stderr]     |
[INFO] [stderr] 227 |     pub fn iter_objects(&self, template: &[Attribute]) -> Result<ObjectHandleIterator> {
[INFO] [stderr]     |                         ^^^^^ the lifetime is elided here        ^^^^^^^^^^^^^^^^^^^^ the same lifetime is hidden here
[INFO] [stderr]     |
[INFO] [stderr]     = help: the same lifetime is referred to in inconsistent ways, making the signature confusing
[INFO] [stderr]     = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default
[INFO] [stderr] help: use `'_` for type paths
[INFO] [stderr]     |
[INFO] [stderr] 227 |     pub fn iter_objects(&self, template: &[Attribute]) -> Result<ObjectHandleIterator<'_>> {
[INFO] [stderr]     |                                                                                      ++++
[INFO] [stderr] 
[INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing
[INFO] [stderr]    --> src/session/object_management.rs:248:9
[INFO] [stderr]     |
[INFO] [stderr] 248 |         &self,
[INFO] [stderr]     |         ^^^^^ the lifetime is elided here
[INFO] [stderr] ...
[INFO] [stderr] 251 |     ) -> Result<ObjectHandleIterator> {
[INFO] [stderr]     |                 ^^^^^^^^^^^^^^^^^^^^ the same lifetime is hidden here
[INFO] [stderr]     |
[INFO] [stderr]     = help: the same lifetime is referred to in inconsistent ways, making the signature confusing
[INFO] [stderr] help: use `'_` for type paths
[INFO] [stderr]     |
[INFO] [stderr] 251 |     ) -> Result<ObjectHandleIterator<'_>> {
[INFO] [stderr]     |                                     ++++
[INFO] [stderr] 
[INFO] [stderr] warning: `cryptoki` (lib) generated 2 warnings (run `cargo fix --lib -p cryptoki` to apply 2 suggestions)
[INFO] [stderr] warning: variable does not need to be mutable
[INFO] [stderr]     --> tests/basic.rs:1200:9
[INFO] [stderr]      |
[INFO] [stderr] 1200 |     let mut priv_attribs = [
[INFO] [stderr]      |         ----^^^^^^^^^^^^
[INFO] [stderr]      |         |
[INFO] [stderr]      |         help: remove this `mut`
[INFO] [stderr]      |
[INFO] [stderr]      = note: `#[warn(unused_mut)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `cryptoki` (test "basic") generated 1 warning (run `cargo fix --test "basic" -p cryptoki` to apply 1 suggestion)
[INFO] [stderr] warning: `cryptoki` (lib test) generated 2 warnings (2 duplicates)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/cryptoki-d62df301529bbb68)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test mechanism::mechanism_info::test::debug_info ... ok
[INFO] [stdout] test slot::token_info::test::debug_info ... ok
[INFO] [stdout] test types::test::utc_time_display_fmt ... ok
[INFO] [stdout] test session::session_info::test::debug_flags_all ... ok
[INFO] [stdout] test slot::slot_info::test::debug_flags_all ... ok
[INFO] [stdout] test types::test::utc_time_convert_good ... ok
[INFO] [stdout] test slot::token_info::test::debug_flags_all ... ok
[INFO] [stdout] test slot::slot_info::test::debug_info ... ok
[INFO] [stdout] test mechanism::mechanism_info::test::debug_flags_all ... ok
[INFO] [stdout] test types::test::utc_time_debug_fmt ... ok
[INFO] [stdout] test session::session_info::test::debug_info ... ok
[INFO] [stdout] test types::test::utc_time_convert_bad ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/allowed_mechanisms.rs (/opt/rustwide/target/release/deps/allowed_mechanisms-a23408b7dc8a8533)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test nonempty_allowed_mechanisms_round_trip_preserves_element_count ... ok
[INFO] [stdout] test allowed_mechanisms_raw_length_is_measured_in_bytes ... ok
[INFO] [stdout] test null_nonempty_allowed_mechanisms_value_is_rejected ... ok
[INFO] [stdout] test unaligned_allowed_mechanisms_value_is_decoded_as_bytes ... ok
[INFO] [stdout] test malformed_allowed_mechanisms_byte_length_is_rejected ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/basic.rs (/opt/rustwide/target/release/deps/basic-e2f4c445127b34ee)
[INFO] [stdout] 
[INFO] [stdout] running 66 tests
[INFO] [stdout] test derive_key ... FAILED
[INFO] [stdout] test aes_gcm_with_aad ... FAILED
[INFO] [stdout] test aes_gcm_no_aad ... ok
[INFO] [stdout] test ekdf_aes_cbc_encrypt_data ... FAILED
[INFO] [stdout] test aes_cbc_encrypt ... FAILED
[INFO] [stdout] test generate_generic_secret_key ... FAILED
[INFO] [stdout] test aes_key_attributes_test ... FAILED
[INFO] [stdout] test encrypt_decrypt_multipart ... FAILED
[INFO] [stdout] test encrypt_decrypt_multipart_not_initialized ... FAILED
[INFO] [stdout] test gcm_param_graceful_failure ... ok
[INFO] [stdout] test aes_cmac_sign ... FAILED
[INFO] [stdout] test encrypt_decrypt_gcm_message_no_aad ... FAILED
[INFO] [stdout] test encrypt_decrypt_gcm_message_with_aad ... FAILED
[INFO] [stdout] test encrypt_decrypt ... FAILED
[INFO] [stdout] test aes_cmac_verify ... FAILED
[INFO] [stdout] test encrypt_decrypt_multipart_already_initialized ... FAILED
[INFO] [stdout] test kbkdf_additional_keys_double_pipeline_mode ... ignored, unsupported by both SoftHSM and Kryoptic for the moment
[INFO] [stdout] test kbkdf_double_pipeline_mode ... ignored, unsupported by both SoftHSM and Kryoptic for the moment
[INFO] [stdout] test aes_cbc_pad_encrypt ... FAILED
[INFO] [stdout] test is_fn_supported_test ... FAILED
[INFO] [stdout] test kbkdf_invalid_data_params_double_pipeline_mode ... ok
[INFO] [stdout] test get_slot_event ... FAILED
[INFO] [stdout] test ro_rw_session_test ... FAILED
[INFO] [stdout] test get_token_info ... FAILED
[INFO] [stdout] test kbkdf_additional_keys_counter_mode ... ok
[INFO] [stdout] test kbkdf_counter_mode ... ok
[INFO] [stdout] test import_export ... FAILED
[INFO] [stdout] test kbkdf_feedback_mode ... ok
[INFO] [stdout] test set_pin_test ... FAILED
[INFO] [stdout] test get_attribute_info_test ... FAILED
[INFO] [stdout] test rsa_pkcs_oaep_with_data ... ok
[INFO] [stdout] test session_find_objects ... FAILED
[INFO] [stdout] test session_objecthandle_iterator ... FAILED
[INFO] [stdout] test get_session_info_test ... FAILED
[INFO] [stdout] test kbkdf_additional_keys_feedback_mode ... ok
[INFO] [stdout] test get_info_test ... FAILED
[INFO] [stdout] test get_slot_info_test ... FAILED
[INFO] [stdout] test sha256_digest ... FAILED
[INFO] [stdout] test generate_random_test ... FAILED
[INFO] [stdout] test kbkdf_invalid_data_params_counter_mode ... ok
[INFO] [stdout] test session_copy_object ... FAILED
[INFO] [stdout] test sha256_digest_multipart_already_initialized ... FAILED
[INFO] [stdout] test kbkdf_invalid_data_params_feedback_mode ... ok
[INFO] [stdout] test sha256_digest_multipart ... FAILED
[INFO] [stdout] test sign_verify_eddsa_with_ed448_schemes ... FAILED
[INFO] [stdout] test login_feast ... FAILED
[INFO] [stdout] test sha256_digest_multipart_not_initialized ... FAILED
[INFO] [stdout] test rsa_pkcs_oaep_empty ... FAILED
[INFO] [stdout] test sign_verify ... FAILED
[INFO] [stdout] test is_initialized_test ... FAILED
[INFO] [stdout] test sign_verify_eddsa ... FAILED
[INFO] [stdout] test sign_verify_sha512_hmac ... FAILED
[INFO] [stdout] test sign_verify_sha256_hmac ... FAILED
[INFO] [stdout] test sha256_digest_multipart_with_key ... FAILED
[INFO] [stdout] test test_clone_initialize ... FAILED
[INFO] [stdout] test update_attributes_key ... FAILED
[INFO] [stdout] test sign_verify_multipart ... FAILED
[INFO] [stdout] test sign_verify_sha224_hmac ... FAILED
[INFO] [stdout] test sign_verify_multipart_not_initialized ... FAILED
[INFO] [stdout] test unique_id ... FAILED
[INFO] [stdout] test sign_verify_sha384_hmac ... FAILED
[INFO] [stdout] test sign_verify_multipart_already_initialized ... FAILED
[INFO] [stdout] test wrap_and_unwrap_key ... FAILED
[INFO] [stdout] test sign_verify_eddsa_with_ed25519_schemes ... FAILED
[INFO] [stdout] test sign_verify_sha1_hmac ... FAILED
[INFO] [stdout] test wait_for_slot_event ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- derive_key stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'derive_key' (729) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a675cd4e - <basic[52c7ad9f75458f07]::derive_key::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c0e7 - <basic[52c7ad9f75458f07]::derive_key::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- aes_gcm_with_aad stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'aes_gcm_with_aad' (727) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a67619e8 - <basic[52c7ad9f75458f07]::aes_gcm_with_aad::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c387 - <basic[52c7ad9f75458f07]::aes_gcm_with_aad::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- ekdf_aes_cbc_encrypt_data stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'ekdf_aes_cbc_encrypt_data' (730) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a676f149 - <basic[52c7ad9f75458f07]::ekdf_aes_cbc_encrypt_data::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c8c7 - <basic[52c7ad9f75458f07]::ekdf_aes_cbc_encrypt_data::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- aes_cbc_encrypt stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'aes_cbc_encrypt' (722) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a67609fb - <basic[52c7ad9f75458f07]::aes_cbc_encrypt::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c2f7 - <basic[52c7ad9f75458f07]::aes_cbc_encrypt::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- generate_generic_secret_key stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'generate_generic_secret_key' (738) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a6771969 - <basic[52c7ad9f75458f07]::generate_generic_secret_key::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c987 - <basic[52c7ad9f75458f07]::generate_generic_secret_key::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- aes_key_attributes_test stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'aes_key_attributes_test' (728) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a676aeee - <basic[52c7ad9f75458f07]::aes_key_attributes_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c747 - <basic[52c7ad9f75458f07]::aes_key_attributes_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- encrypt_decrypt_multipart stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'encrypt_decrypt_multipart' (734) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a677008e - <basic[52c7ad9f75458f07]::encrypt_decrypt_multipart::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c8f7 - <basic[52c7ad9f75458f07]::encrypt_decrypt_multipart::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- encrypt_decrypt_multipart_not_initialized stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'encrypt_decrypt_multipart_not_initialized' (736) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a677d912 - <basic[52c7ad9f75458f07]::encrypt_decrypt_multipart_not_initialized::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675cbf7 - <basic[52c7ad9f75458f07]::encrypt_decrypt_multipart_not_initialized::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- aes_cmac_sign stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'aes_cmac_sign' (724) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a675a7d8 - basic[52c7ad9f75458f07]::aes_cmac_sign_impl
[INFO] [stdout]   14:     0x6055a675ea69 - <basic[52c7ad9f75458f07]::aes_cmac_sign::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   15:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   16:     0x6055a675c1a7 - <basic[52c7ad9f75458f07]::aes_cmac_sign::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   17:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   18:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   19:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   20:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   21:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   22:     0x786a236eddfa - <unknown>
[INFO] [stdout]   23:     0x786a237813d4 - clone
[INFO] [stdout]   24:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- encrypt_decrypt_gcm_message_no_aad stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'encrypt_decrypt_gcm_message_no_aad' (732) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a67741be - <basic[52c7ad9f75458f07]::encrypt_decrypt_gcm_message_no_aad::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675ca17 - <basic[52c7ad9f75458f07]::encrypt_decrypt_gcm_message_no_aad::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- encrypt_decrypt_gcm_message_with_aad stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'encrypt_decrypt_gcm_message_with_aad' (733) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a6778f4e - <basic[52c7ad9f75458f07]::encrypt_decrypt_gcm_message_with_aad::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675caa7 - <basic[52c7ad9f75458f07]::encrypt_decrypt_gcm_message_with_aad::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- encrypt_decrypt stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'encrypt_decrypt' (731) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a676106e - <basic[52c7ad9f75458f07]::encrypt_decrypt::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c357 - <basic[52c7ad9f75458f07]::encrypt_decrypt::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- aes_cmac_verify stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'aes_cmac_verify' (725) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a675aec8 - basic[52c7ad9f75458f07]::aes_cmac_verify_impl
[INFO] [stdout]   14:     0x6055a6760f59 - <basic[52c7ad9f75458f07]::aes_cmac_verify::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   15:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   16:     0x6055a675c327 - <basic[52c7ad9f75458f07]::aes_cmac_verify::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   17:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   18:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   19:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   20:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   21:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   22:     0x786a236eddfa - <unknown>
[INFO] [stdout]   23:     0x786a237813d4 - clone
[INFO] [stdout]   24:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- encrypt_decrypt_multipart_already_initialized stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'encrypt_decrypt_multipart_already_initialized' (735) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a678092a - <basic[52c7ad9f75458f07]::encrypt_decrypt_multipart_already_initialized::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675ccb7 - <basic[52c7ad9f75458f07]::encrypt_decrypt_multipart_already_initialized::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- aes_cbc_pad_encrypt stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'aes_cbc_pad_encrypt' (723) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a6764028 - <basic[52c7ad9f75458f07]::aes_cbc_pad_encrypt::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c477 - <basic[52c7ad9f75458f07]::aes_cbc_pad_encrypt::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- is_fn_supported_test stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'is_fn_supported_test' (747) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a6767ab1 - <basic[52c7ad9f75458f07]::is_fn_supported_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a67d0374 - serial_test[ca9b57f5193cb429]::serial_core
[INFO] [stdout]   15:     0x6055a675c5f8 - <basic[52c7ad9f75458f07]::is_fn_supported_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- get_slot_event stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'get_slot_event' (743) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a67605e1 - <basic[52c7ad9f75458f07]::get_slot_event::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c297 - <basic[52c7ad9f75458f07]::get_slot_event::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- ro_rw_session_test stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'ro_rw_session_test' (757) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a6763804 - <basic[52c7ad9f75458f07]::ro_rw_session_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c447 - <basic[52c7ad9f75458f07]::ro_rw_session_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- get_token_info stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'get_token_info' (745) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a6760774 - <basic[52c7ad9f75458f07]::get_token_info::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c2c7 - <basic[52c7ad9f75458f07]::get_token_info::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- import_export stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'import_export' (746) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a675edfe - <basic[52c7ad9f75458f07]::import_export::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c207 - <basic[52c7ad9f75458f07]::import_export::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- set_pin_test stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'set_pin_test' (763) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a675e667 - <basic[52c7ad9f75458f07]::set_pin_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c177 - <basic[52c7ad9f75458f07]::set_pin_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- get_attribute_info_test stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'get_attribute_info_test' (740) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a676b7ae - <basic[52c7ad9f75458f07]::get_attribute_info_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c777 - <basic[52c7ad9f75458f07]::get_attribute_info_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- session_find_objects stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'session_find_objects' (761) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a6767c2b - <basic[52c7ad9f75458f07]::session_find_objects::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c627 - <basic[52c7ad9f75458f07]::session_find_objects::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- session_objecthandle_iterator stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'session_objecthandle_iterator' (762) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a67722b9 - <basic[52c7ad9f75458f07]::session_objecthandle_iterator::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c9b7 - <basic[52c7ad9f75458f07]::session_objecthandle_iterator::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- get_session_info_test stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'get_session_info_test' (742) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a676892c - <basic[52c7ad9f75458f07]::get_session_info_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c657 - <basic[52c7ad9f75458f07]::get_session_info_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- get_info_test stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'get_info_test' (741) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a675eb76 - <basic[52c7ad9f75458f07]::get_info_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c1d7 - <basic[52c7ad9f75458f07]::get_info_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- get_slot_info_test stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'get_slot_info_test' (744) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a6762864 - <basic[52c7ad9f75458f07]::get_slot_info_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c3e7 - <basic[52c7ad9f75458f07]::get_slot_info_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sha256_digest stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sha256_digest' (764) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a675fb88 - <basic[52c7ad9f75458f07]::sha256_digest::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c237 - <basic[52c7ad9f75458f07]::sha256_digest::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- generate_random_test stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'generate_random_test' (739) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a6767669 - <basic[52c7ad9f75458f07]::generate_random_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c5c7 - <basic[52c7ad9f75458f07]::generate_random_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- session_copy_object stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'session_copy_object' (760) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a6766225 - <basic[52c7ad9f75458f07]::session_copy_object::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c537 - <basic[52c7ad9f75458f07]::session_copy_object::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sha256_digest_multipart_already_initialized stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sha256_digest_multipart_already_initialized' (766) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a67805e2 - <basic[52c7ad9f75458f07]::sha256_digest_multipart_already_initialized::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675cc87 - <basic[52c7ad9f75458f07]::sha256_digest_multipart_already_initialized::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stderr] error: test failed, to rerun pass `--test basic`
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sha256_digest_multipart stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sha256_digest_multipart' (765) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a676d337 - <basic[52c7ad9f75458f07]::sha256_digest_multipart::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c7d7 - <basic[52c7ad9f75458f07]::sha256_digest_multipart::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sign_verify_eddsa_with_ed448_schemes stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sign_verify_eddsa_with_ed448_schemes' (772) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a6779a0e - <basic[52c7ad9f75458f07]::sign_verify_eddsa_with_ed448_schemes::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675cad7 - <basic[52c7ad9f75458f07]::sign_verify_eddsa_with_ed448_schemes::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- login_feast stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'login_feast' (756) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a675dbae - <basic[52c7ad9f75458f07]::login_feast::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a67d0374 - serial_test[ca9b57f5193cb429]::serial_core
[INFO] [stdout]   15:     0x6055a675c118 - <basic[52c7ad9f75458f07]::login_feast::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sha256_digest_multipart_not_initialized stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sha256_digest_multipart_not_initialized' (767) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a677d502 - <basic[52c7ad9f75458f07]::sha256_digest_multipart_not_initialized::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675cbc7 - <basic[52c7ad9f75458f07]::sha256_digest_multipart_not_initialized::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- rsa_pkcs_oaep_empty stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'rsa_pkcs_oaep_empty' (758) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a676587b - <basic[52c7ad9f75458f07]::rsa_pkcs_oaep_empty::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c507 - <basic[52c7ad9f75458f07]::rsa_pkcs_oaep_empty::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sign_verify stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sign_verify' (769) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a675dede - <basic[52c7ad9f75458f07]::sign_verify::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c147 - <basic[52c7ad9f75458f07]::sign_verify::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- is_initialized_test stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'is_initialized_test' (748) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a6764652 - <basic[52c7ad9f75458f07]::is_initialized_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   13:     0x6055a67d0374 - serial_test[ca9b57f5193cb429]::serial_core
[INFO] [stdout]   14:     0x6055a675c4a8 - <basic[52c7ad9f75458f07]::is_initialized_test::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   15:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   16:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   17:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   18:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   19:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   20:     0x786a236eddfa - <unknown>
[INFO] [stdout]   21:     0x786a237813d4 - clone
[INFO] [stdout]   22:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sign_verify_eddsa stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sign_verify_eddsa' (770) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a6761fdb - <basic[52c7ad9f75458f07]::sign_verify_eddsa::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c3b7 - <basic[52c7ad9f75458f07]::sign_verify_eddsa::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sign_verify_sha512_hmac stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sign_verify_sha512_hmac' (780) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a676eb0c - <basic[52c7ad9f75458f07]::sign_verify_sha512_hmac::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c897 - <basic[52c7ad9f75458f07]::sign_verify_sha512_hmac::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sign_verify_sha256_hmac stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sign_verify_sha256_hmac' (778) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a676de8c - <basic[52c7ad9f75458f07]::sign_verify_sha256_hmac::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c837 - <basic[52c7ad9f75458f07]::sign_verify_sha256_hmac::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sha256_digest_multipart_with_key stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sha256_digest_multipart_with_key' (768) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a67736dc - <basic[52c7ad9f75458f07]::sha256_digest_multipart_with_key::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c9e7 - <basic[52c7ad9f75458f07]::sha256_digest_multipart_with_key::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_clone_initialize stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_clone_initialize' (781) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a676a4be - <basic[52c7ad9f75458f07]::test_clone_initialize::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   13:     0x6055a67d0374 - serial_test[ca9b57f5193cb429]::serial_core
[INFO] [stdout]   14:     0x6055a675c6e8 - <basic[52c7ad9f75458f07]::test_clone_initialize::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   15:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   16:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   17:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   18:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   19:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   20:     0x786a236eddfa - <unknown>
[INFO] [stdout]   21:     0x786a237813d4 - clone
[INFO] [stdout]   22:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- update_attributes_key stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'update_attributes_key' (783) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a676a61e - <basic[52c7ad9f75458f07]::update_attributes_key::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c717 - <basic[52c7ad9f75458f07]::update_attributes_key::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sign_verify_multipart stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sign_verify_multipart' (773) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a676942e - <basic[52c7ad9f75458f07]::sign_verify_multipart::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c687 - <basic[52c7ad9f75458f07]::sign_verify_multipart::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sign_verify_sha224_hmac stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sign_verify_sha224_hmac' (777) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a676d84c - <basic[52c7ad9f75458f07]::sign_verify_sha224_hmac::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c807 - <basic[52c7ad9f75458f07]::sign_verify_sha224_hmac::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sign_verify_multipart_not_initialized stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sign_verify_multipart_not_initialized' (775) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a677a3d4 - <basic[52c7ad9f75458f07]::sign_verify_multipart_not_initialized::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675cb07 - <basic[52c7ad9f75458f07]::sign_verify_multipart_not_initialized::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- unique_id stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'unique_id' (782) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a678100e - <basic[52c7ad9f75458f07]::unique_id::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675cd17 - <basic[52c7ad9f75458f07]::unique_id::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sign_verify_sha384_hmac stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sign_verify_sha384_hmac' (779) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a676e4cc - <basic[52c7ad9f75458f07]::sign_verify_sha384_hmac::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c867 - <basic[52c7ad9f75458f07]::sign_verify_sha384_hmac::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sign_verify_multipart_already_initialized stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sign_verify_multipart_already_initialized' (774) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a677dece - <basic[52c7ad9f75458f07]::sign_verify_multipart_already_initialized::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675cc27 - <basic[52c7ad9f75458f07]::sign_verify_multipart_already_initialized::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- wrap_and_unwrap_key stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'wrap_and_unwrap_key' (785) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a6766a9b - <basic[52c7ad9f75458f07]::wrap_and_unwrap_key::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a67d0374 - serial_test[ca9b57f5193cb429]::serial_core
[INFO] [stdout]   15:     0x6055a675c598 - <basic[52c7ad9f75458f07]::wrap_and_unwrap_key::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sign_verify_eddsa_with_ed25519_schemes stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sign_verify_eddsa_with_ed25519_schemes' (771) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a677ba91 - <basic[52c7ad9f75458f07]::sign_verify_eddsa_with_ed25519_schemes::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675cb67 - <basic[52c7ad9f75458f07]::sign_verify_eddsa_with_ed25519_schemes::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sign_verify_sha1_hmac stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sign_verify_sha1_hmac' (776) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a6769d2c - <basic[52c7ad9f75458f07]::sign_verify_sha1_hmac::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a6782268 - serial_test[ca9b57f5193cb429]::serial_core_with_return::<testresult[473f8dcf73605204]::TestError>
[INFO] [stdout]   15:     0x6055a675c6b7 - <basic[52c7ad9f75458f07]::sign_verify_sha1_hmac::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- wait_for_slot_event stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'wait_for_slot_event' (784) panicked at tests/common.rs:24:36:
[INFO] [stdout] 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" })
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6055a6819261 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x6055a682d8aa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x6055a681d6fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6055a67f5856 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x6055a68119c9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6055a679beb0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x6055a6811b82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6055a67f5902 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6055a67ee689 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6055a67f64fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x6055a682dfdc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x6055a682ddb2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6055a678ec43 - basic[52c7ad9f75458f07]::common::init_pins
[INFO] [stdout]   13:     0x6055a6766971 - <basic[52c7ad9f75458f07]::wait_for_slot_event::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x6055a67d0374 - serial_test[ca9b57f5193cb429]::serial_core
[INFO] [stdout]   15:     0x6055a675c568 - <basic[52c7ad9f75458f07]::wait_for_slot_event::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x6055a678f19b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x6055a679c805 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x6055a67960c4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x6055a679f962 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x6055a6818b39 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x786a236eddfa - <unknown>
[INFO] [stdout]   22:     0x786a237813d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     aes_cbc_encrypt
[INFO] [stdout]     aes_cbc_pad_encrypt
[INFO] [stdout]     aes_cmac_sign
[INFO] [stdout]     aes_cmac_verify
[INFO] [stdout]     aes_gcm_with_aad
[INFO] [stdout]     aes_key_attributes_test
[INFO] [stdout]     derive_key
[INFO] [stdout]     ekdf_aes_cbc_encrypt_data
[INFO] [stdout]     encrypt_decrypt
[INFO] [stdout]     encrypt_decrypt_gcm_message_no_aad
[INFO] [stdout]     encrypt_decrypt_gcm_message_with_aad
[INFO] [stdout]     encrypt_decrypt_multipart
[INFO] [stdout]     encrypt_decrypt_multipart_already_initialized
[INFO] [stdout]     encrypt_decrypt_multipart_not_initialized
[INFO] [stdout]     generate_generic_secret_key
[INFO] [stdout]     generate_random_test
[INFO] [stdout]     get_attribute_info_test
[INFO] [stdout]     get_info_test
[INFO] [stdout]     get_session_info_test
[INFO] [stdout]     get_slot_event
[INFO] [stdout]     get_slot_info_test
[INFO] [stdout]     get_token_info
[INFO] [stdout]     import_export
[INFO] [stdout]     is_fn_supported_test
[INFO] [stdout]     is_initialized_test
[INFO] [stdout]     login_feast
[INFO] [stdout]     ro_rw_session_test
[INFO] [stdout]     rsa_pkcs_oaep_empty
[INFO] [stdout]     session_copy_object
[INFO] [stdout]     session_find_objects
[INFO] [stdout]     session_objecthandle_iterator
[INFO] [stdout]     set_pin_test
[INFO] [stdout]     sha256_digest
[INFO] [stdout]     sha256_digest_multipart
[INFO] [stdout]     sha256_digest_multipart_already_initialized
[INFO] [stdout]     sha256_digest_multipart_not_initialized
[INFO] [stdout]     sha256_digest_multipart_with_key
[INFO] [stdout]     sign_verify
[INFO] [stdout]     sign_verify_eddsa
[INFO] [stdout]     sign_verify_eddsa_with_ed25519_schemes
[INFO] [stdout]     sign_verify_eddsa_with_ed448_schemes
[INFO] [stdout]     sign_verify_multipart
[INFO] [stdout]     sign_verify_multipart_already_initialized
[INFO] [stdout]     sign_verify_multipart_not_initialized
[INFO] [stdout]     sign_verify_sha1_hmac
[INFO] [stdout]     sign_verify_sha224_hmac
[INFO] [stdout]     sign_verify_sha256_hmac
[INFO] [stdout]     sign_verify_sha384_hmac
[INFO] [stdout]     sign_verify_sha512_hmac
[INFO] [stdout]     test_clone_initialize
[INFO] [stdout]     unique_id
[INFO] [stdout]     update_attributes_key
[INFO] [stdout]     wait_for_slot_event
[INFO] [stdout]     wrap_and_unwrap_key
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 10 passed; 54 failed; 2 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "2c1be6eeaaf256f71ea38f58486018a6d7fe2634c704f63e82022db098b2523f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2c1be6eeaaf256f71ea38f58486018a6d7fe2634c704f63e82022db098b2523f", kill_on_drop: false }`
[INFO] [stdout] 2c1be6eeaaf256f71ea38f58486018a6d7fe2634c704f63e82022db098b2523f
