[INFO] fetching crate rasusa 0.6.1...
[INFO] testing rasusa-0.6.1 against beta-2022-04-10 for beta-1.61-1
[INFO] extracting crate rasusa 0.6.1 into /workspace/builds/worker-12/source
[INFO] validating manifest of crates.io crate rasusa 0.6.1 on toolchain beta-2022-04-10
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate rasusa 0.6.1
[INFO] finished tweaking crates.io crate rasusa 0.6.1
[INFO] tweaked toml for crates.io crate rasusa 0.6.1 written to /workspace/builds/worker-12/source/Cargo.toml
[INFO] crate crates.io crate rasusa 0.6.1 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] d901ce972a06d27d8ddd6402528b76071a3b7a1503a52c8999dec7bc5c2d9750
[INFO] running `Command { std: "docker" "start" "-a" "d901ce972a06d27d8ddd6402528b76071a3b7a1503a52c8999dec7bc5c2d9750", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d901ce972a06d27d8ddd6402528b76071a3b7a1503a52c8999dec7bc5c2d9750", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d901ce972a06d27d8ddd6402528b76071a3b7a1503a52c8999dec7bc5c2d9750", kill_on_drop: false }`
[INFO] [stdout] d901ce972a06d27d8ddd6402528b76071a3b7a1503a52c8999dec7bc5c2d9750
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 759f363d0758e5ca4b43947f9952dff030bbae20a86bd0a351d1101208f83264
[INFO] running `Command { std: "docker" "start" "-a" "759f363d0758e5ca4b43947f9952dff030bbae20a86bd0a351d1101208f83264", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.99
[INFO] [stderr]    Compiling proc-macro2 v1.0.28
[INFO] [stderr]    Compiling cc v1.0.45
[INFO] [stderr]    Compiling unicode-xid v0.2.0
[INFO] [stderr]    Compiling syn v1.0.74
[INFO] [stderr]    Compiling crc32fast v1.2.0
[INFO] [stderr]    Compiling adler32 v1.0.4
[INFO] [stderr]    Compiling winapi v0.3.8
[INFO] [stderr]    Compiling cgmath v0.16.1
[INFO] [stderr]    Compiling autocfg v0.1.6
[INFO] [stderr]    Compiling approx v0.1.1
[INFO] [stderr]    Compiling bitflags v1.2.0
[INFO] [stderr]    Compiling rgb v0.8.14
[INFO] [stderr]    Compiling unicode-segmentation v1.3.0
[INFO] [stderr]    Compiling ppv-lite86 v0.2.10
[INFO] [stderr]    Compiling unicode-width v0.1.6
[INFO] [stderr]    Compiling safemem v0.3.3
[INFO] [stderr]    Compiling anyhow v1.0.33
[INFO] [stderr]    Compiling vec_map v0.8.1
[INFO] [stderr]    Compiling bytecount v0.6.0
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling log v0.4.8
[INFO] [stderr]    Compiling buf_redux v0.8.4
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling miniz_oxide v0.3.3
[INFO] [stderr]    Compiling heck v0.3.1
[INFO] [stderr]    Compiling num-integer v0.1.41
[INFO] [stderr]    Compiling c2-chacha v0.2.2
[INFO] [stderr]    Compiling lzma-sys v0.1.17
[INFO] [stderr]    Compiling bzip2-sys v0.1.11+1.0.8
[INFO] [stderr]    Compiling quote v1.0.2
[INFO] [stderr]    Compiling rand v0.4.6
[INFO] [stderr]    Compiling getrandom v0.1.12
[INFO] [stderr]    Compiling flate2 v1.0.12
[INFO] [stderr]    Compiling atty v0.2.13
[INFO] [stderr]    Compiling time v0.1.42
[INFO] [stderr]    Compiling clap v2.33.0
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling xz2 v0.1.6
[INFO] [stderr]    Compiling rand_chacha v0.2.1
[INFO] [stderr]    Compiling rand_pcg v0.2.1
[INFO] [stderr]    Compiling rand v0.7.2
[INFO] [stderr]    Compiling num-traits v0.1.43
[INFO] [stderr]    Compiling chrono v0.4.9
[INFO] [stderr]    Compiling bzip2 v0.4.3
[INFO] [stderr]    Compiling needletail v0.4.1
[INFO] [stderr]    Compiling winconsole v0.10.0
[INFO] [stderr]    Compiling colored v1.8.0
[INFO] [stderr]    Compiling fern v0.5.9
[INFO] [stderr]    Compiling proc-macro-error v0.2.6
[INFO] [stderr]    Compiling thiserror-impl v1.0.21
[INFO] [stderr]    Compiling structopt-derive v0.3.2
[INFO] [stderr]    Compiling thiserror v1.0.21
[INFO] [stderr]    Compiling bgzip v0.2.1
[INFO] [stderr]    Compiling structopt v0.3.2
[INFO] [stderr]    Compiling niffler v2.3.2
[INFO] [stderr]    Compiling rasusa v0.6.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 12.23s
[INFO] running `Command { std: "docker" "inspect" "759f363d0758e5ca4b43947f9952dff030bbae20a86bd0a351d1101208f83264", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "759f363d0758e5ca4b43947f9952dff030bbae20a86bd0a351d1101208f83264", kill_on_drop: false }`
[INFO] [stdout] 759f363d0758e5ca4b43947f9952dff030bbae20a86bd0a351d1101208f83264
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 58665be3bc294c94daeb44c1c9d9dda0ac18a54068f8a8167d5a47ba9f87e439
[INFO] running `Command { std: "docker" "start" "-a" "58665be3bc294c94daeb44c1c9d9dda0ac18a54068f8a8167d5a47ba9f87e439", kill_on_drop: false }`
[INFO] [stderr]    Compiling ryu v1.0.0
[INFO] [stderr]    Compiling serde v1.0.101
[INFO] [stderr]    Compiling escargot v0.3.1
[INFO] [stderr]    Compiling predicates-core v1.0.0
[INFO] [stderr]    Compiling itoa v0.4.4
[INFO] [stderr]    Compiling difference v2.0.0
[INFO] [stderr]    Compiling treeline v0.1.0
[INFO] [stderr]    Compiling normalize-line-endings v0.2.2
[INFO] [stderr]    Compiling remove_dir_all v0.5.2
[INFO] [stderr]    Compiling float-cmp v0.4.0
[INFO] [stderr]    Compiling serde_derive v1.0.101
[INFO] [stderr]    Compiling tempfile v3.1.0
[INFO] [stderr]    Compiling predicates-tree v1.0.0
[INFO] [stderr]    Compiling predicates v1.0.1
[INFO] [stderr]    Compiling serde_json v1.0.41
[INFO] [stderr]    Compiling assert_cmd v0.10.2
[INFO] [stderr]    Compiling rasusa v0.6.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 13.60s
[INFO] [stderr]   Executable unittests src/main.rs (/opt/rustwide/target/debug/deps/rasusa-d3098f0c3ec31bcd)
[INFO] [stderr]   Executable tests/main.rs (/opt/rustwide/target/debug/deps/main-8958fef7c686388f)
[INFO] running `Command { std: "docker" "inspect" "58665be3bc294c94daeb44c1c9d9dda0ac18a54068f8a8167d5a47ba9f87e439", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "58665be3bc294c94daeb44c1c9d9dda0ac18a54068f8a8167d5a47ba9f87e439", kill_on_drop: false }`
[INFO] [stdout] 58665be3bc294c94daeb44c1c9d9dda0ac18a54068f8a8167d5a47ba9f87e439
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 7e938558dafa80920d2a16ca165b5b39647ae0cd22fc164446efb5f9cd265366
[INFO] running `Command { std: "docker" "start" "-a" "7e938558dafa80920d2a16ca165b5b39647ae0cd22fc164446efb5f9cd265366", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/rasusa-d3098f0c3ec31bcd)
[INFO] [stdout] 
[INFO] [stdout] running 80 tests
[INFO] [stdout] test cli::tests::base_suffix_from_string ... ok
[INFO] [stdout] test cli::tests::compression_format_from_path ... ok
[INFO] [stdout] test cli::tests::divide_u64_by_genome_size ... ok
[INFO] [stdout] test cli::tests::compression_format_from_str ... ok
[INFO] [stdout] test cli::tests::empty_string_is_base_metric_suffix ... ok
[INFO] [stdout] test cli::tests::float_multiply_with_base_unit ... ok
[INFO] [stdout] test cli::tests::genome_size_from_faidx_fastq_index ... ok
[INFO] [stdout] test cli::tests::empty_coverage_returns_err ... ok
[INFO] [stdout] test cli::tests::genome_size_from_faidx ... ok
[INFO] [stdout] test cli::tests::giga_suffix_from_string ... ok
[INFO] [stdout] test cli::tests::float_ending_in_x_coverage_returns_float ... ok
[INFO] [stdout] test cli::tests::float_coverage_returns_float ... ok
[INFO] [stdout] test cli::tests::invalid_suffix_raises_error ... ok
[INFO] [stdout] test cli::tests::int_ending_in_x_coverage_returns_float ... ok
[INFO] [stdout] test cli::tests::mega_suffix_from_string ... ok
[INFO] [stdout] test cli::tests::kilo_suffix_from_string ... ok
[INFO] [stdout] test cli::tests::int_coverage_returns_float ... ok
[INFO] [stdout] test cli::tests::invalid_coverage_given_raises_error ... ok
[INFO] [stdout] test cli::tests::int_and_tera_suffix_returns_multiplied_int ... ok
[INFO] [stdout] test cli::tests::int_and_base_suffix_returns_int_without_scaling ... ok
[INFO] [stdout] test cli::tests::no_coverage_given_raises_error ... ok
[INFO] [stdout] test cli::tests::tera_suffix_from_string ... ok
[INFO] [stdout] test cli::tests::no_args_given_raises_error ... ok
[INFO] [stdout] test cli::tests::test_in_compress_range ... ok
[INFO] [stdout] test cli::tests::no_genome_size_given_raises_error ... ok
[INFO] [stdout] test cli::tests::multiply_coverage_by_genome_size ... ok
[INFO] [stdout] test fastx::tests::filter_reads_empty_indices_no_output ... ok
[INFO] [stdout] test fastx::tests::filter_fasta_reads_one_index_out_of_range ... ok
[INFO] [stdout] test fastx::tests::get_read_lengths_for_empty_fasta_returns_empty_vector ... ok
[INFO] [stdout] test subsampler::tests::subsample_three_lengths_all_greater_than_target_returns_two ... ok
[INFO] [stdout] test subsampler::tests::subsample_three_lengths_sum_greater_than_target_returns_two ... ok
[INFO] [stdout] test fastx::tests::filter_fastq_reads_two_indices_matches_first_and_last_reads ... ok
[INFO] [stdout] test subsampler::tests::shuffled_indices_with_seed_produces_same_ordering ... ok
[INFO] [stdout] test cli::tests::no_input_file_given_raises_error ... ok
[INFO] [stdout] test fastx::tests::get_read_lengths_for_fasta ... ok
[INFO] [stdout] test fastx::tests::create_invalid_output_file_raises_error ... ok
[INFO] [stdout] test fastx::tests::fastx_from_fasta ... ok
[INFO] [stdout] test fastx::tests::create_valid_output_file_and_can_write_to_it ... ok
[INFO] [stdout] test fastx::tests::filter_fasta_reads_one_index_matches_only_read ... ok
[INFO] [stdout] test subsampler::tests::subsample_one_length_target_zero_returns_empty ... ok
[INFO] [stdout] test fastx::tests::get_read_lengths_for_fastq ... ok
[INFO] [stdout] test subsampler::tests::subsample_one_length_greater_than_target_returns_zero ... ok
[INFO] [stdout] test cli::tests::invalid_genome_size_given_raises_error ... ok
[INFO] [stdout] test subsampler::tests::subsample_empty_lengths_returns_empty ... ok
[INFO] [stdout] test subsampler::tests::shuffled_indices_for_vector_len_one_returns_zero ... ok
[INFO] [stdout] test subsampler::tests::subsample_one_length_less_than_target_returns_zero ... ok
[INFO] [stdout] test subsampler::tests::shuffled_indices_for_vector_len_two_does_shuffle ... ok
[INFO] [stdout] test subsampler::tests::shuffled_indices_for_empty_vector_returns_empty ... ok
[INFO] [stdout] test subsampler::tests::subsample_three_lengths_sum_less_than_target_returns_three ... ok
[INFO] [stdout] test subsampler::tests::subsample_three_lengths_sum_equal_target_returns_three ... ok
[INFO] [stdout] test cli::tests::multiply_genome_size_by_coverage ... ok
[INFO] [stdout] test cli::tests::non_number_coverage_returns_err ... ok
[INFO] [stdout] test cli::tests::integer_only_returns_integer ... ok
[INFO] [stdout] test fastx::tests::filter_fastq_reads_one_index_out_of_range ... ok
[INFO] [stdout] test cli::tests::no_genome_size_or_coverage_given_but_bases_given ... ok
[INFO] [stdout] test fastx::tests::create_valid_compressed_output_file_and_can_write_to_it ... ok
[INFO] [stdout] test fastx::tests::filter_fastq_reads_one_index_matches_only_read ... ok
[INFO] [stdout] test fastx::tests::filter_fastq_reads_one_index_matches_one_of_two_reads ... ok
[INFO] [stdout] test cli::tests::float_only_returns_integer ... ok
[INFO] [stdout] test cli::tests::invalid_seed_given_raises_error ... ok
[INFO] [stdout] test cli::tests::float_and_suffix_returns_multiplied_float_as_int ... ok
[INFO] [stdout] test cli::tests::empty_string_returns_error ... ok
[INFO] [stdout] test cli::tests::zero_coverage_returns_zero ... ok
[INFO] [stdout] test cli::tests::suffix_with_no_size_returns_error ... ok
[INFO] [stdout] test cli::tests::genome_size_from_str_fastq_index ... ok
[INFO] [stdout] test cli::tests::float_without_leading_int_and_suffix_returns_multiplied_float_as_int ... ok
[INFO] [stdout] test cli::tests::invalid_suffix_returns_err ... ok
[INFO] [stdout] test cli::tests::all_valid_args_with_two_inputs_parsed_as_expected ... ok
[INFO] [stdout] test cli::tests::faidx_given_as_genome_size ... ok
[INFO] [stdout] test cli::tests::two_input_two_outputs_is_ok ... ok
[INFO] [stdout] test cli::tests::all_valid_args_with_two_inputs_using_flag_twice_parsed_as_expected ... ok
[INFO] [stdout] test cli::tests::int_and_suffix_returns_multiplied_int ... ok
[INFO] [stdout] test cli::tests::all_valid_args_parsed_as_expected ... ok
[INFO] [stdout] test cli::tests::three_inputs_raises_error ... ok
[INFO] [stdout] test cli::tests::one_input_two_outputs_raises_error ... ok
[INFO] [stdout] test cli::tests::no_genome_size_but_bases ... ok
[INFO] [stdout] test cli::tests::bases_and_coverage_and_genome_size_all_llowed ... ok
[INFO] [stdout] test cli::tests::one_input_no_output_is_ok ... ok
[INFO] [stdout] test cli::tests::three_outputs_raises_error ... ok
[INFO] [stdout] test cli::tests::two_inputs_one_output_raises_error ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 80 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.51s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running tests/main.rs (/opt/rustwide/target/debug/deps/main-8958fef7c686388f)
[INFO] [stdout] running 7 tests
[INFO] [stdout] test invalid_input_and_output_combination_raises_error ... ok
[INFO] [stdout] test unequal_number_of_reads_raises_error ... ok
[INFO] [stdout] test valid_inputs_raises_no_errors ... ok
[INFO] [stdout] test output_file_in_nonexistant_dir ... ok
[INFO] [stdout] test input_file_doesnt_exist ... ok
[INFO] [stdout] test input_and_output_filetypes_different_raises_no_errors ... ok
[INFO] [stdout] test two_valid_illumina_inputs_suceeds ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 11.44s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "7e938558dafa80920d2a16ca165b5b39647ae0cd22fc164446efb5f9cd265366", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7e938558dafa80920d2a16ca165b5b39647ae0cd22fc164446efb5f9cd265366", kill_on_drop: false }`
[INFO] [stdout] 7e938558dafa80920d2a16ca165b5b39647ae0cd22fc164446efb5f9cd265366