[INFO] fetching crate delhi 0.1.4...
[INFO] testing delhi-0.1.4 against 1.100.0-beta.1+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate delhi 0.1.4 into /workspace/builds/worker-2-tc2/source
[INFO] started tweaking crates.io crate delhi 0.1.4
[INFO] finished tweaking crates.io crate delhi 0.1.4
[INFO] tweaked toml for crates.io crate delhi 0.1.4 written to /workspace/builds/worker-2-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate delhi 0.1.4 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate delhi 0.1.4 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] baa373b3ecad0f868b08e6c5cdc627a97a16371fa74e68e7173eae12e18be742
[INFO] running `Command { std: "docker" "start" "baa373b3ecad0f868b08e6c5cdc627a97a16371fa74e68e7173eae12e18be742", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "baa373b3ecad0f868b08e6c5cdc627a97a16371fa74e68e7173eae12e18be742", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "baa373b3ecad0f868b08e6c5cdc627a97a16371fa74e68e7173eae12e18be742" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "baa373b3ecad0f868b08e6c5cdc627a97a16371fa74e68e7173eae12e18be742", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "baa373b3ecad0f868b08e6c5cdc627a97a16371fa74e68e7173eae12e18be742" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]    Compiling delhi-core v0.1.4
[INFO] [stderr]    Compiling delhi-syntax v0.1.4
[INFO] [stderr]    Compiling proc-macro2 v1.0.107
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling httpdate v1.0.3
[INFO] [stderr]    Compiling chunked_transfer v1.5.0
[INFO] [stderr]    Compiling log v0.4.33
[INFO] [stderr]    Compiling ascii v1.1.0
[INFO] [stderr]    Compiling delhi-mb v0.1.4
[INFO] [stderr]    Compiling tiny_http v0.12.0
[INFO] [stderr]    Compiling delhi-lang v0.1.4
[INFO] [stderr]    Compiling syn v3.0.3
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling delhi-gui v0.1.4
[INFO] [stderr]    Compiling delhi v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 36.58s
[INFO] running `Command { std: "docker" "inspect" "baa373b3ecad0f868b08e6c5cdc627a97a16371fa74e68e7173eae12e18be742", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "baa373b3ecad0f868b08e6c5cdc627a97a16371fa74e68e7173eae12e18be742" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling delhi v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 3.57s
[INFO] running `Command { std: "docker" "inspect" "baa373b3ecad0f868b08e6c5cdc627a97a16371fa74e68e7173eae12e18be742", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "baa373b3ecad0f868b08e6c5cdc627a97a16371fa74e68e7173eae12e18be742" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.07s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/release/build/delhi/7e158b76b262e78e/out/delhi-7e158b76b262e78e)
[INFO] [stdout] 
[INFO] [stdout] running 43 tests
[INFO] [stdout] test cmd::tests::ask_enumerates_after_the_trace_and_exits_on_whether_anything_matched ... ok
[INFO] [stdout] test cmd::tests::ask_reports_a_bad_pattern_as_a_usage_error ... ok
[INFO] [stdout] test cmd::tests::bench_rejects_bad_input_without_running_anything ... ok
[INFO] [stdout] test cmd::tests::bench_shows_contraction_bounding_a_run_that_would_otherwise_grow ... ok
[INFO] [stdout] test cmd::tests::check_accepts_a_file_whose_invariants_hold_at_the_start ... ok
[INFO] [stdout] test cmd::tests::check_accepts_a_valid_file ... ok
[INFO] [stdout] test cmd::tests::ask_exits_nonzero_when_nothing_matches_so_a_script_can_branch ... ok
[INFO] [stdout] test cmd::tests::ask_errors_end_with_a_newline_so_the_prompt_does_not_run_into_them ... ok
[INFO] [stdout] test cmd::tests::check_rejects_a_domain_inconsistent_with_its_own_constraint ... ok
[INFO] [stdout] test cmd::tests::dot_omits_reflexive_edges ... ok
[INFO] [stdout] test cmd::tests::eval_distinguishes_an_unknown_action_from_an_inapplicable_one ... ok
[INFO] [stdout] test cmd::tests::contracted_preserves_the_designated_world ... ok
[INFO] [stdout] test cmd::tests::check_rejects_and_explains ... ok
[INFO] [stdout] test cmd::tests::eval_answers_against_the_state_the_trace_reaches ... ok
[INFO] [stdout] test cmd::tests::dot_emits_a_digraph_with_one_node_per_world ... ok
[INFO] [stdout] test cmd::tests::eval_reports_a_malformed_formula_rather_than_panicking ... ok
[INFO] [stdout] test cmd::tests::eval_reports_true_and_false_with_different_codes ... ok
[INFO] [stdout] test cmd::tests::repl_ask_reads_a_leading_integer_as_the_depth ... ok
[INFO] [stdout] test cmd::tests::repl_evaluates_a_bare_formula ... ok
[INFO] [stdout] test cmd::tests::repl_applies_an_action_and_the_state_persists ... ok
[INFO] [stdout] test cmd::tests::repl_lists_the_available_actions ... ok
[INFO] [stdout] test cmd::tests::repl_ask_explains_itself_when_the_pattern_is_missing ... ok
[INFO] [stdout] test cmd::tests::repl_quit_stops_and_unknown_commands_do_not ... ok
[INFO] [stdout] test cmd::tests::repl_reports_a_bad_formula_without_stopping ... ok
[INFO] [stdout] test cmd::tests::state_separates_knowing_from_merely_believing ... ok
[INFO] [stdout] test cmd::tests::repl_state_follows_the_current_state_not_the_initial_one ... ok
[INFO] [stdout] test cmd::tests::show_emits_the_explicit_form ... ok
[INFO] [stdout] test cmd::tests::repl_reset_returns_to_the_initial_state ... ok
[INFO] [stdout] test cmd::tests::step_applies_a_sequence_and_prints_the_result ... ok
[INFO] [stdout] test cmd::tests::step_reports_an_inapplicable_action_rather_than_panicking ... ok
[INFO] [stdout] test cmd::tests::state_reports_undecided_when_an_agent_leans_neither_way ... ok
[INFO] [stdout] test cmd::tests::state_describes_the_state_the_trace_reaches ... ok
[INFO] [stdout] test cmd::tests::state_rejects_a_bad_file ... ok
[INFO] [stdout] test cmd::tests::step_reports_an_unknown_action_by_name ... ok
[INFO] [stdout] test cmd::tests::step_contracts_so_worlds_do_not_accumulate ... ok
[INFO] [stdout] test cmd::tests::step_names_the_action_that_broke_an_invariant ... ok
[INFO] [stdout] test style::tests::styling_is_a_no_op_until_enabled ... ok
[INFO] [stdout] test json::tests::the_characters_json_requires_escaping_are_escaped ... ok
[INFO] [stdout] test style::tests::no_color_beats_clicolor_force ... ok
[INFO] [stdout] test json::tests::builders_compose_into_the_shape_the_python_wrapper_expects ... ok
[INFO] [stdout] test json::tests::formula_glyphs_survive_as_utf8_rather_than_being_escaped ... ok
[INFO] [stdout] test cmd::tests::the_repl_reports_a_violation_but_keeps_going ... ok
[INFO] [stdout] test json::tests::an_empty_array_and_an_empty_object_are_still_valid ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 43 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "baa373b3ecad0f868b08e6c5cdc627a97a16371fa74e68e7173eae12e18be742", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "baa373b3ecad0f868b08e6c5cdc627a97a16371fa74e68e7173eae12e18be742", kill_on_drop: false }`
[INFO] [stdout] baa373b3ecad0f868b08e6c5cdc627a97a16371fa74e68e7173eae12e18be742
