[INFO] fetching crate wokhei 0.3.1...
[INFO] testing wokhei-0.3.1 against master#ec6f9a5b4413f74386267ef8efc93712c2ce6db6 for pr-155739-1
[INFO] extracting crate wokhei 0.3.1 into /workspace/builds/worker-4-tc1/source
[INFO] removed /workspace/builds/worker-4-tc1/source/rust-toolchain.toml
[INFO] started tweaking crates.io crate wokhei 0.3.1
[INFO] finished tweaking crates.io crate wokhei 0.3.1
[INFO] tweaked toml for crates.io crate wokhei 0.3.1 written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate wokhei 0.3.1 on toolchain ec6f9a5b4413f74386267ef8efc93712c2ce6db6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate wokhei 0.3.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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded nostr-relay-pool v0.44.0
[INFO] [stderr]   Downloaded wasm-bindgen-shared v0.2.113
[INFO] [stderr]   Downloaded wasm-bindgen-macro v0.2.113
[INFO] [stderr]   Downloaded tikv-jemallocator v0.6.1
[INFO] [stderr]   Downloaded async-utility v0.3.1
[INFO] [stderr]   Downloaded negentropy v0.5.0
[INFO] [stderr]   Downloaded atomic-destructor v0.3.0
[INFO] [stderr]   Downloaded nostr-gossip v0.44.0
[INFO] [stderr]   Downloaded chacha20 v0.9.1
[INFO] [stderr]   Downloaded tokio-tungstenite v0.26.2
[INFO] [stderr]   Downloaded nostr-database v0.44.0
[INFO] [stderr]   Downloaded wasm-bindgen-futures v0.4.63
[INFO] [stderr]   Downloaded poly1305 v0.8.0
[INFO] [stderr]   Downloaded agcli v0.6.0
[INFO] [stderr]   Downloaded tokio-socks v0.5.2
[INFO] [stderr]   Downloaded wasm-bindgen v0.2.113
[INFO] [stderr]   Downloaded portable-atomic-util v0.2.5
[INFO] [stderr]   Downloaded jiff-tzdb v0.1.5
[INFO] [stderr]   Downloaded secp256k1 v0.29.1
[INFO] [stderr]   Downloaded wasm-bindgen-macro-support v0.2.113
[INFO] [stderr]   Downloaded async-wsocket v0.13.1
[INFO] [stderr]   Downloaded nostr-sdk v0.44.1
[INFO] [stderr]   Downloaded bech32 v0.11.1
[INFO] [stderr]   Downloaded tungstenite v0.26.2
[INFO] [stderr]   Downloaded chacha20poly1305 v0.10.1
[INFO] [stderr]   Downloaded jiff-static v0.2.21
[INFO] [stderr]   Downloaded js-sys v0.3.90
[INFO] [stderr]   Downloaded nostr v0.44.2
[INFO] [stderr]   Downloaded web-sys v0.3.90
[INFO] [stderr]   Downloaded jiff v0.2.21
[INFO] [stderr]   Downloaded tikv-jemalloc-sys v0.6.1+5.3.0-1-ge13ca993e8ccb9ba9847cc330696e02839f328f7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 4c4e2b15494c7940dbfc96be69058a641255be07fa23a2dbe08024c299b267a7
[INFO] running `Command { std: "docker" "start" "-a" "4c4e2b15494c7940dbfc96be69058a641255be07fa23a2dbe08024c299b267a7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "4c4e2b15494c7940dbfc96be69058a641255be07fa23a2dbe08024c299b267a7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4c4e2b15494c7940dbfc96be69058a641255be07fa23a2dbe08024c299b267a7", kill_on_drop: false }`
[INFO] [stdout] 4c4e2b15494c7940dbfc96be69058a641255be07fa23a2dbe08024c299b267a7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9bace9c5bd15216b9c721ceed9dd463fcab18a7f8cba821c66569265b08e95a5
[INFO] running `Command { std: "docker" "start" "-a" "9bace9c5bd15216b9c721ceed9dd463fcab18a7f8cba821c66569265b08e95a5", kill_on_drop: false }`
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling libc v0.2.182
[INFO] [stderr]    Compiling zerocopy v0.8.39
[INFO] [stderr]    Compiling cc v1.2.56
[INFO] [stderr]    Compiling percent-encoding v2.3.2
[INFO] [stderr]    Compiling rustls v0.23.37
[INFO] [stderr]    Compiling bitcoin-io v0.1.4
[INFO] [stderr]    Compiling futures-core v0.3.32
[INFO] [stderr]    Compiling hex-conservative v0.2.2
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling http v1.4.0
[INFO] [stderr]    Compiling hex v0.4.3
[INFO] [stderr]    Compiling bech32 v0.11.1
[INFO] [stderr]    Compiling utf-8 v0.7.6
[INFO] [stderr]    Compiling lru v0.16.3
[INFO] [stderr]    Compiling atomic-destructor v0.3.0
[INFO] [stderr]    Compiling form_urlencoded v1.2.2
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling negentropy v0.5.0
[INFO] [stderr]    Compiling jiff v0.2.21
[INFO] [stderr]    Compiling sha1 v0.10.6
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling secp256k1-sys v0.10.1
[INFO] [stderr]    Compiling tikv-jemalloc-sys v0.6.1+5.3.0-1-ge13ca993e8ccb9ba9847cc330696e02839f328f7
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling socket2 v0.6.2
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling dirs-sys v0.5.0
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling dirs v6.0.0
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling rustls-webpki v0.103.9
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling zerofrom-derive v0.1.6
[INFO] [stderr]    Compiling yoke-derive v0.8.1
[INFO] [stderr]    Compiling zerovec-derive v0.11.2
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling zerofrom v0.1.6
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling yoke v0.8.1
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling zerovec v0.11.5
[INFO] [stderr]    Compiling zerotrie v0.2.3
[INFO] [stderr]    Compiling tinystr v0.8.2
[INFO] [stderr]    Compiling potential_utf v0.1.4
[INFO] [stderr]    Compiling icu_collections v2.1.1
[INFO] [stderr]    Compiling icu_locale_core v2.1.1
[INFO] [stderr]    Compiling icu_provider v2.1.1
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling icu_normalizer v2.1.1
[INFO] [stderr]    Compiling icu_properties v2.1.2
[INFO] [stderr]    Compiling secp256k1 v0.29.1
[INFO] [stderr]    Compiling bitcoin_hashes v0.14.1
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling tungstenite v0.26.2
[INFO] [stderr]    Compiling url v2.5.8
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling tokio-socks v0.5.2
[INFO] [stderr]    Compiling async-utility v0.3.1
[INFO] [stderr]    Compiling tokio-tungstenite v0.26.2
[INFO] [stderr]    Compiling nostr v0.44.2
[INFO] [stderr]    Compiling async-wsocket v0.13.1
[INFO] [stderr]    Compiling nostr-database v0.44.0
[INFO] [stderr]    Compiling nostr-gossip v0.44.0
[INFO] [stderr]    Compiling nostr-relay-pool v0.44.0
[INFO] [stderr]    Compiling nostr-sdk v0.44.1
[INFO] [stderr]    Compiling tikv-jemallocator v0.6.1
[INFO] [stderr]    Compiling agcli v0.6.0
[INFO] [stderr]    Compiling wokhei v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2m 07s
[INFO] running `Command { std: "docker" "inspect" "9bace9c5bd15216b9c721ceed9dd463fcab18a7f8cba821c66569265b08e95a5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9bace9c5bd15216b9c721ceed9dd463fcab18a7f8cba821c66569265b08e95a5", kill_on_drop: false }`
[INFO] [stdout] 9bace9c5bd15216b9c721ceed9dd463fcab18a7f8cba821c66569265b08e95a5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 028306082dc3b73e937032c3a1620b107afbc9f095bd34902cb5db1b9404cc48
[INFO] running `Command { std: "docker" "start" "-a" "028306082dc3b73e937032c3a1620b107afbc9f095bd34902cb5db1b9404cc48", kill_on_drop: false }`
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling tempfile v3.26.0
[INFO] [stderr]    Compiling wokhei v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 6.50s
[INFO] running `Command { std: "docker" "inspect" "028306082dc3b73e937032c3a1620b107afbc9f095bd34902cb5db1b9404cc48", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "028306082dc3b73e937032c3a1620b107afbc9f095bd34902cb5db1b9404cc48", kill_on_drop: false }`
[INFO] [stdout] 028306082dc3b73e937032c3a1620b107afbc9f095bd34902cb5db1b9404cc48
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 407a929be54c774dd422e0f25ef856fe4282d118f4a5dcf590344547ee1796a6
[INFO] running `Command { std: "docker" "start" "-a" "407a929be54c774dd422e0f25ef856fe4282d118f4a5dcf590344547ee1796a6", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.32s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/wokhei-14fb2403a6f88ef3)
[INFO] [stdout] 
[INFO] [stdout] running 134 tests
[INFO] [stdout] test dtag::tests::header_dtag_deterministic ... ok
[INFO] [stdout] test dtag::tests::header_dtag_different_pubkeys_differ ... ok
[INFO] [stdout] test dtag::tests::header_dtag_different_names_differ ... ok
[INFO] [stdout] test dtag::tests::header_dtag_empty_name_uses_fallback ... ok
[INFO] [stdout] test dtag::tests::header_dtag_format ... ok
[INFO] [stdout] test dtag::tests::item_dtag_different_parents_differ ... ok
[INFO] [stdout] test dtag::tests::item_dtag_different_anchors_differ ... ok
[INFO] [stdout] test dtag::tests::item_dtag_deterministic ... ok
[INFO] [stdout] test dtag::tests::normalize_collapses_whitespace_runs ... ok
[INFO] [stdout] test dtag::tests::normalize_strips_unicode ... ok
[INFO] [stdout] test dtag::tests::normalize_numeric_only ... ok
[INFO] [stdout] test dtag::tests::normalize_empty_input_returns_fallback ... ok
[INFO] [stdout] test dtag::tests::normalize_all_special_chars_returns_fallback ... ok
[INFO] [stdout] test dtag::tests::normalize_leading_trailing_hyphens_trimmed ... ok
[INFO] [stdout] test dtag::tests::normalize_only_whitespace_returns_fallback ... ok
[INFO] [stdout] test dtag::tests::item_dtag_format ... ok
[INFO] [stdout] test dtag::tests::normalize_repeated_hyphens_collapsed ... ok
[INFO] [stdout] test dtag::tests::normalize_simple_lowercase ... ok
[INFO] [stdout] test dtag::tests::normalize_preserves_digits ... ok
[INFO] [stdout] test dtag::tests::normalize_trims_whitespace ... ok
[INFO] [stdout] test dtag::tests::item_dtag_empty_anchor_uses_fallback ... ok
[INFO] [stdout] test dtag::tests::normalize_strips_special_chars ... ok
[INFO] [stdout] test dtag::tests::suffix_different_inputs_differ ... ok
[INFO] [stdout] test dtag::tests::suffix_length_is_8 ... ok
[INFO] [stdout] test dtag::tests::suffix_is_hex ... ok
[INFO] [stdout] test error::tests::code_keys_already_exist ... ok
[INFO] [stdout] test error::tests::code_keys_save_failed ... ok
[INFO] [stdout] test error::tests::code_relay_unreachable ... ok
[INFO] [stdout] test error::tests::code_relay_rejected ... ok
[INFO] [stdout] test error::tests::command_error_from_app_error_preserves_code ... ok
[INFO] [stdout] test error::tests::fix_keys_already_exist_contains_path ... ok
[INFO] [stdout] test dtag::tests::suffix_deterministic ... ok
[INFO] [stdout] test error::tests::code_header_missing_d_tag ... ok
[INFO] [stdout] test error::tests::fix_relay_unreachable_contains_url ... ok
[INFO] [stdout] test error::tests::code_header_not_found ... ok
[INFO] [stdout] test error::tests::code_invalid_json ... ok
[INFO] [stdout] test error::tests::code_invalid_nsec ... ok
[INFO] [stdout] test error::tests::command_error_from_app_error_preserves_retryable ... ok
[INFO] [stdout] test error::tests::code_io_error ... ok
[INFO] [stdout] test error::tests::fix_strings_are_all_non_empty ... ok
[INFO] [stdout] test error::tests::non_relay_errors_are_not_retryable ... ok
[INFO] [stdout] test header::tests::custom_alt_text_overrides_default ... ok
[INFO] [stdout] test error::tests::relay_unreachable_is_retryable ... ok
[INFO] [stdout] test header::tests::d_tag_adds_identifier ... ok
[INFO] [stdout] test header::tests::description_absent_when_none ... ok
[INFO] [stdout] test error::tests::fix_keys_not_found_suggests_init ... ok
[INFO] [stdout] test header::tests::description_present_when_set ... ok
[INFO] [stdout] test header::tests::hashtags_generated_from_tags_list ... ok
[INFO] [stdout] test header::tests::minimal_params_has_client_tag ... ok
[INFO] [stdout] test header::tests::minimal_params_has_alt_tag_with_default ... ok
[INFO] [stdout] test error::tests::code_no_results ... ok
[INFO] [stdout] test error::tests::code_invalid_coordinate ... ok
[INFO] [stdout] test error::tests::code_invalid_event_id ... ok
[INFO] [stdout] test error::tests::command_error_from_app_error_preserves_message ... ok
[INFO] [stdout] test header::tests::minimal_params_has_names_tag_with_singular_and_plural ... ok
[INFO] [stdout] test header::tests::no_d_tag_when_none ... ok
[INFO] [stdout] test header::tests::titles_tag_absent_when_not_set ... ok
[INFO] [stdout] test item::tests::build_item_tags_d_tag_absent ... ok
[INFO] [stdout] test item::tests::build_item_tags_does_not_emit_legacy_parent_tags ... ok
[INFO] [stdout] test item::tests::build_item_tags_d_tag_present ... ok
[INFO] [stdout] test header::tests::titles_tag_present_when_set ... ok
[INFO] [stdout] test header::tests::recommended_fields_emitted_as_separate_tags ... ok
[INFO] [stdout] test header::tests::required_fields_present ... ok
[INFO] [stdout] test item::tests::build_item_tags_fields_without_equals_skipped ... ok
[INFO] [stdout] test item::tests::build_item_tags_accepts_coordinate_parent_ref ... ok
[INFO] [stdout] test item::tests::build_item_tags_has_client ... ok
[INFO] [stdout] test item::tests::build_item_tags_has_resource ... ok
[INFO] [stdout] test item::tests::build_item_tags_fields_with_equals_become_tags ... ok
[INFO] [stdout] test item::tests::parse_coordinate_invalid_kind ... ok
[INFO] [stdout] test item::tests::parse_coordinate_d_tag_with_colons_preserved ... ok
[INFO] [stdout] test item::tests::parse_coordinate_empty_d_tag ... ok
[INFO] [stdout] test item::tests::parse_coordinate_invalid_pubkey ... ok
[INFO] [stdout] test item::tests::build_item_tags_has_parent_z_ref ... ok
[INFO] [stdout] test item::tests::parse_coordinate_single_part ... ok
[INFO] [stdout] test item::tests::parse_coordinate_too_few_parts ... ok
[INFO] [stdout] test item::tests::validate_header_only_ok ... ok
[INFO] [stdout] test item::tests::validate_neither_header_nor_coordinate_errors ... ok
[INFO] [stdout] test item::tests::validate_non_addressable_without_d_tag_ok ... ok
[INFO] [stdout] test item::tests::validate_addressable_with_d_tag_ok ... ok
[INFO] [stdout] test item::tests::parse_coordinate_valid ... ok
[INFO] [stdout] test item::tests::validate_addressable_without_d_tag_ok ... ok
[INFO] [stdout] test keys::tests::init_neither_flag_errors ... ok
[INFO] [stdout] test keys::tests::keys_result_contains_pubkey ... ok
[INFO] [stdout] test keys::tests::keys_path_from_appends_keys ... ok
[INFO] [stdout] test keys::tests::post_init_actions_contains_pubkey ... ok
[INFO] [stdout] test keys::tests::post_init_actions_non_empty ... ok
[INFO] [stdout] test keys::tests::read_nsec_from_stdin_cursor ... ok
[INFO] [stdout] test keys::tests::keys_result_npub_starts_with_npub1 ... ok
[INFO] [stdout] test item::tests::validate_coordinate_only_ok ... ok
[INFO] [stdout] test keys::tests::read_nsec_nonexistent_file_errors ... ok
[INFO] [stdout] test keys::tests::post_init_actions_contains_whoami ... ok
[INFO] [stdout] test keys::tests::keys_result_has_keys_path ... ok
[INFO] [stdout] test keys::tests::read_nsec_from_file ... ok
[INFO] [stdout] test keys::tests::read_nsec_trims_whitespace ... ok
[INFO] [stdout] test keys::tests::init_generate_does_not_return_missing_arg ... ok
[INFO] [stdout] test keys::tests::save_sets_permissions_0600 ... ok
[INFO] [stdout] test keys::tests::load_from_nonexistent_path_errors ... ok
[INFO] [stdout] test error::tests::code_keys_not_found ... ok
[INFO] [stdout] test keys::tests::keys_dir_from_appends_wokhei ... ok
[INFO] [stdout] test keys::tests::save_creates_directory_and_file ... ok
[INFO] [stdout] test keys::tests::save_and_load_roundtrip ... ok
[INFO] [stdout] test query::tests::event_to_json_description_extracted ... ok
[INFO] [stdout] test query::tests::paginate_returns_empty_when_offset_out_of_range ... ok
[INFO] [stdout] test query::tests::paginate_returns_empty_when_limit_zero ... ok
[INFO] [stdout] test query::tests::paginate_returns_expected_window ... ok
[INFO] [stdout] test query::tests::sort_event_json_orders_by_created_at_desc_then_id ... ok
[INFO] [stdout] test query::tests::event_to_json_tags_array_structure ... ok
[INFO] [stdout] test query::tests::event_to_json_names_tag_extracts_singular_and_plural ... ok
[INFO] [stdout] test tests::bool_flag_bare_is_true ... ok
[INFO] [stdout] test query::tests::event_to_json_single_name_sets_only_singular_name ... ok
[INFO] [stdout] test query::tests::event_to_json_basic_fields ... ok
[INFO] [stdout] test tests::bool_flag_invalid_value_errors ... ok
[INFO] [stdout] test query::tests::event_to_json_titles_tag_extracted ... ok
[INFO] [stdout] test tests::bool_flag_absent_is_false ... ok
[INFO] [stdout] test query::tests::event_to_json_content_preserved ... ok
[INFO] [stdout] test tests::import_equals_form_is_preserved ... ok
[INFO] [stdout] test tests::import_space_form_uses_positional_source ... ok
[INFO] [stdout] test query::tests::event_to_json_d_tag_creates_coordinate ... ok
[INFO] [stdout] test tests::parse_csv_multiple_values ... ok
[INFO] [stdout] test tests::parse_csv_empty_string_returns_empty ... ok
[INFO] [stdout] test tests::bool_flag_equals_true_works ... ok
[INFO] [stdout] test tests::parse_csv_none_returns_empty ... ok
[INFO] [stdout] test tests::import_missing_source_errors ... ok
[INFO] [stdout] test query::tests::event_to_json_unknown_tags_dont_pollute_top_level ... ok
[INFO] [stdout] test tests::resolve_relay_flag_beats_env ... ok
[INFO] [stdout] test tests::usize_flag_valid_number ... ok
[INFO] [stdout] test tests::parse_csv_single_value ... ok
[INFO] [stdout] test tests::parse_csv_trims_whitespace ... ok
[INFO] [stdout] test tests::resolve_relay_flag_override ... ok
[INFO] [stdout] test tests::resolve_relay_default_fallback ... ok
[INFO] [stdout] test tests::usize_flag_absent_returns_default ... ok
[INFO] [stdout] test tests::usize_flag_invalid_errors ... ok
[INFO] [stdout] test tests::usize_flag_zero_works ... ok
[INFO] [stdout] test tests::resolve_relay_env_var ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::resolve_relay_env_var stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::resolve_relay_env_var' (145) panicked at src/main.rs:580:9:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: "ws://localhost:7777"
[INFO] [stdout]  right: "ws://envrelay:5555"
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x62eae94e16da - std[29689e6404d28ef9]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x62eae94e16da - std[29689e6404d28ef9]::backtrace_rs::backtrace::trace_unsynchronized::<std[29689e6404d28ef9]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x62eae94e16da - std[29689e6404d28ef9]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x62eae94e16da - <<std[29689e6404d28ef9]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[e929cb53b82a81ca]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x62eae94f814a - <core[e929cb53b82a81ca]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x62eae94f814a - core[e929cb53b82a81ca]::fmt::write
[INFO] [stdout]    6:     0x62eae94e6452 - std[29689e6404d28ef9]::io::default_write_fmt::<alloc[9d7caffeb3b5d2c6]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x62eae94e6452 - <alloc[9d7caffeb3b5d2c6]::vec::Vec<u8> as std[29689e6404d28ef9]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x62eae94be7cf - <std[29689e6404d28ef9]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x62eae94be7cf - std[29689e6404d28ef9]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x62eae94d8d09 - std[29689e6404d28ef9]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x62eae903fe0c - <alloc[9d7caffeb3b5d2c6]::boxed::Box<dyn for<'a, 'b> core[e929cb53b82a81ca]::ops::function::Fn<(&'a std[29689e6404d28ef9]::panic::PanicHookInfo<'b>,), Output = ()> + core[e929cb53b82a81ca]::marker::Send + core[e929cb53b82a81ca]::marker::Sync> as core[e929cb53b82a81ca]::ops::function::Fn<(&std[29689e6404d28ef9]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x62eae903fe0c - test[a24b3028667022f7]::test_main_inner::<test[a24b3028667022f7]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x62eae94d8ec2 - <alloc[9d7caffeb3b5d2c6]::boxed::Box<dyn for<'a, 'b> core[e929cb53b82a81ca]::ops::function::Fn<(&'a std[29689e6404d28ef9]::panic::PanicHookInfo<'b>,), Output = ()> + core[e929cb53b82a81ca]::marker::Send + core[e929cb53b82a81ca]::marker::Sync> as core[e929cb53b82a81ca]::ops::function::Fn<(&std[29689e6404d28ef9]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x62eae94d8ec2 - std[29689e6404d28ef9]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x62eae94be888 - std[29689e6404d28ef9]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x62eae94b3599 - std[29689e6404d28ef9]::sys::backtrace::__rust_end_short_backtrace::<std[29689e6404d28ef9]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x62eae94bf74d - __rustc[3aed6af316653e63]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x62eae94f88dc - core[e929cb53b82a81ca]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x62eae94f8793 - core[e929cb53b82a81ca]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panicking.rs:439:17
[INFO] [stdout]   20:     0x62eae8ff1044 - core[e929cb53b82a81ca]::panicking::assert_failed::<alloc[9d7caffeb3b5d2c6]::string::String, &str>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x62eae9004cd1 - wokhei[4f3dbd97c91e878a]::tests::resolve_relay_env_var
[INFO] [stdout]                                at /opt/rustwide/workdir/src/main.rs:580:9
[INFO] [stdout]   22:     0x62eae9003667 - wokhei[4f3dbd97c91e878a]::tests::resolve_relay_env_var::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/main.rs:577:31
[INFO] [stdout]   23:     0x62eae8fe19b6 - <wokhei[4f3dbd97c91e878a]::tests::resolve_relay_env_var::{closure#0} as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x62eae90330eb - <fn() -> core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x62eae90330eb - test[a24b3028667022f7]::__rust_begin_short_backtrace::<core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>, fn() -> core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:724:18
[INFO] [stdout]   26:     0x62eae90408db - test[a24b3028667022f7]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:747:74
[INFO] [stdout]   27:     0x62eae90408db - <core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x62eae90408db - std[29689e6404d28ef9]::panicking::catch_unwind::do_call::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}>, core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x62eae90408db - std[29689e6404d28ef9]::panicking::catch_unwind::<core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>, core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x62eae90408db - std[29689e6404d28ef9]::panic::catch_unwind::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}>, core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x62eae90408db - test[a24b3028667022f7]::run_test_in_process
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:747:27
[INFO] [stdout]   32:     0x62eae90408db - test[a24b3028667022f7]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:668:43
[INFO] [stdout]   33:     0x62eae9039ff4 - test[a24b3028667022f7]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:698:41
[INFO] [stdout]   34:     0x62eae9039ff4 - std[29689e6404d28ef9]::sys::backtrace::__rust_begin_short_backtrace::<test[a24b3028667022f7]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x62eae90434e2 - std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked::<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x62eae90434e2 - <core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x62eae90434e2 - std[29689e6404d28ef9]::panicking::catch_unwind::do_call::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x62eae90434e2 - std[29689e6404d28ef9]::panicking::catch_unwind::<(), core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x62eae90434e2 - std[29689e6404d28ef9]::panic::catch_unwind::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x62eae90434e2 - std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked::<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x62eae90434e2 - <std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1} as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x62eae94e0acf - <alloc[9d7caffeb3b5d2c6]::boxed::Box<dyn core[e929cb53b82a81ca]::ops::function::FnOnce<(), Output = ()> + core[e929cb53b82a81ca]::marker::Send> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   43:     0x62eae94e0acf - <std[29689e6404d28ef9]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x756dd96dfaa4 - <unknown>
[INFO] [stdout]   45:     0x756dd976ca64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::resolve_relay_env_var
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 133 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.32s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--bin wokhei`
[INFO] running `Command { std: "docker" "inspect" "407a929be54c774dd422e0f25ef856fe4282d118f4a5dcf590344547ee1796a6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "407a929be54c774dd422e0f25ef856fe4282d118f4a5dcf590344547ee1796a6", kill_on_drop: false }`
[INFO] [stdout] 407a929be54c774dd422e0f25ef856fe4282d118f4a5dcf590344547ee1796a6
