[INFO] fetching crate debruijn 0.3.4...
[INFO] testing debruijn-0.3.4 against 1.69.0 for beta-1.70-1
[INFO] extracting crate debruijn 0.3.4 into /workspace/builds/worker-0-tc1/source
[INFO] validating manifest of crates.io crate debruijn 0.3.4 on toolchain 1.69.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.69.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate debruijn 0.3.4
[INFO] finished tweaking crates.io crate debruijn 0.3.4
[INFO] tweaked toml for crates.io crate debruijn 0.3.4 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" __CARGO_TEST_CHANNEL_OVERRIDE_DO_NOT_USE_THIS="nightly" "/workspace/cargo-home/bin/cargo" "+1.69.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.69.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded boomphf v0.5.9
[INFO] [stderr]   Downloaded wyhash v0.5.0
[INFO] [stderr]   Downloaded pretty_assertions v0.5.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 8a255809ece37a69f254211c6d7754685ac95bc071d1c00eb97f93ec2fb95c3e
[INFO] running `Command { std: "docker" "start" "-a" "8a255809ece37a69f254211c6d7754685ac95bc071d1c00eb97f93ec2fb95c3e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8a255809ece37a69f254211c6d7754685ac95bc071d1c00eb97f93ec2fb95c3e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8a255809ece37a69f254211c6d7754685ac95bc071d1c00eb97f93ec2fb95c3e", kill_on_drop: false }`
[INFO] [stdout] 8a255809ece37a69f254211c6d7754685ac95bc071d1c00eb97f93ec2fb95c3e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] dc71e76d41be5222b4737f7f31fd53e5da00970dc948c2dc5567813f2e486468
[INFO] running `Command { std: "docker" "start" "-a" "dc71e76d41be5222b4737f7f31fd53e5da00970dc948c2dc5567813f2e486468", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling crossbeam-utils v0.8.15
[INFO] [stderr]    Compiling memoffset v0.8.0
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.14
[INFO] [stderr]    Compiling rayon-core v1.11.0
[INFO] [stderr]    Compiling either v1.8.1
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling bit-vec v0.6.3
[INFO] [stderr]    Compiling num_cpus v1.15.0
[INFO] [stderr]    Compiling wyhash v0.5.0
[INFO] [stderr]    Compiling itertools v0.10.5
[INFO] [stderr]    Compiling bit-set v0.5.3
[INFO] [stderr]    Compiling crossbeam-channel v0.5.8
[INFO] [stderr]    Compiling crossbeam-deque v0.8.3
[INFO] [stderr]    Compiling rayon v1.7.0
[INFO] [stderr]    Compiling boomphf v0.5.9
[INFO] [stderr]    Compiling debruijn v0.3.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.59s
[INFO] running `Command { std: "docker" "inspect" "dc71e76d41be5222b4737f7f31fd53e5da00970dc948c2dc5567813f2e486468", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dc71e76d41be5222b4737f7f31fd53e5da00970dc948c2dc5567813f2e486468", kill_on_drop: false }`
[INFO] [stdout] dc71e76d41be5222b4737f7f31fd53e5da00970dc948c2dc5567813f2e486468
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e8f94dd5b810eaed93437b4d9dfd2554c57b1e3914ae928650213c1e19739498
[INFO] running `Command { std: "docker" "start" "-a" "e8f94dd5b810eaed93437b4d9dfd2554c57b1e3914ae928650213c1e19739498", kill_on_drop: false }`
[INFO] [stderr]    Compiling rand_core v0.4.2
[INFO] [stderr]    Compiling difference v2.0.0
[INFO] [stderr]    Compiling pretty_assertions v0.5.1
[INFO] [stderr]    Compiling rand_core v0.3.1
[INFO] [stderr]    Compiling rand v0.5.6
[INFO] [stderr]    Compiling debruijn v0.3.4 (/opt/rustwide/workdir)
[INFO] [stdout] warning: use of deprecated function `msp::simple_scan`: Please use the `Scanner` type instead 
[INFO] [stdout]    --> src/msp.rs:394:33
[INFO] [stdout]     |
[INFO] [stdout] 394 |             let slices = super::simple_scan::<_, Kmer8>(k, &DnaSlice(&dna), &permutation, true);
[INFO] [stdout]     |                                 ^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(deprecated)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated function `msp::simple_scan`: Please use the `Scanner` type instead 
[INFO] [stdout]    --> src/msp.rs:586:25
[INFO] [stdout]     |
[INFO] [stdout] 586 |         let s1 = super::simple_scan::<_, Kmer5>(35, &DnaSlice(&mut &v1), &permutation, true);
[INFO] [stdout]     |                         ^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated function `msp::simple_scan`: Please use the `Scanner` type instead 
[INFO] [stdout]    --> src/msp.rs:587:25
[INFO] [stdout]     |
[INFO] [stdout] 587 |         let s2 = super::simple_scan::<_, Kmer5>(35, &DnaSlice(&mut &v2), &permutation, true);
[INFO] [stdout]     |                         ^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 3 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 4.73s
[INFO] running `Command { std: "docker" "inspect" "e8f94dd5b810eaed93437b4d9dfd2554c57b1e3914ae928650213c1e19739498", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e8f94dd5b810eaed93437b4d9dfd2554c57b1e3914ae928650213c1e19739498", kill_on_drop: false }`
[INFO] [stdout] e8f94dd5b810eaed93437b4d9dfd2554c57b1e3914ae928650213c1e19739498
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 383aa8139427bff0c3057cbf625faad076d8bbeebf3afba442dfd8cd033cdfc1
[INFO] running `Command { std: "docker" "start" "-a" "383aa8139427bff0c3057cbf625faad076d8bbeebf3afba442dfd8cd033cdfc1", kill_on_drop: false }`
[INFO] [stderr] warning: use of deprecated function `msp::simple_scan`: Please use the `Scanner` type instead 
[INFO] [stderr]    --> src/msp.rs:394:33
[INFO] [stderr]     |
[INFO] [stderr] 394 |             let slices = super::simple_scan::<_, Kmer8>(k, &DnaSlice(&dna), &permutation, true);
[INFO] [stderr]     |                                 ^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(deprecated)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated function `msp::simple_scan`: Please use the `Scanner` type instead 
[INFO] [stderr]    --> src/msp.rs:586:25
[INFO] [stderr]     |
[INFO] [stderr] 586 |         let s1 = super::simple_scan::<_, Kmer5>(35, &DnaSlice(&mut &v1), &permutation, true);
[INFO] [stderr]     |                         ^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated function `msp::simple_scan`: Please use the `Scanner` type instead 
[INFO] [stderr]    --> src/msp.rs:587:25
[INFO] [stderr]     |
[INFO] [stderr] 587 |         let s2 = super::simple_scan::<_, Kmer5>(35, &DnaSlice(&mut &v2), &permutation, true);
[INFO] [stderr]     |                         ^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `debruijn` (lib test) generated 3 warnings
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/debruijn-9aaf011d764c9c3a)
[INFO] [stdout] 
[INFO] [stdout] running 52 tests
[INFO] [stdout] test bitops_avx2::test::test_convert_bytes_for_debug ... ok
[INFO] [stdout] test dna_string::tests::test_dna_string ... ok
[INFO] [stdout] test dna_string::tests::dnastringslice_get_kmer ... ok
[INFO] [stdout] test dna_string::tests::dnastringslice_slice ... ok
[INFO] [stdout] test dna_string::tests::test_kmers_too_short ... ok
[INFO] [stdout] test dna_string::tests::test_from_dna_string ... ok
[INFO] [stdout] test dna_string::tests::test_ndiffs ... ok
[INFO] [stdout] test dna_string::tests::test_kmers ... ok
[INFO] [stdout] test dna_string::tests::test_prefix ... ok
[INFO] [stdout] test dna_string::tests::test_reverse ... ok
[INFO] [stdout] test dna_string::tests::test_suffix ... ok
[INFO] [stdout] test dna_string::tests::test_push_bytes ... ok
[INFO] [stdout] test bitops_avx2::test::test_invalid_bases ... ok
[INFO] [stdout] test bitops_avx2::test::test_convert_bytes_random ... ok
[INFO] [stdout] test kmer::tests::test_kmer_5 ... ok
[INFO] [stdout] test kmer::tests::test_kmer_4 ... ok
[INFO] [stdout] test kmer::tests::test_kmer_10 ... ok
[INFO] [stdout] test kmer::tests::test_kmer_12 ... ok
[INFO] [stdout] test kmer::tests::test_kmer_6 ... ok
[INFO] [stdout] test kmer::tests::test_kmer_16 ... ok
[INFO] [stdout] test kmer::tests::test_kmer_14 ... ok
[INFO] [stdout] test kmer::tests::test_kmer_8 ... ok
[INFO] [stdout] test msp::tests::test1 ... ok
[INFO] [stdout] test kmer::tests::test_kmer_15 ... ok
[INFO] [stdout] test msp::tests::test_sample ... ok
[INFO] [stdout] test kmer::tests::test_kmer_20 ... ok
[INFO] [stdout] test neighbors::test::test_hd1 ... ok
[INFO] [stdout] test msp::tests::test_slice ... ok
[INFO] [stdout] test kmer::tests::test_kmer_24 ... ok
[INFO] [stdout] test kmer::tests::test_kmer_32 ... ok
[INFO] [stdout] test kmer::tests::test_lmer_1_kmer_24 ... ok
[INFO] [stdout] test test::tests::degen_seq_asm ... ok
[INFO] [stdout] test kmer::tests::test_lmer_1_kmer_20 ... ok
[INFO] [stdout] test test::tests::degen_seq_asm_sharded ... ok
[INFO] [stdout] test kmer::tests::test_lmer_1_kmer_16 ... ok
[INFO] [stdout] test test::tests::simple_kmer_compress ... ok
[INFO] [stdout] test kmer::tests::test_kmer_31 ... ok
[INFO] [stdout] test test::tests::simple_path_compress ... ok
[INFO] [stdout] test test::tests::simple_sharded ... ok
[INFO] [stdout] test test::tests::simple_tip_clean ... ok
[INFO] [stdout] test kmer::tests::test_kmer_48 ... ok
[INFO] [stdout] test kmer::tests::test_kmer_64 ... ok
[INFO] [stdout] test kmer::tests::test_lmer_2_kmer_32 ... ok
[INFO] [stdout] test kmer::tests::test_lmer_3_kmer_32 ... ok
[INFO] [stdout] test kmer::tests::test_lmer_3_kmer_48 ... ok
[INFO] [stdout] test kmer::tests::test_lmer_3_kmer_64 ... ok
[INFO] [stdout] test dna_string::tests::test_slice_hamming_dist ... ok
[INFO] [stdout] test test::tests::complex_path_compress ... ok
[INFO] [stdout] test test::tests::complex_sharded ... ok
[INFO] [stdout] test test::tests::complex_kmer_compress ... ok
[INFO] [stdout] test test::tests::complex_path_compress_k31 ... ok
[INFO] [stdout] test msp::tests::test_msp_scanner has been running for over 60 seconds
[ERROR] error running command: no output for 300 seconds
[INFO] running `Command { std: "docker" "inspect" "383aa8139427bff0c3057cbf625faad076d8bbeebf3afba442dfd8cd033cdfc1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "383aa8139427bff0c3057cbf625faad076d8bbeebf3afba442dfd8cd033cdfc1", kill_on_drop: false }`
[INFO] [stdout] 383aa8139427bff0c3057cbf625faad076d8bbeebf3afba442dfd8cd033cdfc1
