[INFO] fetching crate taskchampion 0.4.1... [INFO] testing taskchampion-0.4.1 against 1.59.0 for beta-1.60-1 [INFO] extracting crate taskchampion 0.4.1 into /workspace/builds/worker-0/source [INFO] validating manifest of crates.io crate taskchampion 0.4.1 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 crates.io crate taskchampion 0.4.1 [INFO] finished tweaking crates.io crate taskchampion 0.4.1 [INFO] tweaked toml for crates.io crate taskchampion 0.4.1 written to /workspace/builds/worker-0/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.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: "/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] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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] 45391ba2af044f29a64e3491dbf20b86934bb1f9474cfb629c1f0a8b6f8db541 [INFO] running `Command { std: "docker" "start" "-a" "45391ba2af044f29a64e3491dbf20b86934bb1f9474cfb629c1f0a8b6f8db541", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "45391ba2af044f29a64e3491dbf20b86934bb1f9474cfb629c1f0a8b6f8db541", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "45391ba2af044f29a64e3491dbf20b86934bb1f9474cfb629c1f0a8b6f8db541", kill_on_drop: false }` [INFO] [stdout] 45391ba2af044f29a64e3491dbf20b86934bb1f9474cfb629c1f0a8b6f8db541 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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] 4edec059e9a7908ba2856e2448bf9ee31ad1b3d67e3372c654fa4303e4844664 [INFO] running `Command { std: "docker" "start" "-a" "4edec059e9a7908ba2856e2448bf9ee31ad1b3d67e3372c654fa4303e4844664", kill_on_drop: false }` [INFO] [stderr] Compiling rustls v0.20.4 [INFO] [stderr] Compiling protobuf v2.27.1 [INFO] [stderr] Compiling tindercrypt v0.2.2 [INFO] [stderr] Compiling fallible-streaming-iterator v0.1.9 [INFO] [stderr] Compiling fallible-iterator v0.2.0 [INFO] [stderr] Compiling chunked_transfer v1.4.0 [INFO] [stderr] Compiling ring v0.16.20 [INFO] [stderr] Compiling ahash v0.7.6 [INFO] [stderr] Compiling libsqlite3-sys v0.22.2 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling rand v0.7.3 [INFO] [stderr] Compiling serde v1.0.136 [INFO] [stderr] Compiling hashbrown v0.11.2 [INFO] [stderr] Compiling hashlink v0.7.0 [INFO] [stderr] Compiling uuid v0.8.2 [INFO] [stderr] Compiling serde_json v1.0.79 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling webpki v0.22.0 [INFO] [stderr] Compiling sct v0.7.0 [INFO] [stderr] Compiling webpki-roots v0.22.2 [INFO] [stderr] Compiling ureq v2.4.0 [INFO] [stderr] Compiling rusqlite v0.25.4 [INFO] [stderr] Compiling taskchampion v0.4.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 11.33s [INFO] running `Command { std: "docker" "inspect" "4edec059e9a7908ba2856e2448bf9ee31ad1b3d67e3372c654fa4303e4844664", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "4edec059e9a7908ba2856e2448bf9ee31ad1b3d67e3372c654fa4303e4844664", kill_on_drop: false }` [INFO] [stdout] 4edec059e9a7908ba2856e2448bf9ee31ad1b3d67e3372c654fa4303e4844664 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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] 2d72e79d0d55e11f5669a164ffbcd08bc7ec28e91b5c2b51536052a8736fab8c [INFO] running `Command { std: "docker" "start" "-a" "2d72e79d0d55e11f5669a164ffbcd08bc7ec28e91b5c2b51536052a8736fab8c", kill_on_drop: false }` [INFO] [stderr] Compiling quick-error v2.0.1 [INFO] [stderr] Compiling rusty-fork v0.3.0 [INFO] [stderr] Compiling rand_xorshift v0.3.0 [INFO] [stderr] Compiling rstest v0.10.0 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling proptest v1.0.0 [INFO] [stderr] Compiling taskchampion v0.4.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 10.86s [INFO] running `Command { std: "docker" "inspect" "2d72e79d0d55e11f5669a164ffbcd08bc7ec28e91b5c2b51536052a8736fab8c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "2d72e79d0d55e11f5669a164ffbcd08bc7ec28e91b5c2b51536052a8736fab8c", kill_on_drop: false }` [INFO] [stdout] 2d72e79d0d55e11f5669a164ffbcd08bc7ec28e91b5c2b51536052a8736fab8c [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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] a8587fbb6ea5fece8a6ce1b48dafb9ad8602ad41838711dcede862c30c766cfe [INFO] running `Command { std: "docker" "start" "-a" "a8587fbb6ea5fece8a6ce1b48dafb9ad8602ad41838711dcede862c30c766cfe", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.06s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/taskchampion-dccb402aa86ed1ce) [INFO] [stdout] [INFO] [stdout] running 83 tests [INFO] [stdout] test replica::tests::get_does_not_exist ... ok [INFO] [stdout] test replica::tests::delete_task ... ok [INFO] [stdout] test replica::tests::new_task ... ok [INFO] [stdout] test replica::tests::new_pending_adds_to_working_set ... ok [INFO] [stdout] test replica::tests::modify_task ... ok [INFO] [stdout] test replica::tests::get_and_modify ... ok [INFO] [stdout] test storage::inmemory::test::add_to_working_set ... ok [INFO] [stdout] test storage::inmemory::test::clear_working_set ... ok [INFO] [stdout] test storage::inmemory::test::get_working_set_empty ... ok [INFO] [stdout] test storage::operation::test::test_related_updates_same_prop ... ok [INFO] [stdout] test storage::operation::test::test_unrelated_create ... ok [INFO] [stdout] test storage::operation::test::test_related_updates_different_props ... ok [INFO] [stdout] test storage::operation::test::test_related_updates_same_prop_same_time ... ok [INFO] [stdout] test task::priority::test::test_priority ... ok [INFO] [stdout] test task::status::test::test_status ... ok [INFO] [stdout] test task::tag::test::test_tag_try_into_err::case_2_colon_infix ... ok [INFO] [stdout] test task::tag::test::test_tag_try_into_err::case_3_digits ... ok [INFO] [stdout] test task::tag::test::test_tag_try_into_err::case_4_bangs ... ok [INFO] [stdout] test task::tag::test::test_tag_try_into_err::case_1_empty ... ok [INFO] [stdout] test task::tag::test::test_tag_try_into_err::case_5_no_such_synthetic ... ok [INFO] [stdout] test task::tag::test::test_tag_try_into_success::case_1_simple ... ok [INFO] [stdout] test task::tag::test::test_tag_try_into_success::case_2_colon_prefix ... ok [INFO] [stdout] test task::tag::test::test_tag_try_into_success::case_4_synthetic ... ok [INFO] [stdout] test task::tag::test::test_tag_try_into_success::case_3_letters_and_numbers ... ok [INFO] [stdout] test task::task::test::test_add_tags ... ok [INFO] [stdout] test task::task::test::test_done ... ok [INFO] [stdout] test task::task::test::test_get_tags ... ok [INFO] [stdout] test task::task::test::test_get_tags_invalid_tags ... ok [INFO] [stdout] test task::task::test::test_has_tag ... ok [INFO] [stdout] test task::task::test::test_is_active ... ok [INFO] [stdout] test task::task::test::test_is_active_never_started ... ok [INFO] [stdout] test task::task::test::test_is_active_stopped ... ok [INFO] [stdout] test task::task::test::test_wait_in_future ... ok [INFO] [stdout] test task::task::test::test_wait_not_set ... ok [INFO] [stdout] test task::task::test::test_wait_in_past ... ok [INFO] [stdout] test task::task::test::test_stop_multiple ... ok [INFO] [stdout] test taskdb::tests::test_apply_create_exists ... ok [INFO] [stdout] test task::task::test::test_start ... ok [INFO] [stdout] test taskdb::tests::test_apply_delete_not_present ... ok [INFO] [stdout] test task::task::test::test_remove_tags ... ok [INFO] [stdout] test taskdb::tests::rebuild_working_set_no_renumber ... ok [INFO] [stdout] test taskdb::tests::test_apply_create_delete ... ok [INFO] [stdout] test taskdb::tests::rebuild_working_set_renumber ... ok [INFO] [stdout] test taskdb::tests::test_apply_create ... ok [INFO] [stdout] test taskdb::tests::test_apply_update_does_not_exist ... ok [INFO] [stdout] test utils::test::test_from_bytes ... ok [INFO] [stdout] test task::task::test::test_stop ... ok [INFO] [stdout] test workingset::test::test_len_and_is_empty ... ok [INFO] [stdout] test workingset::test::test_new ... ok [INFO] [stdout] test taskdb::tests::test_sync_create_delete ... ok [INFO] [stdout] test taskdb::tests::test_apply_create_update_delete_prop ... ok [INFO] [stdout] test workingset::test::test_by_index ... ok [INFO] [stdout] test workingset::test::test_by_uuid ... ok [INFO] [stdout] test workingset::test::test_iter ... ok [INFO] [stdout] test taskdb::tests::test_apply_create_update ... ok [INFO] [stdout] test taskdb::tests::test_sync ... ok [INFO] [stdout] test utils::test::test_from_bytes_bad_len - should panic ... ok [INFO] [stdout] test server::local::test::test_empty ... ok [INFO] [stdout] test storage::sqlite::test::test_all_tasks_empty ... ok [INFO] [stdout] test server::local::test::test_add_nonzero_base ... ok [INFO] [stdout] test server::local::test::test_add_nonzero_base_forbidden ... ok [INFO] [stdout] test storage::sqlite::test::test_base_version_default ... ok [INFO] [stdout] test storage::sqlite::test::get_working_set_empty ... ok [INFO] [stdout] test storage::sqlite::test::test_delete_task_missing ... ok [INFO] [stdout] test storage::sqlite::test::test_get_missing ... ok [INFO] [stdout] test server::local::test::test_add_zero_base ... ok [INFO] [stdout] test storage::sqlite::test::add_to_working_set ... ok [INFO] [stdout] test storage::sqlite::test::drop_transaction ... ok [INFO] [stdout] test storage::sqlite::test::test_set_task ... ok [INFO] [stdout] test storage::sqlite::test::test_empty_dir ... ok [INFO] [stdout] test storage::sqlite::test::test_base_version_setting ... ok [INFO] [stdout] test storage::sqlite::test::test_create_exists ... ok [INFO] [stdout] test storage::sqlite::test::test_create ... ok [INFO] [stdout] test storage::sqlite::test::test_delete_task_exists ... ok [INFO] [stdout] test storage::sqlite::test::test_all_tasks_and_uuids ... ok [INFO] [stdout] test storage::sqlite::test::clear_working_set ... ok [INFO] [stdout] test storage::sqlite::test::test_operations ... ok [INFO] [stdout] test storage::sqlite::test::set_working_set_item ... ok [INFO] [stdout] test taskdb::tests::transform_sequences_of_operations ... ok [INFO] [stdout] test storage::operation::test::transform_invariant_holds ... ok [INFO] [stdout] test server::remote::crypto::test::round_trip ... ok [INFO] [stdout] test server::remote::crypto::test::round_trip_bad_key ... ok [INFO] [stdout] test server::remote::crypto::test::round_trip_bad_pvid ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 83 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.28s [INFO] [stdout] [INFO] [stderr] Doc-tests taskchampion [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] running `Command { std: "docker" "inspect" "a8587fbb6ea5fece8a6ce1b48dafb9ad8602ad41838711dcede862c30c766cfe", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a8587fbb6ea5fece8a6ce1b48dafb9ad8602ad41838711dcede862c30c766cfe", kill_on_drop: false }` [INFO] [stdout] a8587fbb6ea5fece8a6ce1b48dafb9ad8602ad41838711dcede862c30c766cfe