[INFO] fetching crate jb 0.0.14... [INFO] testing jb-0.0.14 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-1 [INFO] extracting crate jb 0.0.14 into /workspace/builds/worker-2-tc1/source [INFO] started tweaking crates.io crate jb 0.0.14 [INFO] finished tweaking crates.io crate jb 0.0.14 [INFO] tweaked toml for crates.io crate jb 0.0.14 written to /workspace/builds/worker-2-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate jb 0.0.14 on toolchain 562dee4820c458d823175268e41601d4c060588a [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate jb 0.0.14 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" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded hashlink v0.9.1 [INFO] [stderr] Downloaded wasm-bindgen-macro v0.2.111 [INFO] [stderr] Downloaded clap_complete v4.5.66 [INFO] [stderr] Downloaded wasm-bindgen-shared v0.2.111 [INFO] [stderr] Downloaded wasm-bindgen-macro-support v0.2.111 [INFO] [stderr] Downloaded wasm-bindgen v0.2.111 [INFO] [stderr] Downloaded rusqlite v0.32.1 [INFO] [stderr] Downloaded js-sys v0.3.88 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 56e321b5676a78df6193ab259e817d432128b097e20cf475fb351acdc0085087 [INFO] running `Command { std: "docker" "start" "-a" "56e321b5676a78df6193ab259e817d432128b097e20cf475fb351acdc0085087", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "56e321b5676a78df6193ab259e817d432128b097e20cf475fb351acdc0085087", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "56e321b5676a78df6193ab259e817d432128b097e20cf475fb351acdc0085087", kill_on_drop: false }` [INFO] [stdout] 56e321b5676a78df6193ab259e817d432128b097e20cf475fb351acdc0085087 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] e130147e4439b6272b6781d720ca4074d87b6eb1bec47f2bb14e9ceef71e1ce7 [INFO] running `Command { std: "docker" "start" "-a" "e130147e4439b6272b6781d720ca4074d87b6eb1bec47f2bb14e9ceef71e1ce7", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.182 [INFO] [stderr] Compiling quote v1.0.44 [INFO] [stderr] Compiling zerocopy v0.8.39 [INFO] [stderr] Compiling once_cell v1.21.3 [INFO] [stderr] Compiling ahash v0.8.12 [INFO] [stderr] Compiling utf8parse v0.2.2 [INFO] [stderr] Compiling cc v1.2.56 [INFO] [stderr] Compiling pkg-config v0.3.32 [INFO] [stderr] Compiling anstyle-parse v0.2.7 [INFO] [stderr] Compiling vcpkg v0.2.15 [INFO] [stderr] Compiling colorchoice v1.0.4 [INFO] [stderr] Compiling is_terminal_polyfill v1.70.2 [INFO] [stderr] Compiling anstyle-query v1.1.5 [INFO] [stderr] Compiling anstream v0.6.21 [INFO] [stderr] Compiling tracing-core v0.1.36 [INFO] [stderr] Compiling syn v2.0.117 [INFO] [stderr] Compiling regex-syntax v0.8.9 [INFO] [stderr] Compiling strsim v0.11.1 [INFO] [stderr] Compiling serde v1.0.228 [INFO] [stderr] Compiling clap_builder v4.5.60 [INFO] [stderr] Compiling nix v0.30.1 [INFO] [stderr] Compiling thiserror v2.0.18 [INFO] [stderr] Compiling bitflags v2.11.0 [INFO] [stderr] Compiling option-ext v0.2.0 [INFO] [stderr] Compiling anyhow v1.0.102 [INFO] [stderr] Compiling log v0.4.29 [INFO] [stderr] Compiling libsqlite3-sys v0.30.1 [INFO] [stderr] Compiling getrandom v0.3.4 [INFO] [stderr] Compiling parking_lot_core v0.9.12 [INFO] [stderr] Compiling errno v0.3.14 [INFO] [stderr] Compiling rand_core v0.9.5 [INFO] [stderr] Compiling parking_lot v0.12.5 [INFO] [stderr] Compiling signal-hook-registry v1.4.8 [INFO] [stderr] Compiling regex-automata v0.4.14 [INFO] [stderr] Compiling socket2 v0.6.2 [INFO] [stderr] Compiling dirs-sys v0.5.0 [INFO] [stderr] Compiling mio v1.1.1 [INFO] [stderr] Compiling tracing-log v0.2.0 [INFO] [stderr] Compiling sharded-slab v0.1.7 [INFO] [stderr] Compiling thread_local v1.1.9 [INFO] [stderr] Compiling nu-ansi-term v0.50.3 [INFO] [stderr] Compiling iana-time-zone v0.1.65 [INFO] [stderr] Compiling fallible-streaming-iterator v0.1.9 [INFO] [stderr] Compiling bytes v1.11.1 [INFO] [stderr] Compiling fallible-iterator v0.3.0 [INFO] [stderr] Compiling serde_json v1.0.149 [INFO] [stderr] Compiling matchers v0.2.0 [INFO] [stderr] Compiling ppv-lite86 v0.2.21 [INFO] [stderr] Compiling dirs v6.0.0 [INFO] [stderr] Compiling hashbrown v0.14.5 [INFO] [stderr] Compiling colored v3.1.1 [INFO] [stderr] Compiling rand_chacha v0.9.0 [INFO] [stderr] Compiling hashlink v0.9.1 [INFO] [stderr] Compiling rand v0.9.2 [INFO] [stderr] Compiling clap_derive v4.5.55 [INFO] [stderr] Compiling tracing-attributes v0.1.31 [INFO] [stderr] Compiling serde_derive v1.0.228 [INFO] [stderr] Compiling thiserror-impl v2.0.18 [INFO] [stderr] Compiling tokio-macros v2.6.0 [INFO] [stderr] Compiling tokio v1.49.0 [INFO] [stderr] Compiling tracing v0.1.44 [INFO] [stderr] Compiling clap v4.5.60 [INFO] [stderr] Compiling tracing-subscriber v0.3.22 [INFO] [stderr] Compiling clap_complete v4.5.66 [INFO] [stderr] Compiling chrono v0.4.43 [INFO] [stderr] Compiling rusqlite v0.32.1 [INFO] [stderr] Compiling jb v0.0.14 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 19s [INFO] running `Command { std: "docker" "inspect" "e130147e4439b6272b6781d720ca4074d87b6eb1bec47f2bb14e9ceef71e1ce7", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e130147e4439b6272b6781d720ca4074d87b6eb1bec47f2bb14e9ceef71e1ce7", kill_on_drop: false }` [INFO] [stdout] e130147e4439b6272b6781d720ca4074d87b6eb1bec47f2bb14e9ceef71e1ce7 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 0027cfa71ef5248cf7c23fd4c33de994266a7354ac4124f15d4105075490e002 [INFO] running `Command { std: "docker" "start" "-a" "0027cfa71ef5248cf7c23fd4c33de994266a7354ac4124f15d4105075490e002", kill_on_drop: false }` [INFO] [stderr] Compiling getrandom v0.4.1 [INFO] [stderr] Compiling rusqlite v0.32.1 [INFO] [stderr] Compiling nix v0.30.1 [INFO] [stderr] Compiling tempfile v3.25.0 [INFO] [stderr] Compiling jb v0.0.14 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 8.28s [INFO] running `Command { std: "docker" "inspect" "0027cfa71ef5248cf7c23fd4c33de994266a7354ac4124f15d4105075490e002", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0027cfa71ef5248cf7c23fd4c33de994266a7354ac4124f15d4105075490e002", kill_on_drop: false }` [INFO] [stdout] 0027cfa71ef5248cf7c23fd4c33de994266a7354ac4124f15d4105075490e002 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 3af0ef83a34dbdcd31b0577c918a7ac24475d9cc1f84d21b01823259ac24a863 [INFO] running `Command { std: "docker" "start" "-a" "3af0ef83a34dbdcd31b0577c918a7ac24475d9cc1f84d21b01823259ac24a863", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.17s [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/jb-55d3f88c898a6bd9) [INFO] [stdout] [INFO] [stdout] running 96 tests [INFO] [stdout] test commands::clean::tests::test_invalid_status_string_errors ... ok [INFO] [stdout] test commands::clean::tests::test_rejects_running_status ... ok [INFO] [stdout] test commands::clean::tests::test_rejects_pending_status ... ok [INFO] [stdout] test commands::clean::tests::test_orphaned_log_file_removed ... ok [INFO] [stdout] test commands::clean::tests::test_does_not_delete_recent_job ... ok [INFO] [stdout] test commands::clean::tests::test_status_filter_deletes_only_matching ... ok [INFO] [stdout] test commands::clean::tests::test_deletes_old_completed_job ... ok [INFO] [stdout] test commands::clean::tests::test_all_flag_deletes_terminal_jobs_regardless_of_age ... ok [INFO] [stdout] test commands::list::tests::test_empty_result_when_no_jobs ... ok [INFO] [stdout] test commands::logs::tests::test_colorize_line_case_insensitive ... ok [INFO] [stdout] test commands::logs::tests::test_colorize_line_debug ... ok [INFO] [stdout] test commands::logs::tests::test_colorize_line_empty ... ok [INFO] [stdout] test commands::logs::tests::test_colorize_line_error ... ok [INFO] [stdout] test commands::logs::tests::test_colorize_line_error_lowercase ... ok [INFO] [stdout] test commands::logs::tests::test_colorize_line_fatal ... ok [INFO] [stdout] test commands::logs::tests::test_colorize_line_info ... ok [INFO] [stdout] test commands::logs::tests::test_colorize_line_normal ... ok [INFO] [stdout] test commands::logs::tests::test_colorize_line_panic ... ok [INFO] [stdout] test commands::logs::tests::test_colorize_line_priority ... ok [INFO] [stdout] test commands::logs::tests::test_colorize_line_trace ... ok [INFO] [stdout] test commands::logs::tests::test_colorize_line_warn ... ok [INFO] [stdout] test commands::logs::tests::test_colorize_line_warning ... ok [INFO] [stdout] test commands::list::tests::test_invalid_status_string_errors ... ok [INFO] [stdout] test commands::list::tests::test_failed_flag_filters_to_failed_only ... ok [INFO] [stdout] test commands::list::tests::test_failed_flag_overrides_status_filter ... ok [INFO] [stdout] test commands::list::tests::test_status_filter_string ... ok [INFO] [stdout] test commands::stop::tests::test_stop_job_without_pid_is_noop ... ok [INFO] [stdout] test commands::stop::tests::test_stop_pending_job_marks_stopped ... ok [INFO] [stdout] test commands::list::tests::test_custom_limit ... ok [INFO] [stdout] test core::db::tests::test_generate_id ... ok [INFO] [stdout] test core::db::tests::test_generate_id_unique ... ok [INFO] [stdout] test commands::list::tests::test_all_flag_returns_all_jobs ... ok [INFO] [stdout] test core::db::tests::test_get_by_name ... ok [INFO] [stdout] test core::db::tests::test_count_all ... ok [INFO] [stdout] test core::db::tests::test_count_by_status ... ok [INFO] [stdout] test core::db::tests::test_get_by_prefix ... ok [INFO] [stdout] test core::db::tests::test_idempotency_key_unique_constraint ... ok [INFO] [stdout] test core::db::tests::test_idempotency_key ... ok [INFO] [stdout] test core::db::tests::test_get_nonexistent ... ok [INFO] [stdout] test core::db::tests::test_job_exists ... ok [INFO] [stdout] test commands::list::tests::test_no_filter_applies_default_limit ... ok [INFO] [stdout] test core::db::tests::test_insert_and_get ... ok [INFO] [stdout] test core::db::tests::test_list_no_filter ... ok [INFO] [stdout] test core::db::tests::test_list_ordered_by_created_at_desc ... ok [INFO] [stdout] test core::db::tests::test_name_in_use_pending ... ok [INFO] [stdout] test core::db::tests::test_name_not_in_use_when_completed ... ok [INFO] [stdout] test core::db::tests::test_list_with_status_filter ... ok [INFO] [stdout] test core::db::tests::test_name_in_use_running ... ok [INFO] [stdout] test core::db::tests::test_resolve_by_name ... ok [INFO] [stdout] test core::db::tests::test_resolve_not_found ... ok [INFO] [stdout] test core::ipc::tests::test_request_list_roundtrip ... ok [INFO] [stdout] test core::ipc::tests::test_request_ping_roundtrip ... ok [INFO] [stdout] test core::ipc::tests::test_request_run_minimal_roundtrip ... ok [INFO] [stdout] test core::ipc::tests::test_request_run_roundtrip ... ok [INFO] [stdout] test core::ipc::tests::test_request_shutdown_roundtrip ... ok [INFO] [stdout] test core::ipc::tests::test_request_status_roundtrip ... ok [INFO] [stdout] test core::ipc::tests::test_request_stop_roundtrip ... ok [INFO] [stdout] test core::ipc::tests::test_request_wait_roundtrip ... ok [INFO] [stdout] test core::ipc::tests::test_response_error_roundtrip ... ok [INFO] [stdout] test core::ipc::tests::test_response_ok_roundtrip ... ok [INFO] [stdout] test core::ipc::tests::test_response_pong_roundtrip ... ok [INFO] [stdout] test core::ipc::tests::test_response_user_error_roundtrip ... ok [INFO] [stdout] test core::job::tests::test_job_builder_methods ... ok [INFO] [stdout] test core::job::tests::test_job_new ... ok [INFO] [stdout] test core::job::tests::test_job_short_id ... ok [INFO] [stdout] test core::job::tests::test_status_as_str ... ok [INFO] [stdout] test core::job::tests::test_status_display ... ok [INFO] [stdout] test core::job::tests::test_status_from_str ... ok [INFO] [stdout] test core::job::tests::test_status_from_str_case_insensitive ... ok [INFO] [stdout] test core::job::tests::test_status_from_str_invalid ... ok [INFO] [stdout] test core::job::tests::test_status_is_terminal ... ok [INFO] [stdout] test core::tests::test_parse_duration_days ... ok [INFO] [stdout] test core::tests::test_parse_duration_hours ... ok [INFO] [stdout] test core::tests::test_parse_duration_invalid_format ... ok [INFO] [stdout] test core::tests::test_parse_duration_invalid_number ... ok [INFO] [stdout] test core::db::tests::test_resolve_by_id ... ok [INFO] [stdout] test core::tests::test_parse_duration_seconds ... ok [INFO] [stdout] test core::tests::test_parse_duration_minutes ... ok [INFO] [stdout] test core::tests::test_parse_duration_with_whitespace ... ok [INFO] [stdout] test core::db::tests::test_resolve_returns_most_recent ... ok [INFO] [stdout] test core::db::tests::test_update_started ... ok [INFO] [stdout] test core::db::tests::test_update_finished ... ok [INFO] [stdout] test core::db::tests::test_update_status ... ok [INFO] [stdout] test core::db::tests::test_list_with_status_and_limit ... ok [INFO] [stdout] test core::db::tests::test_list_with_limit ... ok [INFO] [stdout] test daemon::spawner::tests::test_job_fails_with_nonzero_exit ... ok [INFO] [stdout] test daemon::spawner::tests::test_job_completes_with_exit_0 ... ok [INFO] [stdout] test daemon::spawner::tests::test_spawn_duplicate_name_returns_user_error ... ok [INFO] [stdout] test daemon::spawner::tests::test_job_output_written_to_log ... ok [INFO] [stdout] test daemon::spawner::tests::test_spawn_idempotency_key_returns_existing_job ... ok [INFO] [stdout] test daemon::spawner::tests::test_job_pid_recorded ... ok [INFO] [stdout] test daemon::spawner::tests::test_job_with_name_stored_correctly ... ok [INFO] [stdout] test daemon::spawner::tests::test_spawn_returns_pending_job ... ok [INFO] [stdout] test daemon::spawner::tests::test_spawn_bad_cwd_marks_job_failed ... ok [INFO] [stdout] test daemon::spawner::tests::test_stop_nonexistent_job_returns_error ... ok [INFO] [stdout] test daemon::spawner::tests::test_stop_job_sets_stopped_status ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 96 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.65s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "3af0ef83a34dbdcd31b0577c918a7ac24475d9cc1f84d21b01823259ac24a863", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3af0ef83a34dbdcd31b0577c918a7ac24475d9cc1f84d21b01823259ac24a863", kill_on_drop: false }` [INFO] [stdout] 3af0ef83a34dbdcd31b0577c918a7ac24475d9cc1f84d21b01823259ac24a863