[INFO] fetching crate deser-incomplete 0.1.2...
[INFO] testing deser-incomplete-0.1.2 against try#8de4c7234dd9b97c9d76b58671343fdbbc9a433e+target=x86_64-unknown-linux-musl for musl_upgrade_1_2_5_with_libc_patch_0
[INFO] extracting crate deser-incomplete 0.1.2 into /workspace/builds/worker-1-tc1/source
[INFO] started tweaking crates.io crate deser-incomplete 0.1.2
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate deser-incomplete 0.1.2
[INFO] tweaked toml for crates.io crate deser-incomplete 0.1.2 written to /workspace/builds/worker-1-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate deser-incomplete 0.1.2 on toolchain 8de4c7234dd9b97c9d76b58671343fdbbc9a433e
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate deser-incomplete 0.1.2 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" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded ansi-to-tui v7.0.0
[INFO] [stderr]   Downloaded insta v1.42.0
[INFO] [stderr]   Downloaded tui-textarea v0.7.0
[INFO] [stderr]   Downloaded interprocess v2.2.2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 069ead512ebb562be3263abc2aa0331ebe73d2cf2b534392a76a92fe7091d04a
[INFO] running `Command { std: "docker" "start" "-a" "069ead512ebb562be3263abc2aa0331ebe73d2cf2b534392a76a92fe7091d04a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "069ead512ebb562be3263abc2aa0331ebe73d2cf2b534392a76a92fe7091d04a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "069ead512ebb562be3263abc2aa0331ebe73d2cf2b534392a76a92fe7091d04a", kill_on_drop: false }`
[INFO] [stdout] 069ead512ebb562be3263abc2aa0331ebe73d2cf2b534392a76a92fe7091d04a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "build" "--frozen" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] e797419f74689e3e5acdf651b3e68226197b0c5bf7ed01bd03af65042fcddb8c
[INFO] running `Command { std: "docker" "start" "-a" "e797419f74689e3e5acdf651b3e68226197b0c5bf7ed01bd03af65042fcddb8c", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.92
[INFO] [stderr]    Compiling unicode-ident v1.0.14
[INFO] [stderr]    Compiling libc v0.2.169
[INFO] [stderr]    Compiling serde v1.0.215
[INFO] [stderr]    Compiling serde_json v1.0.133
[INFO] [stderr]    Compiling thiserror v2.0.3
[INFO] [stderr]    Compiling itoa v1.0.13
[INFO] [stderr]    Compiling memchr v2.7.4
[INFO] [stderr]    Compiling tap v1.0.1
[INFO] [stderr]    Compiling tracing-core v0.1.33
[INFO] [stderr]    Compiling quote v1.0.37
[INFO] [stderr]    Compiling syn v2.0.96
[INFO] [stderr]    Compiling getrandom v0.2.15
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling zerocopy-derive v0.7.35
[INFO] [stderr]    Compiling thiserror-impl v2.0.3
[INFO] [stderr]    Compiling tracing-attributes v0.1.28
[INFO] [stderr]    Compiling zerocopy v0.7.35
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling ppv-lite86 v0.2.20
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling deser-incomplete v0.1.2 (/opt/rustwide/workdir)
[INFO] [stdout] warning: struct `CustomReporter` is never constructed
[INFO] [stdout]    --> src/options_impl.rs:586:12
[INFO] [stdout]     |
[INFO] [stdout] 586 | pub struct CustomReporter<T>(T);
[INFO] [stdout]     |            ^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `CustomReporter` has derived impls for the traits `Debug` and `Clone`, but these are intentionally ignored during dead code analysis
[INFO] [stdout]     = note: `#[warn(dead_code)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `CustomFallbackProvider` is never constructed
[INFO] [stdout]    --> src/options_impl.rs:595:12
[INFO] [stdout]     |
[INFO] [stdout] 595 | pub struct CustomFallbackProvider<T>(T);
[INFO] [stdout]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `CustomFallbackProvider` has derived impls for the traits `Debug` and `Clone`, but these are intentionally ignored during dead code analysis
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 15.54s
[INFO] running `Command { std: "docker" "inspect" "e797419f74689e3e5acdf651b3e68226197b0c5bf7ed01bd03af65042fcddb8c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e797419f74689e3e5acdf651b3e68226197b0c5bf7ed01bd03af65042fcddb8c", kill_on_drop: false }`
[INFO] [stdout] e797419f74689e3e5acdf651b3e68226197b0c5bf7ed01bd03af65042fcddb8c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--no-run" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 1a5cb31dae51fee59b19f7ce3fbf453dc80f68a477255022a3b08b6c487d69cd
[INFO] running `Command { std: "docker" "start" "-a" "1a5cb31dae51fee59b19f7ce3fbf453dc80f68a477255022a3b08b6c487d69cd", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.169
[INFO] [stderr]    Compiling log v0.4.22
[INFO] [stderr]    Compiling rustversion v1.0.19
[INFO] [stderr]    Compiling serde v1.0.215
[INFO] [stderr]    Compiling allocator-api2 v0.2.21
[INFO] [stderr]    Compiling foldhash v0.1.4
[INFO] [stderr]    Compiling signal-hook v0.3.17
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling smallvec v1.13.2
[INFO] [stderr]    Compiling rustix v0.38.43
[INFO] [stderr]    Compiling bitflags v2.8.0
[INFO] [stderr]    Compiling either v1.13.0
[INFO] [stderr]    Compiling serde_derive v1.0.215
[INFO] [stderr]    Compiling linux-raw-sys v0.4.15
[INFO] [stderr]    Compiling paste v1.0.15
[INFO] [stderr]    Compiling tracing-core v0.1.33
[INFO] [stderr]    Compiling unicode-segmentation v1.12.0
[INFO] [stderr]    Compiling indoc v2.0.5
[INFO] [stderr]    Compiling itertools v0.13.0
[INFO] [stderr]    Compiling litrs v0.4.1
[INFO] [stderr]    Compiling unicode-width v0.1.14
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling darling_core v0.20.10
[INFO] [stderr]    Compiling tokio-macros v2.5.0
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling hashbrown v0.15.2
[INFO] [stderr]    Compiling cassowary v0.3.0
[INFO] [stderr]    Compiling unicode-width v0.2.0
[INFO] [stderr]    Compiling serde_json v1.0.133
[INFO] [stderr]    Compiling futures-io v0.3.31
[INFO] [stderr]    Compiling regex-syntax v0.6.29
[INFO] [stderr]    Compiling typeid v1.0.2
[INFO] [stderr]    Compiling regex-syntax v0.8.5
[INFO] [stderr]    Compiling bytes v1.9.0
[INFO] [stderr]    Compiling ahash v0.8.11
[INFO] [stderr]    Compiling document-features v0.2.10
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling clap_lex v0.7.4
[INFO] [stderr]    Compiling base64 v0.13.1
[INFO] [stderr]    Compiling anyhow v1.0.95
[INFO] [stderr]    Compiling castaway v0.2.3
[INFO] [stderr]    Compiling strum_macros v0.26.4
[INFO] [stderr]    Compiling compact_str v0.8.1
[INFO] [stderr]    Compiling overload v0.1.1
[INFO] [stderr]    Compiling nu-ansi-term v0.46.0
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling lru v0.12.5
[INFO] [stderr]    Compiling clap_builder v4.5.26
[INFO] [stderr]    Compiling sharded-slab v0.1.7
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling clap_derive v4.5.24
[INFO] [stderr]    Compiling thread_local v1.1.8
[INFO] [stderr]    Compiling doctest-file v1.0.0
[INFO] [stderr]    Compiling simdutf8 v0.1.5
[INFO] [stderr]    Compiling signal-hook-registry v1.4.2
[INFO] [stderr]    Compiling mio v1.0.3
[INFO] [stderr]    Compiling getrandom v0.2.15
[INFO] [stderr]    Compiling parking_lot_core v0.9.10
[INFO] [stderr]    Compiling unicode-truncate v1.1.0
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling regex-automata v0.1.10
[INFO] [stderr]    Compiling console v0.15.10
[INFO] [stderr]    Compiling parking_lot v0.12.3
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling signal-hook-mio v0.2.4
[INFO] [stderr]    Compiling tokio v1.43.0
[INFO] [stderr]    Compiling crossterm v0.28.1
[INFO] [stderr]    Compiling linked-hash-map v0.5.6
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling matchers v0.1.0
[INFO] [stderr]    Compiling similar v2.6.0
[INFO] [stderr]    Compiling interprocess v2.2.2
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling clap v4.5.26
[INFO] [stderr]    Compiling strum v0.26.3
[INFO] [stderr]    Compiling tracing-subscriber v0.3.19
[INFO] [stderr]    Compiling darling_macro v0.20.10
[INFO] [stderr]    Compiling darling v0.20.10
[INFO] [stderr]    Compiling instability v0.3.7
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling ratatui v0.29.0
[INFO] [stderr]    Compiling tokio-util v0.7.13
[INFO] [stderr]    Compiling tokio-stream v0.1.17
[INFO] [stderr]    Compiling indexmap v2.7.0
[INFO] [stderr]    Compiling ron v0.7.1
[INFO] [stderr]    Compiling erased-serde v0.4.5
[INFO] [stderr]    Compiling serde_yaml v0.9.34+deprecated
[INFO] [stderr]    Compiling insta v1.42.0
[INFO] [stderr]    Compiling ansi-to-tui v7.0.0
[INFO] [stderr]    Compiling tui-textarea v0.7.0
[INFO] [stderr]    Compiling deser-incomplete v0.1.2 (/opt/rustwide/workdir)
[INFO] [stdout] warning: struct `CustomReporter` is never constructed
[INFO] [stdout]    --> src/options_impl.rs:586:12
[INFO] [stdout]     |
[INFO] [stdout] 586 | pub struct CustomReporter<T>(T);
[INFO] [stdout]     |            ^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `CustomReporter` has derived impls for the traits `Debug` and `Clone`, but these are intentionally ignored during dead code analysis
[INFO] [stdout]     = note: `#[warn(dead_code)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `CustomFallbackProvider` is never constructed
[INFO] [stdout]    --> src/options_impl.rs:595:12
[INFO] [stdout]     |
[INFO] [stdout] 595 | pub struct CustomFallbackProvider<T>(T);
[INFO] [stdout]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `CustomFallbackProvider` has derived impls for the traits `Debug` and `Clone`, but these are intentionally ignored during dead code analysis
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `CustomReporter` is never constructed
[INFO] [stdout]    --> src/options_impl.rs:586:12
[INFO] [stdout]     |
[INFO] [stdout] 586 | pub struct CustomReporter<T>(T);
[INFO] [stdout]     |            ^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `CustomReporter` has derived impls for the traits `Debug` and `Clone`, but these are intentionally ignored during dead code analysis
[INFO] [stdout]     = note: `#[warn(dead_code)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `CustomFallbackProvider` is never constructed
[INFO] [stdout]    --> src/options_impl.rs:595:12
[INFO] [stdout]     |
[INFO] [stdout] 595 | pub struct CustomFallbackProvider<T>(T);
[INFO] [stdout]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `CustomFallbackProvider` has derived impls for the traits `Debug` and `Clone`, but these are intentionally ignored during dead code analysis
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 41.23s
[INFO] running `Command { std: "docker" "inspect" "1a5cb31dae51fee59b19f7ce3fbf453dc80f68a477255022a3b08b6c487d69cd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1a5cb31dae51fee59b19f7ce3fbf453dc80f68a477255022a3b08b6c487d69cd", kill_on_drop: false }`
[INFO] [stdout] 1a5cb31dae51fee59b19f7ce3fbf453dc80f68a477255022a3b08b6c487d69cd
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 90444b997cc6c11c12788373a59219ea9cb743b61103b7fdde7017fc25999ea3
[INFO] running `Command { std: "docker" "start" "-a" "90444b997cc6c11c12788373a59219ea9cb743b61103b7fdde7017fc25999ea3", kill_on_drop: false }`
[INFO] [stderr] warning: struct `CustomReporter` is never constructed
[INFO] [stderr]    --> src/options_impl.rs:586:12
[INFO] [stderr]     |
[INFO] [stderr] 586 | pub struct CustomReporter<T>(T);
[INFO] [stderr]     |            ^^^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `CustomReporter` has derived impls for the traits `Debug` and `Clone`, but these are intentionally ignored during dead code analysis
[INFO] [stderr]     = note: `#[warn(dead_code)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `CustomFallbackProvider` is never constructed
[INFO] [stderr]    --> src/options_impl.rs:595:12
[INFO] [stderr]     |
[INFO] [stderr] 595 | pub struct CustomFallbackProvider<T>(T);
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `CustomFallbackProvider` has derived impls for the traits `Debug` and `Clone`, but these are intentionally ignored during dead code analysis
[INFO] [stderr] 
[INFO] [stderr] warning: `deser-incomplete` (lib) generated 2 warnings
[INFO] [stderr] warning: `deser-incomplete` (lib test) generated 2 warnings (2 duplicates)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.35s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/deser_incomplete-c0feaf29cd278b47)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test random_trailer::json::test::test_tag_suffix ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/regression.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/regression-ebdfa2fc128a225d)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 2025-06-29T14:00:47.398571Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=0 point=halting point 0
[INFO] [stdout] 2025-06-29T14:00:47.398627Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=0 point=halting point 0
[INFO] [stdout] 2025-06-29T14:00:47.398644Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_seq nesting_level=0 expecting=a sequence
[INFO] [stdout] 2025-06-29T14:00:47.398654Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_seq nesting_level=0 expecting=a sequence
[INFO] [stdout] 2025-06-29T14:00:47.398666Z TRACE deser_incomplete::reporter::default_reporter: receive visit_seq nesting_level=0
[INFO] [stdout] 2025-06-29T14:00:47.398672Z TRACE deser_incomplete::reporter::default_reporter: receive visit_seq nesting_level=0
[INFO] [stdout] 2025-06-29T14:00:47.398681Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 1
[INFO] [stdout] 2025-06-29T14:00:47.398690Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 1
[INFO] [stdout] 2025-06-29T14:00:47.398700Z TRACE deser_incomplete::attempt::access: entering corresponding_halting_point=halting point 1 self.inside_element=None
[INFO] [stdout] 2025-06-29T14:00:47.398708Z TRACE deser_incomplete::attempt::access: entering corresponding_halting_point=halting point 1 self.inside_element=None
[INFO] [stdout] 2025-06-29T14:00:47.398718Z TRACE deser_incomplete::reporter::default_reporter: start deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.398726Z TRACE deser_incomplete::reporter::default_reporter: start deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.398783Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_i32 nesting_level=1 expecting=i32
[INFO] [stdout] 2025-06-29T14:00:47.398793Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_i32 nesting_level=1 expecting=i32
[INFO] [stdout] 2025-06-29T14:00:47.398805Z TRACE deser_incomplete::reporter::default_reporter: receive visit_u64 nesting_level=1 v=1
[INFO] [stdout] 2025-06-29T14:00:47.398813Z TRACE deser_incomplete::reporter::default_reporter: receive visit_u64 nesting_level=1 v=1
[INFO] [stdout] 2025-06-29T14:00:47.398824Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_primitive nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.398831Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_primitive nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.398839Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.398846Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.398855Z TRACE deser_incomplete::reporter::default_reporter: finish deserializing next element nesting_level=1 present=true
[INFO] [stdout] 2025-06-29T14:00:47.398864Z TRACE deser_incomplete::reporter::default_reporter: finish deserializing next element nesting_level=1 present=true
[INFO] [stdout] 2025-06-29T14:00:47.398874Z TRACE deser_incomplete::attempt::access: leaving self.inside_element=Some(InsideElement { corresponding_halting_point: HaltingPoint(1), halting_point_is_on_stack: true }) self.attempt.halting_point_stack=[HaltingPoint(1)]
[INFO] [stdout] 2025-06-29T14:00:47.398887Z TRACE deser_incomplete::attempt::access: leaving self.inside_element=Some(InsideElement { corresponding_halting_point: HaltingPoint(1), halting_point_is_on_stack: true }) self.attempt.halting_point_stack=[HaltingPoint(1)]
[INFO] [stdout] 2025-06-29T14:00:47.398898Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 2
[INFO] [stdout] 2025-06-29T14:00:47.398905Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 2
[INFO] [stdout] 2025-06-29T14:00:47.398914Z TRACE deser_incomplete::attempt::access: entering corresponding_halting_point=halting point 2 self.inside_element=None
[INFO] [stdout] 2025-06-29T14:00:47.398922Z TRACE deser_incomplete::attempt::access: entering corresponding_halting_point=halting point 2 self.inside_element=None
[INFO] [stdout] 2025-06-29T14:00:47.398930Z TRACE deser_incomplete::reporter::default_reporter: start deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.398937Z TRACE deser_incomplete::reporter::default_reporter: start deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.398944Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_i32 nesting_level=1 expecting=i32
[INFO] [stdout] 2025-06-29T14:00:47.398952Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_i32 nesting_level=1 expecting=i32
[INFO] [stdout] 2025-06-29T14:00:47.398961Z TRACE deser_incomplete::reporter::default_reporter: receive visit_u64 nesting_level=1 v=2
[INFO] [stdout] 2025-06-29T14:00:47.398969Z TRACE deser_incomplete::reporter::default_reporter: receive visit_u64 nesting_level=1 v=2
[INFO] [stdout] 2025-06-29T14:00:47.398978Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_primitive nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.398985Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_primitive nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.398992Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.398998Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399005Z TRACE deser_incomplete::reporter::default_reporter: finish deserializing next element nesting_level=1 present=true
[INFO] [stdout] 2025-06-29T14:00:47.399013Z TRACE deser_incomplete::reporter::default_reporter: finish deserializing next element nesting_level=1 present=true
[INFO] [stdout] 2025-06-29T14:00:47.399022Z TRACE deser_incomplete::attempt::access: leaving self.inside_element=Some(InsideElement { corresponding_halting_point: HaltingPoint(2), halting_point_is_on_stack: true }) self.attempt.halting_point_stack=[HaltingPoint(2)]
[INFO] [stdout] 2025-06-29T14:00:47.399032Z TRACE deser_incomplete::attempt::access: leaving self.inside_element=Some(InsideElement { corresponding_halting_point: HaltingPoint(2), halting_point_is_on_stack: true }) self.attempt.halting_point_stack=[HaltingPoint(2)]
[INFO] [stdout] 2025-06-29T14:00:47.399041Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 3
[INFO] [stdout] 2025-06-29T14:00:47.399049Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 3
[INFO] [stdout] 2025-06-29T14:00:47.399058Z TRACE deser_incomplete::attempt::access: entering corresponding_halting_point=halting point 3 self.inside_element=None
[INFO] [stdout] 2025-06-29T14:00:47.399066Z TRACE deser_incomplete::attempt::access: entering corresponding_halting_point=halting point 3 self.inside_element=None
[INFO] [stdout] 2025-06-29T14:00:47.399074Z TRACE deser_incomplete::reporter::default_reporter: start deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399081Z TRACE deser_incomplete::reporter::default_reporter: start deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399088Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_i32 nesting_level=1 expecting=i32
[INFO] [stdout] 2025-06-29T14:00:47.399095Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_i32 nesting_level=1 expecting=i32
[INFO] [stdout] 2025-06-29T14:00:47.399104Z TRACE deser_incomplete::reporter::default_reporter: receive visit_u64 nesting_level=1 v=3
[INFO] [stdout] 2025-06-29T14:00:47.399111Z TRACE deser_incomplete::reporter::default_reporter: receive visit_u64 nesting_level=1 v=3
[INFO] [stdout] 2025-06-29T14:00:47.399120Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_primitive nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399126Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_primitive nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399133Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399140Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399147Z TRACE deser_incomplete::reporter::default_reporter: finish deserializing next element nesting_level=1 present=true
[INFO] [stdout] 2025-06-29T14:00:47.399155Z TRACE deser_incomplete::reporter::default_reporter: finish deserializing next element nesting_level=1 present=true
[INFO] [stdout] 2025-06-29T14:00:47.399162Z TRACE deser_incomplete::attempt::access: leaving self.inside_element=Some(InsideElement { corresponding_halting_point: HaltingPoint(3), halting_point_is_on_stack: true }) self.attempt.halting_point_stack=[HaltingPoint(3)]
[INFO] [stdout] 2025-06-29T14:00:47.399170Z TRACE deser_incomplete::attempt::access: leaving self.inside_element=Some(InsideElement { corresponding_halting_point: HaltingPoint(3), halting_point_is_on_stack: true }) self.attempt.halting_point_stack=[HaltingPoint(3)]
[INFO] [stdout] 2025-06-29T14:00:47.399181Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 4
[INFO] [stdout] 2025-06-29T14:00:47.399188Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 4
[INFO] [stdout] 2025-06-29T14:00:47.399196Z TRACE deser_incomplete::attempt::access: entering corresponding_halting_point=halting point 4 self.inside_element=None
[INFO] [stdout] 2025-06-29T14:00:47.399203Z TRACE deser_incomplete::attempt::access: entering corresponding_halting_point=halting point 4 self.inside_element=None
[INFO] [stdout] 2025-06-29T14:00:47.399211Z TRACE deser_incomplete::reporter::default_reporter: start deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399217Z TRACE deser_incomplete::reporter::default_reporter: start deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399230Z TRACE deser_incomplete::reporter::default_reporter: finish deserializing next element nesting_level=1 error=expected `,` or `]` at line 1 column 7
[INFO] [stdout] 2025-06-29T14:00:47.399240Z TRACE deser_incomplete::reporter::default_reporter: finish deserializing next element nesting_level=1 error=expected `,` or `]` at line 1 column 7
[INFO] [stdout] 2025-06-29T14:00:47.399265Z TRACE deser_incomplete::reporter::default_reporter: start intervention nesting_level=1 reason=VisitError candidate_halting_point_for_next_attempt=halting point 4 halting_point_stack="[[halting point 4]]"
[INFO] [stdout] 2025-06-29T14:00:47.399278Z TRACE deser_incomplete::reporter::default_reporter: start intervention nesting_level=1 reason=VisitError candidate_halting_point_for_next_attempt=halting point 4 halting_point_stack="[[halting point 4]]"
[INFO] [stdout] 2025-06-29T14:00:47.399290Z TRACE deser_incomplete::attempt::access: leaving self.inside_element=Some(InsideElement { corresponding_halting_point: HaltingPoint(4), halting_point_is_on_stack: true }) self.attempt.halting_point_stack=[HaltingPoint(4)]
[INFO] [stdout] 2025-06-29T14:00:47.399298Z TRACE deser_incomplete::attempt::access: leaving self.inside_element=Some(InsideElement { corresponding_halting_point: HaltingPoint(4), halting_point_is_on_stack: true }) self.attempt.halting_point_stack=[HaltingPoint(4)]
[INFO] [stdout] 2025-06-29T14:00:47.399324Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_seq nesting_level=0 error=expected `,` or `]` at line 1 column 7
[INFO] [stdout] 2025-06-29T14:00:47.399333Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_seq nesting_level=0 error=expected `,` or `]` at line 1 column 7
[INFO] [stdout] 2025-06-29T14:00:47.399345Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=0 error=expected `,` or `]` at line 1 column 7
[INFO] [stdout] 2025-06-29T14:00:47.399352Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=0 error=expected `,` or `]` at line 1 column 7
[INFO] [stdout] 2025-06-29T14:00:47.399367Z DEBUG deser_incomplete::options_impl: attempt failed attempt=0 error=expected `,` or `]` at line 1 column 7
[INFO] [stdout] 2025-06-29T14:00:47.399383Z DEBUG deser_incomplete::options_impl: attempt failed attempt=0 error=expected `,` or `]` at line 1 column 7
[INFO] [stdout] 2025-06-29T14:00:47.399394Z TRACE deser_incomplete::state: creating state for next attempt next_halting_point=HaltingPoint(4) reason=VisitError
[INFO] [stdout] 2025-06-29T14:00:47.399403Z TRACE deser_incomplete::state: creating state for next attempt next_halting_point=HaltingPoint(4) reason=VisitError
[INFO] [stdout] 2025-06-29T14:00:47.399414Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=0 point=halting point 0
[INFO] [stdout] 2025-06-29T14:00:47.399423Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=0 point=halting point 0
[INFO] [stdout] 2025-06-29T14:00:47.399432Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_seq nesting_level=0 expecting=a sequence
[INFO] [stdout] 2025-06-29T14:00:47.399440Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_seq nesting_level=0 expecting=a sequence
[INFO] [stdout] 2025-06-29T14:00:47.399450Z TRACE deser_incomplete::reporter::default_reporter: receive visit_seq nesting_level=0
[INFO] [stdout] 2025-06-29T14:00:47.399457Z TRACE deser_incomplete::reporter::default_reporter: receive visit_seq nesting_level=0
[INFO] [stdout] 2025-06-29T14:00:47.399465Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 1
[INFO] [stdout] 2025-06-29T14:00:47.399473Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 1
[INFO] [stdout] 2025-06-29T14:00:47.399482Z TRACE deser_incomplete::attempt::access: entering corresponding_halting_point=halting point 1 self.inside_element=None
[INFO] [stdout] 2025-06-29T14:00:47.399490Z TRACE deser_incomplete::attempt::access: entering corresponding_halting_point=halting point 1 self.inside_element=None
[INFO] [stdout] 2025-06-29T14:00:47.399500Z TRACE deser_incomplete::reporter::default_reporter: start deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399507Z TRACE deser_incomplete::reporter::default_reporter: start deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399515Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_i32 nesting_level=1 expecting=i32
[INFO] [stdout] 2025-06-29T14:00:47.399523Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_i32 nesting_level=1 expecting=i32
[INFO] [stdout] 2025-06-29T14:00:47.399532Z TRACE deser_incomplete::reporter::default_reporter: receive visit_u64 nesting_level=1 v=1
[INFO] [stdout] 2025-06-29T14:00:47.399540Z TRACE deser_incomplete::reporter::default_reporter: receive visit_u64 nesting_level=1 v=1
[INFO] [stdout] 2025-06-29T14:00:47.399551Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_primitive nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399558Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_primitive nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399566Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399573Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399581Z TRACE deser_incomplete::reporter::default_reporter: finish deserializing next element nesting_level=1 present=true
[INFO] [stdout] 2025-06-29T14:00:47.399588Z TRACE deser_incomplete::reporter::default_reporter: finish deserializing next element nesting_level=1 present=true
[INFO] [stdout] 2025-06-29T14:00:47.399597Z TRACE deser_incomplete::attempt::access: leaving self.inside_element=Some(InsideElement { corresponding_halting_point: HaltingPoint(1), halting_point_is_on_stack: true }) self.attempt.halting_point_stack=[HaltingPoint(1)]
[INFO] [stdout] 2025-06-29T14:00:47.399607Z TRACE deser_incomplete::attempt::access: leaving self.inside_element=Some(InsideElement { corresponding_halting_point: HaltingPoint(1), halting_point_is_on_stack: true }) self.attempt.halting_point_stack=[HaltingPoint(1)]
[INFO] [stdout] 2025-06-29T14:00:47.399617Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 2
[INFO] [stdout] 2025-06-29T14:00:47.399625Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 2
[INFO] [stdout] 2025-06-29T14:00:47.399635Z TRACE deser_incomplete::attempt::access: entering corresponding_halting_point=halting point 2 self.inside_element=None
[INFO] [stdout] 2025-06-29T14:00:47.399643Z TRACE deser_incomplete::attempt::access: entering corresponding_halting_point=halting point 2 self.inside_element=None
[INFO] [stdout] 2025-06-29T14:00:47.399652Z TRACE deser_incomplete::reporter::default_reporter: start deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399658Z TRACE deser_incomplete::reporter::default_reporter: start deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399666Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_i32 nesting_level=1 expecting=i32
[INFO] [stdout] 2025-06-29T14:00:47.399674Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_i32 nesting_level=1 expecting=i32
[INFO] [stdout] 2025-06-29T14:00:47.399683Z TRACE deser_incomplete::reporter::default_reporter: receive visit_u64 nesting_level=1 v=2
[INFO] [stdout] 2025-06-29T14:00:47.399691Z TRACE deser_incomplete::reporter::default_reporter: receive visit_u64 nesting_level=1 v=2
[INFO] [stdout] 2025-06-29T14:00:47.399699Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_primitive nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399706Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_primitive nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399715Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399722Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399729Z TRACE deser_incomplete::reporter::default_reporter: finish deserializing next element nesting_level=1 present=true
[INFO] [stdout] 2025-06-29T14:00:47.399737Z TRACE deser_incomplete::reporter::default_reporter: finish deserializing next element nesting_level=1 present=true
[INFO] [stdout] 2025-06-29T14:00:47.399746Z TRACE deser_incomplete::attempt::access: leaving self.inside_element=Some(InsideElement { corresponding_halting_point: HaltingPoint(2), halting_point_is_on_stack: true }) self.attempt.halting_point_stack=[HaltingPoint(2)]
[INFO] [stdout] 2025-06-29T14:00:47.399754Z TRACE deser_incomplete::attempt::access: leaving self.inside_element=Some(InsideElement { corresponding_halting_point: HaltingPoint(2), halting_point_is_on_stack: true }) self.attempt.halting_point_stack=[HaltingPoint(2)]
[INFO] [stdout] 2025-06-29T14:00:47.399764Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 3
[INFO] [stdout] 2025-06-29T14:00:47.399772Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 3
[INFO] [stdout] 2025-06-29T14:00:47.399781Z TRACE deser_incomplete::attempt::access: entering corresponding_halting_point=halting point 3 self.inside_element=None
[INFO] [stdout] 2025-06-29T14:00:47.399789Z TRACE deser_incomplete::attempt::access: entering corresponding_halting_point=halting point 3 self.inside_element=None
[INFO] [stdout] 2025-06-29T14:00:47.399798Z TRACE deser_incomplete::reporter::default_reporter: start deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399805Z TRACE deser_incomplete::reporter::default_reporter: start deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399812Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_i32 nesting_level=1 expecting=i32
[INFO] [stdout] 2025-06-29T14:00:47.399821Z TRACE deser_incomplete::reporter::default_reporter: start deserialize_i32 nesting_level=1 expecting=i32
[INFO] [stdout] 2025-06-29T14:00:47.399830Z TRACE deser_incomplete::reporter::default_reporter: receive visit_u64 nesting_level=1 v=3
[INFO] [stdout] 2025-06-29T14:00:47.399838Z TRACE deser_incomplete::reporter::default_reporter: receive visit_u64 nesting_level=1 v=3
[INFO] [stdout] 2025-06-29T14:00:47.399847Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_primitive nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399854Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_primitive nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399861Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399868Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399883Z TRACE deser_incomplete::reporter::default_reporter: finish deserializing next element nesting_level=1 present=true
[INFO] [stdout] 2025-06-29T14:00:47.399892Z TRACE deser_incomplete::reporter::default_reporter: finish deserializing next element nesting_level=1 present=true
[INFO] [stdout] 2025-06-29T14:00:47.399901Z TRACE deser_incomplete::attempt::access: leaving self.inside_element=Some(InsideElement { corresponding_halting_point: HaltingPoint(3), halting_point_is_on_stack: true }) self.attempt.halting_point_stack=[HaltingPoint(3)]
[INFO] [stdout] 2025-06-29T14:00:47.399909Z TRACE deser_incomplete::attempt::access: leaving self.inside_element=Some(InsideElement { corresponding_halting_point: HaltingPoint(3), halting_point_is_on_stack: true }) self.attempt.halting_point_stack=[HaltingPoint(3)]
[INFO] [stdout] 2025-06-29T14:00:47.399919Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 4
[INFO] [stdout] 2025-06-29T14:00:47.399927Z TRACE deser_incomplete::reporter::default_reporter: new halting point nesting_level=1 point=halting point 4
[INFO] [stdout] 2025-06-29T14:00:47.399938Z TRACE deser_incomplete::reporter::default_reporter: start intervention nesting_level=1 reason=PlannedHalting { at: HaltingPoint(4) } halting_point_stack="[[]]"
[INFO] [stdout] 2025-06-29T14:00:47.399949Z TRACE deser_incomplete::reporter::default_reporter: start intervention nesting_level=1 reason=PlannedHalting { at: HaltingPoint(4) } halting_point_stack="[[]]"
[INFO] [stdout] 2025-06-29T14:00:47.399961Z TRACE deser_incomplete::reporter::default_reporter: not deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399967Z TRACE deser_incomplete::reporter::default_reporter: not deserializing next element nesting_level=1
[INFO] [stdout] 2025-06-29T14:00:47.399975Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_seq nesting_level=0
[INFO] [stdout] 2025-06-29T14:00:47.399981Z TRACE deser_incomplete::reporter::default_reporter: finish receive visit_seq nesting_level=0
[INFO] [stdout] 2025-06-29T14:00:47.399990Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=0 error=trailing characters at line 1 column 7
[INFO] [stdout] 2025-06-29T14:00:47.399999Z TRACE deser_incomplete::reporter::default_reporter: finish deserialize nesting_level=0 error=trailing characters at line 1 column 7
[INFO] [stdout] 2025-06-29T14:00:47.400008Z TRACE deser_incomplete::reporter::default_reporter: deserializer failed, but we return Ok with value from the visitor nesting_level=0
[INFO] [stdout] 2025-06-29T14:00:47.400014Z TRACE deser_incomplete::reporter::default_reporter: deserializer failed, but we return Ok with value from the visitor nesting_level=0
[INFO] [stdout] test regression_issue_2 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "90444b997cc6c11c12788373a59219ea9cb743b61103b7fdde7017fc25999ea3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "90444b997cc6c11c12788373a59219ea9cb743b61103b7fdde7017fc25999ea3", kill_on_drop: false }`
[INFO] [stdout] 90444b997cc6c11c12788373a59219ea9cb743b61103b7fdde7017fc25999ea3