[INFO] fetching crate taskchampion 0.4.1... [INFO] testing taskchampion-0.4.1 against 1.60.0 for beta-1.61-1 [INFO] extracting crate taskchampion 0.4.1 into /workspace/builds/worker-58/source [INFO] validating manifest of crates.io crate taskchampion 0.4.1 on toolchain 1.60.0 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.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-58/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.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.60.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] [stderr] Downloading crates ... [INFO] [stderr] Downloaded rstest v0.10.0 [INFO] [stderr] Downloaded rusqlite v0.25.4 [INFO] [stderr] Downloaded tindercrypt v0.2.2 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-58/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-58/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" "+1.60.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 883fd49f4724f2cbdb80a3c2c2d1f89728b162d0e871753df0770dd89c0b8b4c [INFO] running `Command { std: "docker" "start" "-a" "883fd49f4724f2cbdb80a3c2c2d1f89728b162d0e871753df0770dd89c0b8b4c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "883fd49f4724f2cbdb80a3c2c2d1f89728b162d0e871753df0770dd89c0b8b4c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "883fd49f4724f2cbdb80a3c2c2d1f89728b162d0e871753df0770dd89c0b8b4c", kill_on_drop: false }` [INFO] [stdout] 883fd49f4724f2cbdb80a3c2c2d1f89728b162d0e871753df0770dd89c0b8b4c [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-58/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-58/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" "+1.60.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 7ed49fd27869f4cb9b24acf48a5e26c79868c2ef1e7678cf2e1efcee1f8ce75d [INFO] running `Command { std: "docker" "start" "-a" "7ed49fd27869f4cb9b24acf48a5e26c79868c2ef1e7678cf2e1efcee1f8ce75d", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.123 [INFO] [stderr] Compiling cc v1.0.73 [INFO] [stderr] Compiling once_cell v1.10.0 [INFO] [stderr] Compiling syn v1.0.91 [INFO] [stderr] Compiling autocfg v1.1.0 [INFO] [stderr] Compiling version_check v0.9.4 [INFO] [stderr] Compiling getrandom v0.1.16 [INFO] [stderr] Compiling log v0.4.16 [INFO] [stderr] Compiling crc32fast v1.3.2 [INFO] [stderr] Compiling pkg-config v0.3.25 [INFO] [stderr] Compiling ppv-lite86 v0.2.16 [INFO] [stderr] Compiling memchr v2.4.1 [INFO] [stderr] Compiling protobuf v2.27.1 [INFO] [stderr] Compiling rustls v0.20.4 [INFO] [stderr] Compiling anyhow v1.0.56 [INFO] [stderr] Compiling tindercrypt v0.2.2 [INFO] [stderr] Compiling fallible-streaming-iterator v0.1.9 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling fallible-iterator v0.2.0 [INFO] [stderr] Compiling chunked_transfer v1.4.0 [INFO] [stderr] Compiling strum v0.21.0 [INFO] [stderr] Compiling tinyvec v1.5.1 [INFO] [stderr] Compiling form_urlencoded v1.0.1 [INFO] [stderr] Compiling miniz_oxide v0.5.1 [INFO] [stderr] Compiling heck v0.3.3 [INFO] [stderr] Compiling ahash v0.7.6 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling ring v0.16.20 [INFO] [stderr] Compiling libsqlite3-sys v0.22.2 [INFO] [stderr] Compiling unicode-normalization v0.1.19 [INFO] [stderr] Compiling getrandom v0.2.6 [INFO] [stderr] Compiling flate2 v1.0.23 [INFO] [stderr] Compiling time v0.1.43 [INFO] [stderr] Compiling rand_core v0.5.1 [INFO] [stderr] Compiling idna v0.2.3 [INFO] [stderr] Compiling rand_chacha v0.2.2 [INFO] [stderr] Compiling hashbrown v0.11.2 [INFO] [stderr] Compiling url v2.2.2 [INFO] [stderr] Compiling rand v0.7.3 [INFO] [stderr] Compiling hashlink v0.7.0 [INFO] [stderr] Compiling serde_derive v1.0.136 [INFO] [stderr] Compiling thiserror-impl v1.0.30 [INFO] [stderr] Compiling strum_macros v0.21.1 [INFO] [stderr] Compiling webpki v0.22.0 [INFO] [stderr] Compiling sct v0.7.0 [INFO] [stderr] Compiling webpki-roots v0.22.3 [INFO] [stderr] Compiling thiserror v1.0.30 [INFO] [stderr] Compiling ureq v2.4.0 [INFO] [stderr] Compiling rusqlite v0.25.4 [INFO] [stderr] Compiling serde v1.0.136 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling uuid v0.8.2 [INFO] [stderr] Compiling serde_json v1.0.79 [INFO] [stderr] Compiling taskchampion v0.4.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 28.18s [INFO] running `Command { std: "docker" "inspect" "7ed49fd27869f4cb9b24acf48a5e26c79868c2ef1e7678cf2e1efcee1f8ce75d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "7ed49fd27869f4cb9b24acf48a5e26c79868c2ef1e7678cf2e1efcee1f8ce75d", kill_on_drop: false }` [INFO] [stdout] 7ed49fd27869f4cb9b24acf48a5e26c79868c2ef1e7678cf2e1efcee1f8ce75d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-58/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-58/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" "+1.60.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] dd105b7bb6c1b2b44b1e0068614cb2865d836b110c1c20a839c7c9fedd94f972 [INFO] running `Command { std: "docker" "start" "-a" "dd105b7bb6c1b2b44b1e0068614cb2865d836b110c1c20a839c7c9fedd94f972", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling ucd-trie v0.1.3 [INFO] [stderr] Compiling fastrand v1.7.0 [INFO] [stderr] Compiling quick-error v1.2.3 [INFO] [stderr] Compiling bit-vec v0.6.3 [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling quick-error v2.0.1 [INFO] [stderr] Compiling wait-timeout v0.2.0 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling pest v2.1.3 [INFO] [stderr] Compiling bit-set v0.5.2 [INFO] [stderr] Compiling tempfile v3.3.0 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling rand_xorshift v0.3.0 [INFO] [stderr] Compiling rusty-fork v0.3.0 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling semver-parser v0.10.2 [INFO] [stderr] Compiling semver v0.11.0 [INFO] [stderr] Compiling proptest v1.0.0 [INFO] [stderr] Compiling rustc_version v0.3.3 [INFO] [stderr] Compiling rstest v0.10.0 [INFO] [stderr] Compiling taskchampion v0.4.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 41.82s [INFO] running `Command { std: "docker" "inspect" "dd105b7bb6c1b2b44b1e0068614cb2865d836b110c1c20a839c7c9fedd94f972", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "dd105b7bb6c1b2b44b1e0068614cb2865d836b110c1c20a839c7c9fedd94f972", kill_on_drop: false }` [INFO] [stdout] dd105b7bb6c1b2b44b1e0068614cb2865d836b110c1c20a839c7c9fedd94f972 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-58/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-58/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" "+1.60.0" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 746cee03919b3096ce6fb1cd1514d577c3cf01875b915492c5e43f8e4a76d198 [INFO] running `Command { std: "docker" "start" "-a" "746cee03919b3096ce6fb1cd1514d577c3cf01875b915492c5e43f8e4a76d198", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 2.48s [INFO] [stdout] [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/taskchampion-87aed93cf07dd087) [INFO] [stdout] running 83 tests [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_does_not_exist ... 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_different_props ... 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_same_prop_same_time ... 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_5_no_such_synthetic ... 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_err::case_3_digits ... ok [INFO] [stdout] test task::tag::test::test_tag_try_into_err::case_4_bangs ... ok [INFO] [stdout] test task::priority::test::test_priority ... ok [INFO] [stdout] test task::tag::test::test_tag_try_into_err::case_1_empty ... ok [INFO] [stdout] test task::task::test::test_get_tags ... ok [INFO] [stdout] test task::task::test::test_has_tag ... 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_3_letters_and_numbers ... ok [INFO] [stdout] test task::task::test::test_is_active_never_started ... ok [INFO] [stdout] test task::task::test::test_get_tags_invalid_tags ... ok [INFO] [stdout] test task::task::test::test_done ... ok [INFO] [stdout] test task::task::test::test_add_tags ... ok [INFO] [stdout] test task::task::test::test_is_active ... ok [INFO] [stdout] test task::task::test::test_remove_tags ... ok [INFO] [stdout] test task::task::test::test_start ... ok [INFO] [stdout] test task::task::test::test_is_active_stopped ... ok [INFO] [stdout] test task::task::test::test_stop ... ok [INFO] [stdout] test task::task::test::test_stop_multiple ... 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 taskdb::tests::rebuild_working_set_renumber ... ok [INFO] [stdout] test taskdb::tests::rebuild_working_set_no_renumber ... ok [INFO] [stdout] test taskdb::tests::test_apply_create_update_delete_prop ... ok [INFO] [stdout] test taskdb::tests::test_apply_delete_not_present ... ok [INFO] [stdout] test taskdb::tests::test_sync ... ok [INFO] [stdout] test taskdb::tests::test_apply_create_exists ... ok [INFO] [stdout] test taskdb::tests::test_apply_create_delete ... 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 task::task::test::test_wait_in_past ... 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 utils::test::test_from_bytes ... ok [INFO] [stdout] test workingset::test::test_len_and_is_empty ... ok [INFO] [stdout] test taskdb::tests::test_sync_create_delete ... ok [INFO] [stdout] test workingset::test::test_new ... 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 server::local::test::test_add_nonzero_base_forbidden ... ok [INFO] [stdout] test server::local::test::test_add_nonzero_base ... ok [INFO] [stdout] test taskdb::tests::transform_sequences_of_operations ... ok [INFO] [stdout] test storage::sqlite::test::test_delete_task_missing ... ok [INFO] [stdout] test server::local::test::test_add_zero_base ... ok [INFO] [stdout] test storage::sqlite::test::get_working_set_empty ... ok [INFO] [stdout] test storage::sqlite::test::test_get_missing ... ok [INFO] [stdout] test storage::operation::test::transform_invariant_holds ... ok [INFO] [stdout] test storage::sqlite::test::test_base_version_default ... ok [INFO] [stdout] test storage::sqlite::test::test_all_tasks_empty ... ok [INFO] [stdout] test storage::sqlite::test::add_to_working_set ... ok [INFO] [stdout] test storage::sqlite::test::test_base_version_setting ... ok [INFO] [stdout] test storage::sqlite::test::test_delete_task_exists ... ok [INFO] [stdout] test storage::sqlite::test::drop_transaction ... ok [INFO] [stdout] test storage::sqlite::test::test_empty_dir ... ok [INFO] [stdout] test storage::sqlite::test::test_all_tasks_and_uuids ... ok [INFO] [stdout] test storage::sqlite::test::test_create_exists ... ok [INFO] [stdout] test storage::sqlite::test::test_set_task ... ok [INFO] [stdout] test storage::sqlite::test::test_create ... 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 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 3.30s [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" "746cee03919b3096ce6fb1cd1514d577c3cf01875b915492c5e43f8e4a76d198", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "746cee03919b3096ce6fb1cd1514d577c3cf01875b915492c5e43f8e4a76d198", kill_on_drop: false }` [INFO] [stdout] 746cee03919b3096ce6fb1cd1514d577c3cf01875b915492c5e43f8e4a76d198