[INFO] fetching crate taskchampion 0.3.0... [INFO] testing taskchampion-0.3.0 against 1.55.0 for beta-1.56-1 [INFO] extracting crate taskchampion 0.3.0 into /workspace/builds/worker-3/source [INFO] validating manifest of crates.io crate taskchampion 0.3.0 on toolchain 1.55.0 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.55.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate taskchampion 0.3.0 [INFO] finished tweaking crates.io crate taskchampion 0.3.0 [INFO] tweaked toml for crates.io crate taskchampion 0.3.0 written to /workspace/builds/worker-3/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.55.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.55.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 proptest v0.9.6 [INFO] [stderr] Downloaded kv v0.10.0 [INFO] [stderr] Downloaded lmdb-rkv v0.12.3 [INFO] [stderr] Downloaded lmdb-rkv-sys v0.9.6 [INFO] [stderr] Downloaded tindercrypt v0.2.2 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 5455f7a181187a53a9f34ec8f59bd9cf407f83ad130cbd2c065c16fda379ccc5 [INFO] running `Command { std: "docker" "start" "-a" "5455f7a181187a53a9f34ec8f59bd9cf407f83ad130cbd2c065c16fda379ccc5", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "5455f7a181187a53a9f34ec8f59bd9cf407f83ad130cbd2c065c16fda379ccc5", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "5455f7a181187a53a9f34ec8f59bd9cf407f83ad130cbd2c065c16fda379ccc5", kill_on_drop: false }` [INFO] [stdout] 5455f7a181187a53a9f34ec8f59bd9cf407f83ad130cbd2c065c16fda379ccc5 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 3cb3459371484be8fa992a5915ebbd003a85fe8ef37481be3491b063e4d5c05d [INFO] running `Command { std: "docker" "start" "-a" "3cb3459371484be8fa992a5915ebbd003a85fe8ef37481be3491b063e4d5c05d", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling protobuf v2.25.1 [INFO] [stderr] Compiling tindercrypt v0.2.2 [INFO] [stderr] Compiling ring v0.16.20 [INFO] [stderr] Compiling time v0.2.27 [INFO] [stderr] Compiling cookie v0.14.4 [INFO] [stderr] Compiling lmdb-rkv-sys v0.9.6 [INFO] [stderr] Compiling qstring v0.7.2 [INFO] [stderr] Compiling rmp v0.8.10 [INFO] [stderr] Compiling time-macros-impl v0.1.2 [INFO] [stderr] Compiling failure_derive v0.1.8 [INFO] [stderr] Compiling rand v0.7.3 [INFO] [stderr] Compiling serde_json v1.0.67 [INFO] [stderr] Compiling uuid v0.8.2 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling rmp-serde v0.14.4 [INFO] [stderr] Compiling time-macros v0.1.1 [INFO] [stderr] Compiling failure v0.1.8 [INFO] [stderr] Compiling lmdb-rkv v0.12.3 [INFO] [stderr] Compiling kv v0.10.0 [INFO] [stderr] Compiling cookie_store v0.12.0 [INFO] [stderr] Compiling webpki v0.21.4 [INFO] [stderr] Compiling sct v0.6.1 [INFO] [stderr] Compiling rustls v0.19.1 [INFO] [stderr] Compiling webpki-roots v0.21.1 [INFO] [stderr] Compiling ureq v1.5.5 [INFO] [stderr] Compiling taskchampion v0.3.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 23.34s [INFO] running `Command { std: "docker" "inspect" "3cb3459371484be8fa992a5915ebbd003a85fe8ef37481be3491b063e4d5c05d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3cb3459371484be8fa992a5915ebbd003a85fe8ef37481be3491b063e4d5c05d", kill_on_drop: false }` [INFO] [stdout] 3cb3459371484be8fa992a5915ebbd003a85fe8ef37481be3491b063e4d5c05d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 972ea9a1aa16a484c28e130d83581706dccd110a7138826df7cb2ede226da8a2 [INFO] running `Command { std: "docker" "start" "-a" "972ea9a1aa16a484c28e130d83581706dccd110a7138826df7cb2ede226da8a2", kill_on_drop: false }` [INFO] [stderr] Compiling bit-vec v0.6.3 [INFO] [stderr] Compiling rand v0.6.5 [INFO] [stderr] Compiling rusty-fork v0.2.2 [INFO] [stderr] Compiling bit-set v0.5.2 [INFO] [stderr] Compiling proptest v0.9.6 [INFO] [stderr] Compiling taskchampion v0.3.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 19.10s [INFO] running `Command { std: "docker" "inspect" "972ea9a1aa16a484c28e130d83581706dccd110a7138826df7cb2ede226da8a2", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "972ea9a1aa16a484c28e130d83581706dccd110a7138826df7cb2ede226da8a2", kill_on_drop: false }` [INFO] [stdout] 972ea9a1aa16a484c28e130d83581706dccd110a7138826df7cb2ede226da8a2 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 5fad6b1d0b607e114dc77103f994203801837de12acb3a3240fa3b425ab336f8 [INFO] running `Command { std: "docker" "start" "-a" "5fad6b1d0b607e114dc77103f994203801837de12acb3a3240fa3b425ab336f8", 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-c4e001d6a45cee39) [INFO] [stdout] [INFO] [stdout] running 68 tests [INFO] [stdout] test replica::tests::get_does_not_exist ... ok [INFO] [stdout] test replica::tests::delete_task ... ok [INFO] [stdout] test replica::tests::get_and_modify ... ok [INFO] [stdout] test replica::tests::modify_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 storage::inmemory::test::clear_working_set ... ok [INFO] [stdout] test storage::inmemory::test::add_to_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_related_updates_different_props ... ok [INFO] [stdout] test storage::operation::test::test_related_updates_same_prop_same_time ... ok [INFO] [stdout] test storage::operation::test::test_unrelated_create ... ok [INFO] [stdout] test task::test::test_is_active_never_started ... ok [INFO] [stdout] test task::test::test_is_active_stopped ... ok [INFO] [stdout] test task::test::test_get_tags ... ok [INFO] [stdout] test task::test::test_priority ... ok [INFO] [stdout] test task::test::test_has_tag ... ok [INFO] [stdout] test task::test::test_remove_tags ... ok [INFO] [stdout] test task::test::test_add_tags ... ok [INFO] [stdout] test task::test::test_status ... ok [INFO] [stdout] test task::test::test_is_active ... ok [INFO] [stdout] test task::test::test_start ... ok [INFO] [stdout] test taskdb::tests::rebuild_working_set_no_renumber ... ok [INFO] [stdout] test taskdb::tests::test_apply_create ... ok [INFO] [stdout] test task::test::test_stop ... ok [INFO] [stdout] test taskdb::tests::test_apply_create_delete ... ok [INFO] [stdout] test taskdb::tests::test_apply_create_update_delete_prop ... ok [INFO] [stdout] test taskdb::tests::rebuild_working_set_renumber ... ok [INFO] [stdout] test server::local::test::test_add_nonzero_base ... ok [INFO] [stdout] test task::test::test_stop_multiple ... ok [INFO] [stdout] test taskdb::tests::test_apply_create_update ... ok [INFO] [stdout] test utils::test::test_from_bytes ... 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 taskdb::tests::test_sync_create_delete ... ok [INFO] [stdout] test workingset::test::test_len_and_is_empty ... ok [INFO] [stdout] test taskdb::tests::test_sync ... ok [INFO] [stdout] test workingset::test::test_by_index ... ok [INFO] [stdout] test task::test::test_tag_from_str ... ok [INFO] [stdout] test taskdb::tests::test_apply_create_exists ... ok [INFO] [stdout] test taskdb::tests::test_apply_update_does_not_exist ... ok [INFO] [stdout] test workingset::test::test_new ... ok [INFO] [stdout] test taskdb::tests::test_apply_delete_not_present ... ok [INFO] [stdout] test task::test::test_get_tags_invalid_tags ... ok [INFO] [stdout] test workingset::test::test_iter ... ok [INFO] [stdout] test server::local::test::test_add_zero_base ... ok [INFO] [stdout] test storage::kv::test::test_all_tasks_empty ... ok [INFO] [stdout] test storage::kv::test::test_base_version_default ... ok [INFO] [stdout] test storage::kv::test::clear_working_set ... ok [INFO] [stdout] test storage::kv::test::test_get_missing ... ok [INFO] [stdout] test workingset::test::test_by_uuid ... ok [INFO] [stdout] test storage::kv::test::get_working_set_empty ... ok [INFO] [stdout] test storage::kv::test::test_create ... ok [INFO] [stdout] test storage::kv::test::test_all_tasks_and_uuids ... ok [INFO] [stdout] test storage::kv::test::test_delete_task_missing ... ok [INFO] [stdout] test storage::kv::test::test_base_version_setting ... ok [INFO] [stdout] test storage::kv::test::test_create_exists ... ok [INFO] [stdout] test storage::kv::test::test_delete_task_exists ... ok [INFO] [stdout] test storage::kv::test::add_to_working_set ... ok [INFO] [stdout] test storage::kv::test::test_set_task ... ok [INFO] [stdout] test storage::kv::test::test_operations ... ok [INFO] [stdout] test utils::test::test_from_bytes_bad_len - should panic ... ok [INFO] [stdout] test server::remote::crypto::test::round_trip_bad_pvid ... ok [INFO] [stdout] test storage::operation::test::transform_invariant_holds ... ok [INFO] [stdout] test server::remote::crypto::test::round_trip_bad_key ... ok [INFO] [stdout] test server::remote::crypto::test::round_trip ... ok [INFO] [stdout] test taskdb::tests::transform_sequences_of_operations ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 68 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 6.50s [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" "5fad6b1d0b607e114dc77103f994203801837de12acb3a3240fa3b425ab336f8", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "5fad6b1d0b607e114dc77103f994203801837de12acb3a3240fa3b425ab336f8", kill_on_drop: false }` [INFO] [stdout] 5fad6b1d0b607e114dc77103f994203801837de12acb3a3240fa3b425ab336f8