[INFO] cloning repository https://github.com/anergictcell/atg
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/anergictcell/atg" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fanergictcell%2Fatg", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fanergictcell%2Fatg'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] d7e1d9d0a2a02548948702e110ee8639db57a18f
[INFO] testing anergictcell/atg against 1.59.0 for beta-1.60-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fanergictcell%2Fatg" "/workspace/builds/worker-55/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-55/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/anergictcell/atg on toolchain 1.59.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/anergictcell/atg
[INFO] finished tweaking git repo https://github.com/anergictcell/atg
[INFO] tweaked toml for git repo https://github.com/anergictcell/atg written to /workspace/builds/worker-55/source/Cargo.toml
[INFO] crate git repo https://github.com/anergictcell/atg already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] d6d9db3b60e5964727f26b5a7a13c56c20ad4a61e226b06ab24e9e377445e445
[INFO] running `Command { std: "docker" "start" "-a" "d6d9db3b60e5964727f26b5a7a13c56c20ad4a61e226b06ab24e9e377445e445", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d6d9db3b60e5964727f26b5a7a13c56c20ad4a61e226b06ab24e9e377445e445", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d6d9db3b60e5964727f26b5a7a13c56c20ad4a61e226b06ab24e9e377445e445", kill_on_drop: false }`
[INFO] [stdout] d6d9db3b60e5964727f26b5a7a13c56c20ad4a61e226b06ab24e9e377445e445
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e0ff8b62a0f9312576f58d00cc301855b50e29c484300f7adecb2aa62c05f86b
[INFO] running `Command { std: "docker" "start" "-a" "e0ff8b62a0f9312576f58d00cc301855b50e29c484300f7adecb2aa62c05f86b", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libc v0.2.102
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling ansi_term v0.12.1
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling clap v2.33.3
[INFO] [stderr]    Compiling loggerv v0.7.2
[INFO] [stderr]    Compiling atg v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 57.71s
[INFO] running `Command { std: "docker" "inspect" "e0ff8b62a0f9312576f58d00cc301855b50e29c484300f7adecb2aa62c05f86b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e0ff8b62a0f9312576f58d00cc301855b50e29c484300f7adecb2aa62c05f86b", kill_on_drop: false }`
[INFO] [stdout] e0ff8b62a0f9312576f58d00cc301855b50e29c484300f7adecb2aa62c05f86b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 772234bd8ca5c549d6af793e85ba54a0dd6f16e9714311344cc34d199f445f9b
[INFO] running `Command { std: "docker" "start" "-a" "772234bd8ca5c549d6af793e85ba54a0dd6f16e9714311344cc34d199f445f9b", kill_on_drop: false }`
[INFO] [stderr]    Compiling atg v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.18s
[INFO] running `Command { std: "docker" "inspect" "772234bd8ca5c549d6af793e85ba54a0dd6f16e9714311344cc34d199f445f9b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "772234bd8ca5c549d6af793e85ba54a0dd6f16e9714311344cc34d199f445f9b", kill_on_drop: false }`
[INFO] [stdout] 772234bd8ca5c549d6af793e85ba54a0dd6f16e9714311344cc34d199f445f9b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 049cca97d1cade8135a855bbb91539a2e84b34b173e0a1c078ab4fff71a816b5
[INFO] running `Command { std: "docker" "start" "-a" "049cca97d1cade8135a855bbb91539a2e84b34b173e0a1c078ab4fff71a816b5", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.13s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/atg-ed17ecab8999557e)
[INFO] [stdout] running 66 tests
[INFO] [stdout] test gtf::reader::test_ighm::test_read ... ok
[INFO] [stdout] test gtf::reader::test_nm_001385228::test_read ... ok
[INFO] [stdout] test gtf::reader::tests::test_nm_001365057 ... ok
[INFO] [stdout] test gtf::reader::test_nm_201550::test_read ... ok
[INFO] [stdout] test gtf::reader::tests::test_nm_001365408 ... ok
[INFO] [stdout] test gtf::reader::tests::test_nm_001371720 ... ok
[INFO] [stdout] test gtf::reader::tests::test_nm_201550 ... ok
[INFO] [stdout] test gtf::record::tests::test_attributes_parsing ... ok
[INFO] [stdout] test models::test_start_codon::case_1 ... ok
[INFO] [stdout] test models::test_codon::test_codon_builder ... ok
[INFO] [stdout] test gtf::writer::tests::test_nm_001365408 ... ok
[INFO] [stdout] test models::test_start_codon::case_3 ... ok
[INFO] [stdout] test gtf::writer::tests::test_nm_201550 ... ok
[INFO] [stdout] test models::test_start_codon::case_2 ... ok
[INFO] [stdout] test gtf::record::tests::test_single_attribute_parsing ... ok
[INFO] [stdout] test models::test_start_codon::case_4 ... ok
[INFO] [stdout] test gtf::writer::tests::test_nm_001365057 ... ok
[INFO] [stdout] test gtf::writer::tests::test_nm_001371720 ... ok
[INFO] [stdout] test models::test_start_codon::case_5 ... ok
[INFO] [stdout] test models::test_stop_codon::case_1 ... ok
[INFO] [stdout] test models::test_stop_codon::case_2 ... ok
[INFO] [stdout] test models::test_stop_codon::case_4 ... ok
[INFO] [stdout] test models::test_stop_codon::case_6 ... ok
[INFO] [stdout] test models::test_stop_codon::case_5 ... ok
[INFO] [stdout] test models::tests::test_frame_addition ... ok
[INFO] [stdout] test models::tests::test_special_transcripts ... ok
[INFO] [stdout] test models::tests::test_transcript ... ok
[INFO] [stdout] test refgene::reader::tests::test_missing_exon_start ... ok
[INFO] [stdout] test refgene::reader::tests::test_missing_exon_stop ... ok
[INFO] [stdout] test refgene::reader::tests::test_nm_001365057 ... ok
[INFO] [stdout] test refgene::reader::tests::test_nm_001365408 ... ok
[INFO] [stdout] test refgene::reader::tests::test_parse_exons_no_cds ... ok
[INFO] [stdout] test refgene::reader::tests::test_missing_exon_frame ... ok
[INFO] [stdout] test refgene::reader::tests::test_nm_001371720 ... ok
[INFO] [stdout] test refgene::reader::tests::test_wrong_exon_frame ... ok
[INFO] [stdout] test refgene::tests::test_parse_exons_with_cds ... ok
[INFO] [stdout] test refgene::tests::test_parsing_and_composing ... ok
[INFO] [stdout] test models::tests::test_exon_downstream_frame ... ok
[INFO] [stdout] test models::test_start_codon::case_6 ... ok
[INFO] [stdout] test refgene::tests::test_transcript_building ... ok
[INFO] [stdout] test refgene::reader::tests::test_nm_201550 ... ok
[INFO] [stdout] test refgene::writer::tests::test_nm_001365408 ... ok
[INFO] [stdout] test utils::genomic_relations::test_intersect::test_a_fully_in_b ... ok
[INFO] [stdout] test utils::genomic_relations::test_intersect::test_b_fully_in_a ... ok
[INFO] [stdout] test utils::genomic_relations::test_intersect::test_left_overlap ... ok
[INFO] [stdout] test utils::genomic_relations::test_intersect::test_no_overlap ... ok
[INFO] [stdout] test models::test_stop_codon::case_3 ... ok
[INFO] [stdout] test refgene::writer::tests::test_nm_001365057 ... ok
[INFO] [stdout] test utils::genomic_relations::test_intersect::test_right_overlap ... ok
[INFO] [stdout] test utils::genomic_relations::test_overlap::test_cds_overlap ... ok
[INFO] [stdout] test utils::genomic_relations::test_relation::test_downstream ... ok
[INFO] [stdout] test utils::genomic_relations::test_relation::test_inside ... ok
[INFO] [stdout] test utils::genomic_relations::test_relation::test_left ... ok
[INFO] [stdout] test utils::genomic_relations::test_relation::test_match ... ok
[INFO] [stdout] test utils::genomic_relations::test_relation::test_overlaps ... ok
[INFO] [stdout] test refgene::writer::tests::test_nm_001371720 ... ok
[INFO] [stdout] test refgene::writer::tests::test_nm_201550 ... ok
[INFO] [stdout] test utils::genomic_relations::test_relation::test_right ... ok
[INFO] [stdout] test utils::genomic_relations::test_relation::test_upstream ... ok
[INFO] [stdout] test utils::genomic_relations::test_subtraction::test_case_1 ... ok
[INFO] [stdout] test utils::genomic_relations::test_subtraction::test_case_2 ... ok
[INFO] [stdout] test utils::genomic_relations::test_subtraction::test_case_3 ... ok
[INFO] [stdout] test utils::genomic_relations::test_subtraction::test_case_5 ... ok
[INFO] [stdout] test utils::genomic_relations::test_subtraction::test_case_7 ... ok
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/atg-250738c6c71ce565)
[INFO] [stdout] test utils::genomic_relations::test_subtraction::test_case_4 ... ok
[INFO] [stdout] test utils::genomic_relations::test_subtraction::test_case_6 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 66 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests atg
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 33 tests
[INFO] [stdout] test src/lib.rs - (line 55) - compile ... ok
[INFO] [stdout] test src/gtf/record.rs - gtf::record::GtfRecordBuilder (line 365) ... ok
[INFO] [stdout] test src/models/exon.rs - models::exon::Exon::is_coding (line 124) ... ok
[INFO] [stdout] test src/models/transcript.rs - models::transcript::TranscriptBuilder::new (line 365) ... ok
[INFO] [stdout] test src/utils/genomic_relations.rs - utils::genomic_relations::union (line 66) ... ok
[INFO] [stdout] test src/models/transcripts.rs - models::transcripts::Transcripts::push (line 125) ... ok
[INFO] [stdout] test src/utils/genomic_relations.rs - utils::genomic_relations::relation (line 142) ... ok
[INFO] [stdout] test src/models/frame.rs - models::frame::Frame::to_refgene (line 127) ... ok
[INFO] [stdout] test src/models/exon.rs - models::exon::Exon::new (line 38) ... ok
[INFO] [stdout] test src/gtf/writer.rs - gtf::writer::Writer (line 17) ... ok
[INFO] [stdout] test src/models/utils.rs - models::utils::Strand (line 57) ... ok
[INFO] [stdout] test src/models/transcripts.rs - models::transcripts::Transcripts::by_gene (line 94) ... ok
[INFO] [stdout] test src/models/transcript.rs - models::transcript::TranscriptBuilder (line 329) ... ok
[INFO] [stdout] test src/models/frame.rs - models::frame::Frame::from_gtf (line 65) ... ok
[INFO] [stdout] test src/models/utils.rs - models::utils::parse_chrom (line 136) ... ok
[INFO] [stdout] test src/refgene/reader.rs - refgene::reader::Reader (line 26) ... ok
[INFO] [stdout] test src/models/frame.rs - models::frame::Frame::from_refgene (line 84) ... ok
[INFO] [stdout] test src/refgene/reader.rs - refgene::reader::Reader<R>::transcripts (line 131) ... ok
[INFO] [stdout] test src/models/transcripts.rs - models::transcripts::Transcripts::by_name (line 63) ... ok
[INFO] [stdout] test src/models/exon.rs - models::exon::Exon (line 10) ... ok
[INFO] [stdout] test src/utils/genomic_relations.rs - utils::genomic_relations::intersect (line 42) ... ok
[INFO] [stdout] test src/models/frame.rs - models::frame::Frame (line 15) ... ok
[INFO] [stdout] test src/refgene/writer.rs - refgene::writer::Writer (line 14) ... ok
[INFO] [stdout] test src/utils/genomic_relations.rs - utils::genomic_relations::subtract (line 91) ... ok
[INFO] [stdout] test src/gtf/reader.rs - gtf::reader::Reader (line 22) ... ok
[INFO] [stdout] test src/models/frame.rs - models::frame::Frame::to_gtf (line 108) ... ok
[INFO] [stdout] test src/gtf/reader.rs - gtf::reader::Reader<File>::from_file (line 50) ... ok
[INFO] [stdout] test src/gtf/reader.rs - gtf::reader::Reader<R>::transcripts (line 126) ... ok
[INFO] [stdout] test src/models/transcripts.rs - models::transcripts::Transcripts (line 11) ... ok
[INFO] [stdout] test src/refgene/reader.rs - refgene::reader::Reader<File>::from_file (line 54) ... ok
[INFO] [stdout] test src/bed/writer.rs - bed::writer::Writer (line 14) ... ok
[INFO] [stdout] test src/utils/genomic_relations.rs - utils::genomic_relations::exon_cds_overlap (line 171) ... ok
[INFO] [stdout] test src/models/codon.rs - models::codon::Codon::from_transcript (line 41) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 33 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.94s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "049cca97d1cade8135a855bbb91539a2e84b34b173e0a1c078ab4fff71a816b5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "049cca97d1cade8135a855bbb91539a2e84b34b173e0a1c078ab4fff71a816b5", kill_on_drop: false }`
[INFO] [stdout] 049cca97d1cade8135a855bbb91539a2e84b34b173e0a1c078ab4fff71a816b5