[INFO] cloning repository https://github.com/ncsa/rusty-neat
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/ncsa/rusty-neat" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fncsa%2Frusty-neat", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fncsa%2Frusty-neat'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 3139c97368743a80b47bfd9dd22645eaf737b712
[INFO] testing ncsa/rusty-neat against 1.98.0-beta.1 for beta-1.98-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fncsa%2Frusty-neat" "/workspace/builds/worker-6-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-6-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/ncsa/rusty-neat
[INFO] finished tweaking git repo https://github.com/ncsa/rusty-neat
[INFO] tweaked toml for git repo https://github.com/ncsa/rusty-neat written to /workspace/builds/worker-6-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/ncsa/rusty-neat on toolchain 1.98.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.98.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/ncsa/rusty-neat 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.98.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/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:3d5ced03c013a94a2f102a4510f48a6e9184255caf5fd8244f58017bde7f5210" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 76cd9e169e63b56297a1e8f9fffbf2615390a42ca8f20135491d3b879976aaa8
[INFO] running `Command { std: "docker" "start" "76cd9e169e63b56297a1e8f9fffbf2615390a42ca8f20135491d3b879976aaa8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "76cd9e169e63b56297a1e8f9fffbf2615390a42ca8f20135491d3b879976aaa8", 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" "76cd9e169e63b56297a1e8f9fffbf2615390a42ca8f20135491d3b879976aaa8" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "76cd9e169e63b56297a1e8f9fffbf2615390a42ca8f20135491d3b879976aaa8", 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" "76cd9e169e63b56297a1e8f9fffbf2615390a42ca8f20135491d3b879976aaa8" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.175
[INFO] [stderr]    Compiling cfg-if v1.0.3
[INFO] [stderr]    Compiling find-msvc-tools v0.1.9
[INFO] [stderr]    Compiling shlex v2.0.1
[INFO] [stderr]    Compiling proc-macro2 v1.0.101
[INFO] [stderr]    Compiling unicode-ident v1.0.19
[INFO] [stderr]    Compiling zerocopy v0.8.27
[INFO] [stderr]    Compiling lexical-util v1.0.7
[INFO] [stderr]    Compiling crc32fast v1.5.0
[INFO] [stderr]    Compiling zlib-rs v0.5.5
[INFO] [stderr]    Compiling hashbrown v0.16.0
[INFO] [stderr]    Compiling serde_core v1.0.225
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling regex-automata v0.4.10
[INFO] [stderr]    Compiling crossbeam-channel v0.5.15
[INFO] [stderr]    Compiling paste v1.0.15
[INFO] [stderr]    Compiling bitflags v2.11.1
[INFO] [stderr]    Compiling bytemuck v1.23.2
[INFO] [stderr]    Compiling bytes v1.11.1
[INFO] [stderr]    Compiling cc v1.2.64
[INFO] [stderr]    Compiling safe_arch v0.7.4
[INFO] [stderr]    Compiling matrixmultiply v0.3.10
[INFO] [stderr]    Compiling bit-vec v0.9.1
[INFO] [stderr]    Compiling serde v1.0.225
[INFO] [stderr]    Compiling anyhow v1.0.99
[INFO] [stderr]    Compiling lexical-write-integer v1.0.6
[INFO] [stderr]    Compiling lexical-parse-integer v1.0.6
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling indexmap v2.11.4
[INFO] [stderr]    Compiling lexical-parse-float v1.0.6
[INFO] [stderr]    Compiling getrandom v0.3.3
[INFO] [stderr]    Compiling lexical-write-float v1.0.6
[INFO] [stderr]    Compiling wide v0.7.33
[INFO] [stderr]    Compiling rawpointer v0.2.1
[INFO] [stderr]    Compiling rustix v1.1.2
[INFO] [stderr]    Compiling quote v1.0.40
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling approx v0.5.1
[INFO] [stderr]    Compiling num-complex v0.4.6
[INFO] [stderr]    Compiling getrandom v0.2.16
[INFO] [stderr]    Compiling lexical-core v1.0.6
[INFO] [stderr]    Compiling serde_yml v0.0.12
[INFO] [stderr]    Compiling bstr v1.12.0
[INFO] [stderr]    Compiling syn v2.0.106
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling anstyle-query v1.1.4
[INFO] [stderr]    Compiling powerfmt v0.2.0
[INFO] [stderr]    Compiling cmake v0.1.58
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling num-rational v0.4.2
[INFO] [stderr]    Compiling anstyle v1.0.11
[INFO] [stderr]    Compiling linux-raw-sys v0.11.0
[INFO] [stderr]    Compiling thiserror v2.0.16
[INFO] [stderr]    Compiling virtue v0.0.18
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]    Compiling colorchoice v1.0.4
[INFO] [stderr]    Compiling rayon-core v1.13.0
[INFO] [stderr]    Compiling num-conv v0.1.0
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.1
[INFO] [stderr]    Compiling time-core v0.1.6
[INFO] [stderr]    Compiling anstream v0.6.20
[INFO] [stderr]    Compiling libyml v0.0.5
[INFO] [stderr]    Compiling deranged v0.5.3
[INFO] [stderr]    Compiling time-macros v0.2.24
[INFO] [stderr]    Compiling iana-time-zone v0.1.64
[INFO] [stderr]    Compiling noodles-core v0.19.0
[INFO] [stderr]    Compiling clap_lex v0.7.5
[INFO] [stderr]    Compiling unty v0.0.4
[INFO] [stderr]    Compiling libz-ng-sys v1.1.22
[INFO] [stderr]    Compiling libdeflate-sys v1.25.2
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling num_threads v0.1.7
[INFO] [stderr]    Compiling log v0.4.28
[INFO] [stderr]    Compiling bincode_derive v2.0.1
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling clap_builder v4.5.47
[INFO] [stderr]    Compiling chrono v0.4.42
[INFO] [stderr]    Compiling termcolor v1.4.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling simba v0.9.1
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling rayon v1.12.0
[INFO] [stderr]    Compiling bincode v2.0.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling time v0.3.44
[INFO] [stderr]    Compiling tempfile v3.22.0
[INFO] [stderr]    Compiling rand_distr v0.4.3
[INFO] [stderr]    Compiling libz-rs-sys v0.5.5
[INFO] [stderr]    Compiling serde_derive v1.0.225
[INFO] [stderr]    Compiling thiserror-impl v2.0.16
[INFO] [stderr]    Compiling clap_derive v4.5.47
[INFO] [stderr]    Compiling simplelog v0.12.2
[INFO] [stderr]    Compiling libdeflater v1.25.2
[INFO] [stderr]    Compiling clap v4.5.47
[INFO] [stderr]    Compiling nalgebra v0.33.2
[INFO] [stderr]    Compiling vectorize v0.2.0
[INFO] [stderr]    Compiling flate2 v1.1.2
[INFO] [stderr]    Compiling noodles-bgzf v0.46.0
[INFO] [stderr]    Compiling noodles-csi v0.55.0
[INFO] [stderr]    Compiling noodles-sam v0.84.0
[INFO] [stderr]    Compiling noodles-bam v0.88.0
[INFO] [stderr]    Compiling noodles v0.109.0
[INFO] [stderr]    Compiling statrs v0.18.0
[INFO] [stderr]    Compiling common v1.20.0 (/opt/rustwide/workdir/common)
[INFO] [stderr]    Compiling rneat v1.20.0 (/opt/rustwide/workdir/rneat)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 12s
[INFO] running `Command { std: "docker" "inspect" "76cd9e169e63b56297a1e8f9fffbf2615390a42ca8f20135491d3b879976aaa8", 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" "76cd9e169e63b56297a1e8f9fffbf2615390a42ca8f20135491d3b879976aaa8" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling getrandom v0.3.3
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling predicates-core v1.0.10
[INFO] [stderr]    Compiling float-cmp v0.10.0
[INFO] [stderr]    Compiling termtree v0.5.1
[INFO] [stderr]    Compiling assert_cmd v2.2.2
[INFO] [stderr]    Compiling normalize-line-endings v0.3.0
[INFO] [stderr]    Compiling difflib v0.4.0
[INFO] [stderr]    Compiling quick-error v1.2.3
[INFO] [stderr]    Compiling bit-vec v0.8.0
[INFO] [stderr]    Compiling unarray v0.1.4
[INFO] [stderr]    Compiling tempfile v3.22.0
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling predicates-tree v1.0.13
[INFO] [stderr]    Compiling bit-set v0.8.0
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling rand v0.9.4
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling regex-automata v0.4.10
[INFO] [stderr]    Compiling proptest v1.11.0
[INFO] [stderr]    Compiling bstr v1.12.0
[INFO] [stderr]    Compiling regex v1.11.2
[INFO] [stderr]    Compiling predicates v3.1.4
[INFO] [stderr]    Compiling noodles-core v0.19.0
[INFO] [stderr]    Compiling noodles-csi v0.55.0
[INFO] [stderr]    Compiling noodles-sam v0.84.0
[INFO] [stderr]    Compiling noodles-bam v0.88.0
[INFO] [stderr]    Compiling noodles v0.109.0
[INFO] [stderr]    Compiling common v1.20.0 (/opt/rustwide/workdir/common)
[INFO] [stderr]    Compiling rneat v1.20.0 (/opt/rustwide/workdir/rneat)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 45.83s
[INFO] running `Command { std: "docker" "inspect" "76cd9e169e63b56297a1e8f9fffbf2615390a42ca8f20135491d3b879976aaa8", 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" "76cd9e169e63b56297a1e8f9fffbf2615390a42ca8f20135491d3b879976aaa8" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.32s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/common-55aab6176c657570)
[INFO] [stdout] 
[INFO] [stdout] running 349 tests
[INFO] [stdout] test file_tools::bam_reader::tests::test_coverage_observer_clips_at_contig_end ... ok
[INFO] [stdout] test file_tools::bam_reader::tests::test_coverage_observer_insertion_does_not_advance_reference ... ok
[INFO] [stdout] test file_tools::bam_reader::tests::test_coverage_observer_single_record ... ok
[INFO] [stdout] test file_tools::bam_reader::tests::test_coverage_observer_soft_clip_does_not_count ... ok
[INFO] [stdout] test file_tools::bam_reader::tests::test_parse_md_simple ... ok
[INFO] [stdout] test file_tools::bam_reader::tests::test_parse_md_leading_zero_mismatch ... ok
[INFO] [stdout] test file_tools::bam_reader::tests::test_parse_md_with_deletion ... ok
[INFO] [stdout] test file_tools::bam_reader::tests::test_coverage_observer_deletion_advances_reference_without_depth ... ok
[INFO] [stdout] test file_tools::bam_reader::tests::test_coverage_observer_multi_contig ... ok
[INFO] [stdout] test file_tools::bam_reader::tests::test_coverage_observer_overlapping_reads_add ... ok
[INFO] [stdout] test file_tools::bam_reader::tests::test_walk_bam_min_mapq_zero_keeps_records_with_no_mapq ... ok
[INFO] [stdout] test file_tools::bam_writer::tests::test_bam_writer_creates_file ... ok
[INFO] [stdout] test file_tools::bam_reader::tests::test_walk_bam_require_same_ref_as_mate ... ok
[INFO] [stdout] test file_tools::bam_reader::tests::test_walk_bam_min_mapq_is_strict_lower_bound ... ok
[INFO] [stdout] test file_tools::bam_writer::tests::test_concat_temp_bams_empty_body_files ... ok
[INFO] [stdout] test file_tools::bam_reader::tests::test_walk_bam_dispatches_to_multiple_observers ... ok
[INFO] [stdout] test file_tools::bam_writer::tests::test_flush_all_sorts_and_writes ... ok
[INFO] [stdout] test file_tools::bam_writer::tests::test_concat_temp_bams_single_body_file ... ok
[INFO] [stdout] test file_tools::bed_reader::tests::test_process_mut_bed ... ok
[INFO] [stdout] test file_tools::bam_reader::tests::test_walk_bam_skip_flags_drops_secondary ... ok
[INFO] [stdout] test file_tools::bam_writer::tests::test_read_flags_paired_r1 ... ok
[INFO] [stdout] test file_tools::bam_writer::tests::test_read_flags_single_ended ... ok
[INFO] [stdout] test file_tools::bed_reader::tests::test_read_bed_file_not_found ... ok
[INFO] [stdout] test file_tools::bam_writer::tests::test_read_flags_paired_r2 ... ok
[INFO] [stdout] test file_tools::bed_reader::tests::test_process_bed_no_extension_succeeds ... ok
[INFO] [stdout] test file_tools::bed_reader::tests::test_process_bed ... ok
[INFO] [stdout] test file_tools::bam_writer::tests::test_flush_up_to_empty_carry_is_noop ... ok
[INFO] [stdout] test file_tools::bam_writer::tests::test_concat_temp_bams_produces_readable_bam ... ok
[INFO] [stdout] test file_tools::bed_reader::tests::test_read_bed_negative_coordinates ... ok
[INFO] [stdout] test file_tools::block_gz::tests::empty_input_yields_valid_empty_gzip ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_non_n_regions_interior_n ... ok
[INFO] [stdout] test file_tools::bed_reader::tests::test_read_bed_malformed_int ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_empty_file_yields_no_contigs ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_n_bases_preserved_as_raw_char ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_non_n_regions_leading_n ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_non_n_regions_all_n ... ok
[INFO] [stdout] test file_tools::bam_writer::tests::test_flush_up_to_partitions_carry ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_reads_single_contig ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_resolve_iupac_all_codes_yield_only_acgtn ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_parses_multiline_sequence ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_reads_gzipped_fasta ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_resolve_iupac_h_uniform_distribution ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_non_n_regions_x_at_start_is_skipped ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_non_n_regions_x_closes_region ... ok
[INFO] [stdout] test file_tools::block_gz::tests::concatenated_streams_are_one_valid_stream ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_non_n_regions_no_ns ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_reads_multiple_contigs ... ok
[INFO] [stdout] test file_tools::block_gz::tests::small_input_round_trips ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_scan_fasta_lengths_multiline ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_scan_fasta_lengths_single_contig ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_resolve_iupac_r_uniform_distribution ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_combine_temp_fastqs ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_resolve_iupac_masked_bases_pass_through ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_resolve_iupac_preserves_acgtn_unchanged ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_scan_fasta_lengths_multiple_contigs ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_strips_description_from_header ... ok
[INFO] [stdout] test file_tools::fasta_stream::tests::test_scan_fasta_lengths_strips_description ... ok
[INFO] [stdout] test file_tools::block_gz::tests::drop_without_finish_still_finalizes ... ok
[INFO] [stdout] test file_tools::block_gz::tests::multi_block_input_round_trips ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_qual_score_to_write ... ok
[INFO] [stdout] test file_tools::block_gz::tests::many_small_writes_reassemble ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_reverse_complement ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_reverse_complement_record ... ok
[INFO] [stdout] test file_tools::block_gz::tests::exact_block_boundaries_round_trip ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_generate_read_snp_variant_produces_all_m_cigar ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_generate_read_counter_heterozygous_splits_around_half ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_generate_read_counter_homozygous_all_alt ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_generate_read_deletion_error_increases_cigar_length ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_generate_read_cigar_mi_plus_d_equals_len ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_generate_read_cigar_all_match_no_errors ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_generate_read_error_indels_appear_in_cigar ... ok
[INFO] [stdout] test file_tools::file_io::tests::test_append_to_file_appends ... ok
[INFO] [stdout] test file_tools::file_io::tests::test_append_to_file_creates_new ... ok
[INFO] [stdout] test file_tools::file_io::tests::test_create_output_file_new ... ok
[INFO] [stdout] test file_tools::file_io::tests::test_create_output_file_no_overwrite_panics - should panic ... ok
[INFO] [stdout] test file_tools::file_io::tests::test_create_output_file_overwrite ... ok
[INFO] [stdout] test file_tools::file_io::tests::test_open_safe ... ok
[INFO] [stdout] test file_tools::file_io::tests::test_read_gzip_lines ... ok
[INFO] [stdout] test file_tools::file_io::tests::test_read_lines ... ok
[INFO] [stdout] test file_tools::file_io::tests::test_vector_buffer_accumulates_writes ... ok
[INFO] [stdout] test file_tools::folder_tools::tests::test_check_parent ... ok
[INFO] [stdout] test file_tools::folder_tools::tests::test_check_parent_fail ... FAILED
[INFO] [stdout] test file_tools::fastq_tools::tests::test_generate_read_insertion_variant_produces_i_ops ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_all_breakend_forms_round_trip ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_all_dot_genotype_treated_as_homozygous ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_info_with_embedded_semicolons_preserved ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_gzipped_input ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_lean_drops_unused_string_fields ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_lean_trailing_format_fields_dropped ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_lean_sites_only_defaults_to_heterozygous ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_missing_gt_defaults_to_heterozygous ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_mixed_phased_unphased_gt_both_supported ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_multi_allelic_alt_skipped ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_qual_dot ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_sample_longer_than_format_rejected ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_sites_only_record_defaults_to_heterozygous ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_symbolic_cnv ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_symbolic_dup_with_cn_and_svlen ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_symbolic_inv ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_generate_read_reverse_applies_variant ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_symbolic_svtype_disagreement_still_parses ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_symbolic_round_trip_through_writer ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_trailing_format_fields_dropped ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_write_vcf ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_write_vcf_bnd_variant_round_trips ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_write_vcf_emits_ad_dp_af_from_counter ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_write_vcf_avoid_duplicating_symbolic_variants ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_write_vcf_input_provenance_surfaces_as_input_tag ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_write_vcf_multi_contig ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_write_vcf_output_is_bgzf_framed ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_write_vcf_records_emitted_in_position_sorted_order ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_write_vcf_symbolic_alt_round_trips_raw_string ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_write_vcf_symbolic_appends_provenance_to_existing_info ... ok
[INFO] [stdout] test file_tools::vcf_tools::tests::test_read_vcf_symbolic_del_parses_to_symbolic_with_info ... ok
[INFO] [stdout] test models::fragment_length::tests::test_from_file ... ok
[INFO] [stdout] test models::fragment_length::tests::test_new_discrete ... ok
[INFO] [stdout] test models::fragment_length::tests::test_new_from_mean ... ok
[INFO] [stdout] test models::fragment_length::tests::test_new_normal ... ok
[INFO] [stdout] test models::fragment_length::tests::test_normal_default ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_default_model_has_101_unit_weights ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_default_window_size_is_100 ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_from_weights_rejects_all_zero_weights ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_from_weights_rejects_infinite_weight ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_from_weights_rejects_nan_weight ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_from_weights_rejects_negative_weight ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_from_weights_rejects_too_few_bins ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_from_weights_rejects_too_many_bins ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_from_weights_rejects_zero_window_size ... ok
[INFO] [stdout] test models::fragment_length::tests::test_discrete_default ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_max_weight ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_mean_weight ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_legacy_file_without_window_size_gets_default ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_weight_for_gc_fraction_clamps_above_one ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_weight_for_gc_fraction_clamps_below_zero ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_weight_for_gc_fraction_rounds_to_nearest_percent ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_roundtrip_write_and_read ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_weight_for_sequence_all_n_returns_neutral ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_weight_for_sequence_empty_slice_returns_neutral ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_weight_for_sequence_fifty_percent_gc ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_weight_for_sequence_ignores_n_bases_in_gc_fraction ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_weight_for_sequence_one_hundred_percent_gc ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_weight_for_gc_fraction_uses_percent_bins ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_weight_for_sequence_zero_percent_gc ... ok
[INFO] [stdout] test models::indel_model::tests::test_generate_insertion ... ok
[INFO] [stdout] test models::gc_bias_model::tests::test_window_size_accessor_returns_stored_value ... ok
[INFO] [stdout] test models::indel_model::tests::test_generate_random_insertion_empty ... ok
[INFO] [stdout] test models::indel_model::tests::test_indel_model ... ok
[INFO] [stdout] test models::indel_model::tests::test_generate_random_insertion_content ... ok
[INFO] [stdout] test models::indel_model::tests::test_indel_model_from_raw_data ... ok
[INFO] [stdout] test models::indel_model::tests::test_indel_model_file_round_trip ... ok
[INFO] [stdout] test models::indel_model::tests::test_is_insertion_above_threshold ... ok
[INFO] [stdout] test models::indel_model::tests::test_is_insertion_at_boundary ... ok
[INFO] [stdout] test models::indel_model::tests::test_is_insertion_below_threshold ... ok
[INFO] [stdout] test models::indel_model::tests::test_new_delete_length ... ok
[INFO] [stdout] test models::mutation_model::tests::from_raw_data_leaves_sv_model_none ... ok
[INFO] [stdout] test models::fragment_length::tests::test_generate_fragment ... ok
[INFO] [stdout] test models::mutation_model::tests::populated_sv_model_round_trips_through_mutation_model_json ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_apply_variants ... ok
[INFO] [stdout] test models::mutation_model::tests::test_check_base_replaces_n ... ok
[INFO] [stdout] test models::mutation_model::tests::test_check_base_unmasks_masked ... ok
[INFO] [stdout] test models::mutation_model::tests::test_from_raw_data_no_indels ... ok
[INFO] [stdout] test models::mutation_model::tests::test_check_base_passes_through_acgt ... ok
[INFO] [stdout] test models::mutation_model::tests::pre_v1_10_model_json_without_sv_field_loads_with_sv_model_none ... ok
[INFO] [stdout] test models::mutation_model::tests::test_generate_genotype_heterozygous ... ok
[INFO] [stdout] test models::mutation_model::tests::test_generate_mutation_deterministic ... ok
[INFO] [stdout] test models::mutation_model::tests::test_generate_mutation_produces_variant ... ok
[INFO] [stdout] test models::mutation_model::tests::test_generate_genotype_homozygous ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_literal_long_deletion_emits_d_ops ... ok
[INFO] [stdout] test models::quality_scores::tests::test_binned_model_generates_only_bins ... ok
[INFO] [stdout] test models::quality_scores::tests::test_from_counts_rejects_binned_with_thirty_one ... ok
[INFO] [stdout] test models::quality_scores::tests::test_from_counts_generates_only_observed_scores ... ok
[INFO] [stdout] test models::quality_scores::tests::test_from_counts_zero_transition_row_uses_uniform_fallback ... ok
[INFO] [stdout] test models::quality_scores::tests::test_from_counts_basic ... ok
[INFO] [stdout] test models::quality_scores::tests::test_binned_model_serialization_round_trip ... ok
[INFO] [stdout] test models::mutation_model::tests::test_model_read_write ... ok
[INFO] [stdout] test models::quality_scores::tests::test_model_default ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_write_block_fastq_carry_bounded_pe ... ok
[INFO] [stdout] test models::quality_scores::tests::test_quality_scores_same ... ok
[INFO] [stdout] test models::quality_scores::tests::test_quality_scores_long ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_write_block_fastq_bam_sorted_with_incremental_flush ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_append_adapter_pads_to_read_length_and_softclips ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_write_reverse ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_r2_adapter_appended_forward_after_flip ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_append_adapter_noop_when_insert_ge_read_length ... ok
[INFO] [stdout] test models::sequencing_error_model::tests::test_sequencing_error_model_binned_emits_only_bins ... ok
[INFO] [stdout] test models::quality_scores::tests::test_model_write_read ... ok
[INFO] [stdout] test models::snp_trinuc_model::tests::context_weights_reflect_trinuc_frequency ... ok
[INFO] [stdout] test models::snp_trinuc_model::tests::test_default_minimal_generate_snp ... ok
[INFO] [stdout] test models::snp_trinuc_model::tests::test_default_minimal_has_16_contexts ... ok
[INFO] [stdout] test models::snp_trinuc_model::tests::test_generate_snp_changes_base ... ok
[INFO] [stdout] test models::snp_trinuc_model::tests::test_generate_snp_deterministic ... ok
[INFO] [stdout] test models::snp_trinuc_model::tests::test_model_write_read ... FAILED
[INFO] [stdout] test models::snp_trinuc_model::tests::test_model_write_read_round_trip ... ok
[INFO] [stdout] test models::sv_model_defaults::tests::default_sv_model_carries_all_six_supported_types ... ok
[INFO] [stdout] test models::sv_model_defaults::tests::default_sv_model_cn_distribution_sums_to_one ... ok
[INFO] [stdout] test models::sv_model_defaults::tests::default_sv_model_is_usable ... ok
[INFO] [stdout] test models::sv_model_defaults::tests::default_sv_model_parameters_in_plausible_ranges ... ok
[INFO] [stdout] test models::sv_model_defaults::tests::default_sv_model_type_probabilities_sum_to_one ... ok
[INFO] [stdout] test rng::mash::tests::test_mash ... ok
[INFO] [stdout] test rng::tests::test_gen_bool ... ok
[INFO] [stdout] test rng::tests::test_rand_int ... ok
[INFO] [stdout] test rng::tests::test_random ... ok
[INFO] [stdout] test rng::tests::test_range ... ok
[INFO] [stdout] test rng::tests::test_shuffle_in_place ... ok
[INFO] [stdout] test structs::bed_record::test::new_bedrecord ... ok
[INFO] [stdout] test structs::bed_record::test::test_contains ... ok
[INFO] [stdout] test structs::bed_record::test::test_get_contig ... ok
[INFO] [stdout] test structs::bed_record::test::test_mut_rate_parser_fails ... ok
[INFO] [stdout] test structs::bed_record::test::test_new_bed_record_edge_cases ... ok
[INFO] [stdout] test structs::bed_record::test::test_new_mut_region_record ... ok
[INFO] [stdout] test structs::bed_record::test::test_new_mut_region_record_bad_rate ... ok
[INFO] [stdout] test structs::bed_record::test::test_not_a_number_error ... ok
[INFO] [stdout] test structs::bed_record::test::test_overlaps ... ok
[INFO] [stdout] test structs::bed_record::test::test_overlaps_more ... ok
[INFO] [stdout] test structs::bed_record::test::test_parse_other_case_insensitivity ... ok
[INFO] [stdout] test structs::bed_record::test::test_parse_other_delimiters ... ok
[INFO] [stdout] test structs::bed_record::test::test_parse_other_finds_mut_rate ... ok
[INFO] [stdout] test structs::bed_record::test::test_parse_other_missing_rate ... ok
[INFO] [stdout] test structs::distributions::test::new_from_values ... ok
[INFO] [stdout] test models::quality_scores::tests::test_quality_scores_short ... ok
[INFO] [stdout] test structs::distributions::test::proptest_all_zero_weights_always_returns_first_value ... ok
[INFO] [stdout] test structs::distributions::test::proptest_sample_returns_value_from_input_set ... ok
[INFO] [stdout] test structs::distributions::test::test_discrete_distribution ... ok
[INFO] [stdout] test structs::distributions::test::test_discrete_distribution_with_values ... ok
[INFO] [stdout] test structs::distributions::test::test_normal_distribution_inverse_cdf_symmetry ... ok
[INFO] [stdout] test structs::distributions::test::test_normal_distribution_params ... ok
[INFO] [stdout] test structs::distributions::test::test_normal_distribution_sample_median ... ok
[INFO] [stdout] test structs::distributions::test::test_normal_distribution_sample_range ... ok
[INFO] [stdout] test structs::mutated_map::tests::test_contains ... ok
[INFO] [stdout] test structs::mutated_map::tests::test_from_interval_routes_symbolic_to_sv_records ... ok
[INFO] [stdout] test structs::mutated_map::tests::test_is_flagged ... ok
[INFO] [stdout] test structs::mutated_map::tests::test_mutate_position_heterozygous_returns_ref_or_alt ... ok
[INFO] [stdout] test structs::mutated_map::tests::test_mutate_position_homozygous_always_returns_alt ... ok
[INFO] [stdout] test structs::mutated_map::tests::test_mutate_position_returns_reference_for_symbolic_leak ... ok
[INFO] [stdout] test structs::nucleotides::tests::cast_type ... ok
[INFO] [stdout] test structs::nucleotides::tests::test_base_to_nuc ... ok
[INFO] [stdout] test structs::nucleotides::tests::test_complement ... ok
[INFO] [stdout] test structs::nucleotides::tests::test_get_masked ... ok
[INFO] [stdout] test structs::nucleotides::tests::test_get_unmasked_base ... ok
[INFO] [stdout] test structs::nucleotides::tests::test_is_masked ... ok
[INFO] [stdout] test structs::nucleotides::tests::test_sequence_array_to_string ... ok
[INFO] [stdout] test structs::sequence_block::tests::test_get_len ... ok
[INFO] [stdout] test structs::sequence_block::tests::test_get_non_n_regions_all_non_n ... ok
[INFO] [stdout] test structs::sequence_block::tests::test_get_non_n_regions_mixed ... ok
[INFO] [stdout] test structs::sequence_block::tests::test_get_subseq_bad_coords ... ok
[INFO] [stdout] test structs::sequence_block::tests::test_get_subseq_full ... ok
[INFO] [stdout] test structs::sequence_block::tests::test_get_subseq_out_of_bounds ... ok
[INFO] [stdout] test structs::sequence_block::tests::test_get_subseq_valid ... ok
[INFO] [stdout] test structs::sv_model::tests::affected_range_for_existing_ins_is_point_event ... ok
[INFO] [stdout] test structs::sv_model::tests::anchor_window_alignable_basics ... ok
[INFO] [stdout] test structs::sv_model::tests::build_info_field_round_trips_through_parse_sv_info ... ok
[INFO] [stdout] test structs::sv_model::tests::de_novo_ins_emits_literal_variant_with_novel_sequence ... ok
[INFO] [stdout] test structs::sv_model::tests::default_sv_model_is_not_usable ... ok
[INFO] [stdout] test structs::sv_model::tests::fit_drops_sub_50bp_records_and_unsupported_types ... ok
[INFO] [stdout] test structs::sv_model::tests::fit_drops_types_with_one_observation ... ok
[INFO] [stdout] test structs::sv_model::tests::fit_from_observations_handles_ins ... ok
[INFO] [stdout] test structs::sv_model::tests::fit_ignores_non_symbolic_alts ... ok
[INFO] [stdout] test structs::sv_model::tests::fit_populates_cnv_copy_number_distribution ... ok
[INFO] [stdout] test structs::sv_model::tests::fit_recovers_log_normal_parameters_within_tolerance ... ok
[INFO] [stdout] test structs::sv_model::tests::fit_returns_none_for_empty_observations ... ok
[INFO] [stdout] test structs::sv_model::tests::fit_returns_none_when_every_type_thin ... ok
[INFO] [stdout] test structs::sv_model::tests::fit_returns_none_when_total_reflen_zero ... ok
[INFO] [stdout] test structs::sv_model::tests::genotype_string_handles_polyploid ... ok
[INFO] [stdout] test structs::sv_model::tests::is_usable_requires_both_rate_and_type_probabilities ... ok
[INFO] [stdout] test structs::sv_model::tests::min_sv_length_is_the_industry_50bp_cutoff ... ok
[INFO] [stdout] test structs::sv_model::tests::populated_sv_model_round_trips_through_serde_json ... ok
[INFO] [stdout] test structs::sv_model::tests::sample_poisson_extreme_lambda_does_not_overflow ... ok
[INFO] [stdout] test structs::sv_model::tests::sample_poisson_large_lambda_mean_matches ... ok
[INFO] [stdout] test structs::sv_model::tests::sample_poisson_large_lambda_returns_finite_count ... ok
[INFO] [stdout] test structs::sv_model::tests::sample_poisson_small_lambda_still_uses_knuth ... ok
[INFO] [stdout] test models::quality_scores::tests::test_quality_scores_vast_difference ... ok
[INFO] [stdout] test structs::sv_model::tests::sample_variants_is_deterministic_for_same_seed ... ok
[INFO] [stdout] test structs::sv_model::tests::sample_variants_length_cap_is_configurable ... ok
[INFO] [stdout] test structs::sv_model::tests::sample_variants_returns_empty_when_contig_too_small ... ok
[INFO] [stdout] test structs::sv_model::tests::sample_variants_returns_empty_when_model_unusable ... ok
[INFO] [stdout] test structs::sv_model::tests::sample_variants_returns_empty_when_rate_scale_zero ... ok
[INFO] [stdout] test structs::sv_model::tests::sample_variants_skips_anchors_in_n_gaps ... ok
[INFO] [stdout] test structs::sv_model::tests::sample_variants_skips_n_adjacent_clean_anchors ... ok
[INFO] [stdout] test models::sequencing_error_model::tests::test_sequencing_error_deterministic ... ok
[INFO] [stdout] test structs::sv_model::tests::sampled_bnds_have_fixed_1bp_length ... ok
[INFO] [stdout] test structs::sv_model::tests::sampled_cnvs_carry_info_cn_from_distribution ... ok
[INFO] [stdout] test structs::sv_model::tests::sampled_cnvs_use_fallback_cn_when_trained_dist_is_empty ... ok
[INFO] [stdout] test structs::sv_model::tests::sampled_dels_have_correct_anchor_and_end_invariant ... ok
[INFO] [stdout] test structs::sv_model::tests::sampled_dups_have_correct_pos_and_end_invariant ... ok
[INFO] [stdout] test structs::sv_model::tests::sampled_ins_emit_literal_with_min_length_inserted_sequence ... ok
[INFO] [stdout] test structs::sv_model::tests::sampled_invs_have_correct_pos_and_end_invariant ... ok
[INFO] [stdout] test structs::distributions::test::proptest_empirical_frequency_approaches_weights ... ok
[INFO] [stdout] test structs::transition_matrix::tests::test_from_tsv_too_few_rows_errors ... ok
[INFO] [stdout] test structs::transition_matrix::tests::test_from_tsv_valid ... ok
[INFO] [stdout] test structs::transition_matrix::tests::test_transition_matrix_build ... ok
[INFO] [stdout] test structs::sv_model::tests::sampled_variants_dont_overlap_each_other_or_existing_svs ... ok
[INFO] [stdout] test structs::variants::tests::alternate_type_literal_as_literal_returns_slice ... ok
[INFO] [stdout] test structs::variants::tests::alternate_type_literal_helpers ... ok
[INFO] [stdout] test structs::variants::tests::alternate_type_symbolic_as_literal_returns_none ... ok
[INFO] [stdout] test structs::transition_matrix::tests::test_transition_matrix_default ... ok
[INFO] [stdout] test structs::variants::tests::from_file_literal_complex_with_end_info_stays_literal ... ok
[INFO] [stdout] test structs::variants::tests::parse_alternate_accepts_lowercase_and_n ... ok
[INFO] [stdout] test structs::variants::tests::parse_alternate_breakend_alt_classifies_as_bnd ... ok
[INFO] [stdout] test structs::variants::tests::parse_alternate_complex_multibase_substitution ... ok
[INFO] [stdout] test structs::variants::tests::from_file_invalid_end_is_dropped_and_falls_back_to_svlen ... ok
[INFO] [stdout] test structs::variants::tests::parse_alternate_deletion ... ok
[INFO] [stdout] test structs::variants::tests::parse_alternate_complex_unequal_length ... ok
[INFO] [stdout] test structs::variants::tests::parse_alternate_empty_reference_is_invalid_vcf ... ok
[INFO] [stdout] test structs::variants::tests::parse_alternate_insertion ... ok
[INFO] [stdout] test structs::variants::tests::parse_alternate_empty_alt_is_invalid_vcf ... ok
[INFO] [stdout] test structs::variants::tests::parse_alternate_snp ... ok
[INFO] [stdout] test structs::variants::tests::parse_alternate_non_iupac_ref_is_invalid_vcf ... ok
[INFO] [stdout] test structs::variants::tests::parse_alternate_symbolic_alts_round_trip_with_correct_type ... ok
[INFO] [stdout] test structs::variants::tests::parse_bnd_alt_extracts_mate_info ... ok
[INFO] [stdout] test structs::variants::tests::parse_sv_info_dot_or_empty_returns_default ... ok
[INFO] [stdout] test structs::variants::tests::parse_sv_info_extracts_all_known_fields ... ok
[INFO] [stdout] test structs::variants::tests::parse_sv_info_ignores_unknown_keys_and_bare_flags ... ok
[INFO] [stdout] test structs::variants::tests::parse_sv_info_last_value_wins_on_duplicate_keys ... ok
[INFO] [stdout] test structs::variants::tests::parse_sv_info_malformed_values_warn_and_drop ... ok
[INFO] [stdout] test structs::variants::tests::parse_sv_info_tolerates_empty_entries_and_trailing_semicolons ... ok
[INFO] [stdout] test structs::variants::tests::sv_data_span_falls_back_to_svlen ... ok
[INFO] [stdout] test structs::variants::tests::sv_data_span_from_end_field ... ok
[INFO] [stdout] test structs::variants::tests::sv_data_span_invalid_end_does_not_fall_back_to_svlen ... ok
[INFO] [stdout] test structs::variants::tests::sv_data_span_none_when_neither_set ... ok
[INFO] [stdout] test structs::variants::tests::sv_data_span_prefers_end_over_svlen ... ok
[INFO] [stdout] test structs::variants::tests::sv_data_span_returns_none_when_end_before_location ... ok
[INFO] [stdout] test structs::variants::tests::sv_type_from_alt_string_breakend ... ok
[INFO] [stdout] test structs::variants::tests::sv_type_from_alt_string_literal_returns_none ... ok
[INFO] [stdout] test structs::variants::tests::sv_type_from_alt_string_recognizes_standard_tags ... ok
[INFO] [stdout] test structs::variants::tests::sv_type_from_alt_string_unknown_tag ... ok
[INFO] [stdout] test structs::variants::tests::sv_type_matches_svtype_strict_and_unknown_passthrough ... ok
[INFO] [stdout] test structs::variants::tests::test_bad_variant_creation - should panic ... ok
[INFO] [stdout] test structs::variants::tests::test_deletion_new ... ok
[INFO] [stdout] test structs::variants::tests::test_empty_alternate_returns_malformed_alt ... ok
[INFO] [stdout] test structs::variants::tests::parse_alternate_unrecognized_nonliteral_alt_is_invalid_vcf ... ok
[INFO] [stdout] test structs::variants::tests::test_empty_reference_returns_malformed_ref ... ok
[INFO] [stdout] test structs::variants::tests::test_variant_creation ... ok
[INFO] [stdout] test structs::variants::tests::test_genotype_to_string ... ok
[INFO] [stdout] test structs::variants::tests::test_variant_from_file_carries_input_provenance ... ok
[INFO] [stdout] test structs::variants::tests::test_variant_new ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_write_block_fastq_carry_bounded_se ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_write_block_fastq_unique_names_for_same_position_fragments ... ok
[INFO] [stdout] test models::sequencing_error_model::tests::test_convert_score ... ok
[INFO] [stdout] test structs::sv_model::tests::sample_variants_emits_all_supported_types ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_write_block_fastq_ref_start_in_read_name ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_write_block_fastq_keep_short_no_adapter_emits_genomic_insert_length_reads ... ok
[INFO] [stdout] test models::sequencing_error_model::tests::test_from_raw_data_stores_error_rate_and_defaults ... ok
[INFO] [stdout] test file_tools::fastq_tools::tests::test_write_block_fastq_skips_zero_insert_no_malformed_record ... ok
[INFO] [stdout] test models::sequencing_error_model::tests::test_convert_score_additional ... ok
[INFO] [stdout] test models::sequencing_error_model::tests::test_indel_forced_path_types ... ok
[INFO] [stdout] test models::sequencing_error_model::tests::test_sequencing_error_model ... ok
[INFO] [stdout] test models::sequencing_error_model::tests::test_sequencing_error_model_file_round_trip ... ok
[INFO] [stdout] test models::sequencing_error_model::tests::test_from_raw_data_round_trips_file ... ok
[INFO] [stdout] test structs::sv_model::tests::sample_variants_works_at_chromosome_scale ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- file_tools::folder_tools::tests::test_check_parent_fail stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'file_tools::folder_tools::tests::test_check_parent_fail' (3984) panicked at common/src/file_tools/folder_tools.rs:23:38:
[INFO] [stdout] Error creating the directory: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5a390b9c2121 - std[73adb7dc35730857]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5a390b9c2121 - std[73adb7dc35730857]::backtrace_rs::backtrace::trace_unsynchronized::<std[73adb7dc35730857]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5a390b9c2121 - std[73adb7dc35730857]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5a390b9c2121 - <<std[73adb7dc35730857]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[6883ba1bc0fe4ed1]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5a390b9d9e6a - <core[6883ba1bc0fe4ed1]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5a390b9d9e6a - core[6883ba1bc0fe4ed1]::fmt::write
[INFO] [stdout]    6:     0x5a390b9c6d9c - std[73adb7dc35730857]::io::default_write_fmt::<alloc[55a36b64bcbf2c0d]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/io/mod.rs:626:11
[INFO] [stdout]    7:     0x5a390b9c6d9c - <alloc[55a36b64bcbf2c0d]::vec::Vec<u8> as std[73adb7dc35730857]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/io/mod.rs:1730:13
[INFO] [stdout]    8:     0x5a390b99de16 - <std[73adb7dc35730857]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5a390b99de16 - std[73adb7dc35730857]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5a390b9b8e39 - std[73adb7dc35730857]::panicking::default_hook
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5a390b7daa70 - <alloc[55a36b64bcbf2c0d]::boxed::Box<dyn for<'a, 'b> core[6883ba1bc0fe4ed1]::ops::function::Fn<(&'a std[73adb7dc35730857]::panic::PanicHookInfo<'b>,), Output = ()> + core[6883ba1bc0fe4ed1]::marker::Send + core[6883ba1bc0fe4ed1]::marker::Sync> as core[6883ba1bc0fe4ed1]::ops::function::Fn<(&std[73adb7dc35730857]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/alloc/src/boxed.rs:2333:9
[INFO] [stdout]   12:     0x5a390b7daa70 - test[980ffaebd391d06d]::test_main_inner::<test[980ffaebd391d06d]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5a390b9b8ff2 - <alloc[55a36b64bcbf2c0d]::boxed::Box<dyn for<'a, 'b> core[6883ba1bc0fe4ed1]::ops::function::Fn<(&'a std[73adb7dc35730857]::panic::PanicHookInfo<'b>,), Output = ()> + core[6883ba1bc0fe4ed1]::marker::Send + core[6883ba1bc0fe4ed1]::marker::Sync> as core[6883ba1bc0fe4ed1]::ops::function::Fn<(&std[73adb7dc35730857]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/alloc/src/boxed.rs:2333:9
[INFO] [stdout]   14:     0x5a390b9b8ff2 - std[73adb7dc35730857]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:823:13
[INFO] [stdout]   15:     0x5a390b99dec2 - std[73adb7dc35730857]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:688:13
[INFO] [stdout]   16:     0x5a390b9953d9 - std[73adb7dc35730857]::sys::backtrace::__rust_end_short_backtrace::<std[73adb7dc35730857]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5a390b99eabd - __rustc[a7b7b02e776dd976]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:679:5
[INFO] [stdout]   18:     0x5a390b9da71c - core[6883ba1bc0fe4ed1]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5a390b9da462 - core[6883ba1bc0fe4ed1]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/result.rs:1870:5
[INFO] [stdout]   20:     0x5a390b82554c - <core[6883ba1bc0fe4ed1]::result::Result<(), core[6883ba1bc0fe4ed1]::io::error::Error>>::expect
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/result.rs:1183:23
[INFO] [stdout]   21:     0x5a390b5d8124 - common[4c7c95f40a098d4b]::file_tools::folder_tools::check_create_dir
[INFO] [stdout]                                at /opt/rustwide/workdir/common/src/file_tools/folder_tools.rs:23:38
[INFO] [stdout]   22:     0x5a390b5d7d9f - common[4c7c95f40a098d4b]::file_tools::folder_tools::check_parent
[INFO] [stdout]                                at /opt/rustwide/workdir/common/src/file_tools/folder_tools.rs:12:9
[INFO] [stdout]   23:     0x5a390b794ab6 - common[4c7c95f40a098d4b]::file_tools::folder_tools::tests::test_check_parent_fail
[INFO] [stdout]                                at /opt/rustwide/workdir/common/src/file_tools/folder_tools.rs:41:9
[INFO] [stdout]   24:     0x5a390b787387 - common[4c7c95f40a098d4b]::file_tools::folder_tools::tests::test_check_parent_fail::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/common/src/file_tools/folder_tools.rs:38:32
[INFO] [stdout]   25:     0x5a390b699da6 - <common[4c7c95f40a098d4b]::file_tools::folder_tools::tests::test_check_parent_fail::{closure#0} as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5a390b7cddab - <fn() -> core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   27:     0x5a390b7cddab - test[980ffaebd391d06d]::__rust_begin_short_backtrace::<core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>, fn() -> core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:724:18
[INFO] [stdout]   28:     0x5a390b7db3f5 - test[980ffaebd391d06d]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:747:74
[INFO] [stdout]   29:     0x5a390b7db3f5 - <core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   30:     0x5a390b7db3f5 - std[73adb7dc35730857]::panicking::catch_unwind::do_call::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}>, core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:576:43
[INFO] [stdout]   31:     0x5a390b7db3f5 - std[73adb7dc35730857]::panicking::catch_unwind::<core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>, core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:544:19
[INFO] [stdout]   32:     0x5a390b7db3f5 - std[73adb7dc35730857]::panic::catch_unwind::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}>, core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panic.rs:359:14
[INFO] [stdout]   33:     0x5a390b7db3f5 - test[980ffaebd391d06d]::run_test_in_process
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:747:27
[INFO] [stdout]   34:     0x5a390b7db3f5 - test[980ffaebd391d06d]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:668:43
[INFO] [stdout]   35:     0x5a390b7d5ea4 - test[980ffaebd391d06d]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:698:41
[INFO] [stdout]   36:     0x5a390b7d5ea4 - std[73adb7dc35730857]::sys::backtrace::__rust_begin_short_backtrace::<test[980ffaebd391d06d]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   37:     0x5a390b7de542 - std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked::<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   38:     0x5a390b7de542 - <core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   39:     0x5a390b7de542 - std[73adb7dc35730857]::panicking::catch_unwind::do_call::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:576:43
[INFO] [stdout]   40:     0x5a390b7de542 - std[73adb7dc35730857]::panicking::catch_unwind::<(), core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:544:19
[INFO] [stdout]   41:     0x5a390b7de542 - std[73adb7dc35730857]::panic::catch_unwind::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panic.rs:359:14
[INFO] [stdout]   42:     0x5a390b7de542 - std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked::<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   43:     0x5a390b7de542 - <std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1} as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x5a390b9c137f - <alloc[55a36b64bcbf2c0d]::boxed::Box<dyn core[6883ba1bc0fe4ed1]::ops::function::FnOnce<(), Output = ()> + core[6883ba1bc0fe4ed1]::marker::Send> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/alloc/src/boxed.rs:2319:9
[INFO] [stdout]   45:     0x5a390b9c137f - <std[73adb7dc35730857]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/thread/unix.rs:123:17
[INFO] [stdout]   46:     0x7a392dd7aaa4 - <unknown>
[INFO] [stdout]   47:     0x7a392de07a64 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- models::snp_trinuc_model::tests::test_model_write_read stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'models::snp_trinuc_model::tests::test_model_write_read' (4094) panicked at common/src/models/lib.rs:15:29:
[INFO] [stdout] Error creating output "test.json.gz"
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5a390b9c2121 - std[73adb7dc35730857]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5a390b9c2121 - std[73adb7dc35730857]::backtrace_rs::backtrace::trace_unsynchronized::<std[73adb7dc35730857]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5a390b9c2121 - std[73adb7dc35730857]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5a390b9c2121 - <<std[73adb7dc35730857]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[6883ba1bc0fe4ed1]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5a390b9d9e6a - <core[6883ba1bc0fe4ed1]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5a390b9d9e6a - core[6883ba1bc0fe4ed1]::fmt::write
[INFO] [stdout]    6:     0x5a390b9c6d9c - std[73adb7dc35730857]::io::default_write_fmt::<alloc[55a36b64bcbf2c0d]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/io/mod.rs:626:11
[INFO] [stdout]    7:     0x5a390b9c6d9c - <alloc[55a36b64bcbf2c0d]::vec::Vec<u8> as std[73adb7dc35730857]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/io/mod.rs:1730:13
[INFO] [stdout]    8:     0x5a390b99de16 - <std[73adb7dc35730857]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5a390b99de16 - std[73adb7dc35730857]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5a390b9b8e39 - std[73adb7dc35730857]::panicking::default_hook
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5a390b7daa70 - <alloc[55a36b64bcbf2c0d]::boxed::Box<dyn for<'a, 'b> core[6883ba1bc0fe4ed1]::ops::function::Fn<(&'a std[73adb7dc35730857]::panic::PanicHookInfo<'b>,), Output = ()> + core[6883ba1bc0fe4ed1]::marker::Send + core[6883ba1bc0fe4ed1]::marker::Sync> as core[6883ba1bc0fe4ed1]::ops::function::Fn<(&std[73adb7dc35730857]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/alloc/src/boxed.rs:2333:9
[INFO] [stdout]   12:     0x5a390b7daa70 - test[980ffaebd391d06d]::test_main_inner::<test[980ffaebd391d06d]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5a390b9b8ff2 - <alloc[55a36b64bcbf2c0d]::boxed::Box<dyn for<'a, 'b> core[6883ba1bc0fe4ed1]::ops::function::Fn<(&'a std[73adb7dc35730857]::panic::PanicHookInfo<'b>,), Output = ()> + core[6883ba1bc0fe4ed1]::marker::Send + core[6883ba1bc0fe4ed1]::marker::Sync> as core[6883ba1bc0fe4ed1]::ops::function::Fn<(&std[73adb7dc35730857]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/alloc/src/boxed.rs:2333:9
[INFO] [stdout]   14:     0x5a390b9b8ff2 - std[73adb7dc35730857]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:823:13
[INFO] [stdout]   15:     0x5a390b99dec2 - std[73adb7dc35730857]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:688:13
[INFO] [stdout]   16:     0x5a390b9953d9 - std[73adb7dc35730857]::sys::backtrace::__rust_end_short_backtrace::<std[73adb7dc35730857]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5a390b99eabd - __rustc[a7b7b02e776dd976]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:679:5
[INFO] [stdout]   18:     0x5a390b9da71c - core[6883ba1bc0fe4ed1]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5a390b79ea6c - common[4c7c95f40a098d4b]::models::lib::model_writer::<&common[4c7c95f40a098d4b]::models::snp_trinuc_model::SnpTrinucModel>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/common/src/models/lib.rs:15:29
[INFO] [stdout]   20:     0x5a390b747aa3 - <core[6883ba1bc0fe4ed1]::result::Result<std[73adb7dc35730857]::fs::File, core[6883ba1bc0fe4ed1]::io::error::Error>>::unwrap_or_else::<common[4c7c95f40a098d4b]::models::lib::model_writer<&common[4c7c95f40a098d4b]::models::snp_trinuc_model::SnpTrinucModel>::{closure#0}>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/result.rs:1620:23
[INFO] [stdout]   21:     0x5a390b79a270 - common[4c7c95f40a098d4b]::models::lib::model_writer::<&common[4c7c95f40a098d4b]::models::snp_trinuc_model::SnpTrinucModel>
[INFO] [stdout]                                at /opt/rustwide/workdir/common/src/models/lib.rs:15:10
[INFO] [stdout]   22:     0x5a390b78d543 - <common[4c7c95f40a098d4b]::models::snp_trinuc_model::SnpTrinucModel>::write_out
[INFO] [stdout]                                at /opt/rustwide/workdir/common/src/models/snp_trinuc_model.rs:365:9
[INFO] [stdout]   23:     0x5a390b5fcd31 - common[4c7c95f40a098d4b]::models::snp_trinuc_model::tests::test_model_write_read
[INFO] [stdout]                                at /opt/rustwide/workdir/common/src/models/snp_trinuc_model.rs:399:28
[INFO] [stdout]   24:     0x5a390b5d5887 - common[4c7c95f40a098d4b]::models::snp_trinuc_model::tests::test_model_write_read::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/common/src/models/snp_trinuc_model.rs:394:31
[INFO] [stdout]   25:     0x5a390b69b9e6 - <common[4c7c95f40a098d4b]::models::snp_trinuc_model::tests::test_model_write_read::{closure#0} as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5a390b7cddab - <fn() -> core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   27:     0x5a390b7cddab - test[980ffaebd391d06d]::__rust_begin_short_backtrace::<core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>, fn() -> core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:724:18
[INFO] [stdout]   28:     0x5a390b7db3f5 - test[980ffaebd391d06d]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:747:74
[INFO] [stdout]   29:     0x5a390b7db3f5 - <core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   30:     0x5a390b7db3f5 - std[73adb7dc35730857]::panicking::catch_unwind::do_call::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}>, core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:576:43
[INFO] [stdout]   31:     0x5a390b7db3f5 - std[73adb7dc35730857]::panicking::catch_unwind::<core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>, core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:544:19
[INFO] [stdout]   32:     0x5a390b7db3f5 - std[73adb7dc35730857]::panic::catch_unwind::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}>, core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panic.rs:359:14
[INFO] [stdout]   33:     0x5a390b7db3f5 - test[980ffaebd391d06d]::run_test_in_process
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:747:27
[INFO] [stdout]   34:     0x5a390b7db3f5 - test[980ffaebd391d06d]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:668:43
[INFO] [stdout]   35:     0x5a390b7d5ea4 - test[980ffaebd391d06d]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:698:41
[INFO] [stdout]   36:     0x5a390b7d5ea4 - std[73adb7dc35730857]::sys::backtrace::__rust_begin_short_backtrace::<test[980ffaebd391d06d]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   37:     0x5a390b7de542 - std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked::<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   38:     0x5a390b7de542 - <core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   39:     0x5a390b7de542 - std[73adb7dc35730857]::panicking::catch_unwind::do_call::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:576:43
[INFO] [stdout]   40:     0x5a390b7de542 - std[73adb7dc35730857]::panicking::catch_unwind::<(), core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:544:19
[INFO] [stdout]   41:     0x5a390b7de542 - std[73adb7dc35730857]::panic::catch_unwind::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panic.rs:359:14
[INFO] [stdout]   42:     0x5a390b7de542 - std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked::<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   43:     0x5a390b7de542 - <std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1} as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x5a390b9c137f - <alloc[55a36b64bcbf2c0d]::boxed::Box<dyn core[6883ba1bc0fe4ed1]::ops::function::FnOnce<(), Output = ()> + core[6883ba1bc0fe4ed1]::marker::Send> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/alloc/src/boxed.rs:2319:9
[INFO] [stdout]   45:     0x5a390b9c137f - <std[73adb7dc35730857]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/thread/unix.rs:123:17
[INFO] [stdout]   46:     0x7a392dd7aaa4 - <unknown>
[INFO] [stdout]   47:     0x7a392de07a64 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     file_tools::folder_tools::tests::test_check_parent_fail
[INFO] [stdout]     models::snp_trinuc_model::tests::test_model_write_read
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 347 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 35.08s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `-p common --lib`
[INFO] running `Command { std: "docker" "inspect" "76cd9e169e63b56297a1e8f9fffbf2615390a42ca8f20135491d3b879976aaa8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "76cd9e169e63b56297a1e8f9fffbf2615390a42ca8f20135491d3b879976aaa8", kill_on_drop: false }`
[INFO] [stdout] 76cd9e169e63b56297a1e8f9fffbf2615390a42ca8f20135491d3b879976aaa8
