[INFO] fetching crate schemat 0.4.7...
[INFO] testing schemat-0.4.7 against try#b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b for pr-145330-1
[INFO] extracting crate schemat 0.4.7 into /workspace/builds/worker-4-tc2/source
[INFO] removed /workspace/builds/worker-4-tc2/source/rust-toolchain.toml
[INFO] started tweaking crates.io crate schemat 0.4.7
[INFO] finished tweaking crates.io crate schemat 0.4.7
[INFO] tweaked toml for crates.io crate schemat 0.4.7 written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate schemat 0.4.7 on toolchain b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate schemat 0.4.7 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" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] ef6ac78bcc461bc6f48c04c0fefa8cbc373e7c3aae942924663c8aa30b719d29
[INFO] running `Command { std: "docker" "start" "-a" "ef6ac78bcc461bc6f48c04c0fefa8cbc373e7c3aae942924663c8aa30b719d29", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ef6ac78bcc461bc6f48c04c0fefa8cbc373e7c3aae942924663c8aa30b719d29", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ef6ac78bcc461bc6f48c04c0fefa8cbc373e7c3aae942924663c8aa30b719d29", kill_on_drop: false }`
[INFO] [stdout] ef6ac78bcc461bc6f48c04c0fefa8cbc373e7c3aae942924663c8aa30b719d29
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] b31e04914bbd29234cff23575bce9273858aea905cfa8dea061e2b4b74300791
[INFO] running `Command { std: "docker" "start" "-a" "b31e04914bbd29234cff23575bce9273858aea905cfa8dea061e2b4b74300791", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.76
[INFO] [stderr]    Compiling memchr v2.7.1
[INFO] [stderr]    Compiling pin-project-lite v0.2.13
[INFO] [stderr]    Compiling slab v0.4.9
[INFO] [stderr]    Compiling anstyle v1.0.8
[INFO] [stderr]    Compiling bytecount v0.6.7
[INFO] [stderr]    Compiling bumpalo v3.19.0
[INFO] [stderr]    Compiling mfmt v0.4.1
[INFO] [stderr]    Compiling glob v0.3.3
[INFO] [stderr]    Compiling colored v3.0.0
[INFO] [stderr]    Compiling anstream v0.6.11
[INFO] [stderr]    Compiling clap_builder v4.5.48
[INFO] [stderr]    Compiling quote v1.0.35
[INFO] [stderr]    Compiling nom v8.0.0
[INFO] [stderr]    Compiling syn v2.0.58
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling clap_derive v4.5.47
[INFO] [stderr]    Compiling tokio-macros v2.5.0
[INFO] [stderr]    Compiling tokio v1.47.1
[INFO] [stderr]    Compiling nom_locate v5.0.0
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling clap v4.5.48
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling schemat v0.4.7 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 34.80s
[INFO] running `Command { std: "docker" "inspect" "b31e04914bbd29234cff23575bce9273858aea905cfa8dea061e2b4b74300791", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b31e04914bbd29234cff23575bce9273858aea905cfa8dea061e2b4b74300791", kill_on_drop: false }`
[INFO] [stdout] b31e04914bbd29234cff23575bce9273858aea905cfa8dea061e2b4b74300791
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 19f69ca788304478c174260dd8cbe616f7033152ab590daf997059ed4d62357d
[INFO] running `Command { std: "docker" "start" "-a" "19f69ca788304478c174260dd8cbe616f7033152ab590daf997059ed4d62357d", kill_on_drop: false }`
[INFO] [stderr]    Compiling indoc v2.0.6
[INFO] [stderr]    Compiling schemat v0.4.7 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 4.43s
[INFO] running `Command { std: "docker" "inspect" "19f69ca788304478c174260dd8cbe616f7033152ab590daf997059ed4d62357d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "19f69ca788304478c174260dd8cbe616f7033152ab590daf997059ed4d62357d", kill_on_drop: false }`
[INFO] [stdout] 19f69ca788304478c174260dd8cbe616f7033152ab590daf997059ed4d62357d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3c8ab5ea92d007ab0b3ddf38b65e9df6c142aef550df3237db0184ce6c787991
[INFO] running `Command { std: "docker" "start" "-a" "3c8ab5ea92d007ab0b3ddf38b65e9df6c142aef550df3237db0184ce6c787991", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.14s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/schemat-313e172d00171938)
[INFO] [stdout] 
[INFO] [stdout] running 131 tests
[INFO] [stdout] test ast::expression::tests::equal ... ok
[INFO] [stdout] test format::tests::comment::block::inline::format_after_first_expression ... ok
[INFO] [stdout] test format::tests::comment::block::inline::format_after_second_expression ... ok
[INFO] [stdout] test format::tests::comment::block::inline::format_in_empty_list ... ok
[INFO] [stdout] test format::tests::comment::block::inline::format_in_front ... ok
[INFO] [stdout] test format::tests::comment::block::inline::format_many ... ok
[INFO] [stdout] test format::tests::comment::block::multi_line::format_with_blank_lines ... ok
[INFO] [stdout] test format::tests::comment::format_line_and_inline_comments_before_closing_parenthesis ... ok
[INFO] [stdout] test format::tests::comment::format_line_comment ... ok
[INFO] [stdout] test format::tests::comment::block::multi_line::format_with_no_blank_line ... ok
[INFO] [stdout] test format::tests::comment::block::multi_line::format_with_extra_blank_lines ... ok
[INFO] [stdout] test format::tests::comment::format_line_and_inline_comments_before_closing_parenthesis_in_nested_expression ... ok
[INFO] [stdout] test format::tests::comment::format_blank_lines_before_terminal_line_comments ... ok
[INFO] [stdout] test format::tests::comment::format_line_comment_before_closing_parenthesis ... ok
[INFO] [stdout] test format::tests::comment::format_multi_line_comment_after_expression ... ok
[INFO] [stdout] test format::tests::comment::format_line_comments ... ok
[INFO] [stdout] test format::tests::comment::format_multi_line_comment ... ok
[INFO] [stdout] test format::tests::comment::format_multi_line_comment_after_expression_in_list ... ok
[INFO] [stdout] test format::tests::comment::format_multi_line_comment_with_extra_line ... ok
[INFO] [stdout] test format::tests::comment::format_multi_line_comments_with_extra_line ... ok
[INFO] [stdout] test format::tests::comment::format_multi_line_comments ... ok
[INFO] [stdout] test format::tests::comment::format_remaining_multi_line_comment ... ok
[INFO] [stdout] test format::tests::comment::format_remaining_multi_line_comments ... ok
[INFO] [stdout] test format::tests::comment::format_remaining_multi_line_comments_with_extra_line ... ok
[INFO] [stdout] test format::tests::comment::suffix::format_next_line ... ok
[INFO] [stdout] test format::tests::comment::format_line_comment_on_multi_line_expression ... ok
[INFO] [stdout] test format::tests::comment::suffix::format_next_next_line ... ok
[INFO] [stdout] test format::tests::comment::format_line_comment_for_last_argument_in_different_line ... ok
[INFO] [stdout] test format::tests::comment::suffix::format_next_next_line_with_expression_and_inline_comment ... ok
[INFO] [stdout] test format::tests::comment::suffix::format_next_next_line_with_inline_comment ... ok
[INFO] [stdout] test format::tests::data::format_broken_list_with_empty_line ... ok
[INFO] [stdout] test format::tests::data::format_first_element_on_second_line ... ok
[INFO] [stdout] test format::tests::data::format_list ... ok
[INFO] [stdout] test format::tests::data::format_broken_list ... ok
[INFO] [stdout] test format::tests::data::format_line_comment_on_multi_line_expression ... ok
[INFO] [stdout] test format::tests::data::nested::format_broken_nested_lists ... ok
[INFO] [stdout] test format::tests::data::nested::format_nested_unquote ... ok
[INFO] [stdout] test format::tests::data::nested::format_splicing_unquote ... ok
[INFO] [stdout] test format::tests::format_empty ... ok
[INFO] [stdout] test format::tests::data::nested::format_nested_lists ... ok
[INFO] [stdout] test format::tests::format_list ... ok
[INFO] [stdout] test format::tests::format_list_with_split_lines ... ok
[INFO] [stdout] test format::tests::format_list_with_split_lines_and_multiple_elements ... ok
[INFO] [stdout] test format::tests::format_multi_line_string ... ok
[INFO] [stdout] test format::tests::format_string ... ok
[INFO] [stdout] test format::tests::format_symbol ... ok
[INFO] [stdout] test format::tests::format_vector ... ok
[INFO] [stdout] test format::tests::format_quote ... ok
[INFO] [stdout] test format::tests::format_unquote ... ok
[INFO] [stdout] test format::tests::hash_directive::format_hash_directive ... ok
[INFO] [stdout] test format::tests::format_quoted_symbol ... ok
[INFO] [stdout] test format::tests::hash_directive::format_hash_directive_with_expression ... ok
[INFO] [stdout] test format::tests::hash_directive::format_hash_directives ... ok
[INFO] [stdout] test format::tests::list::format_blank_line ... ok
[INFO] [stdout] test format::tests::list::format_blank_lines ... ok
[INFO] [stdout] test format::tests::list::format_first_element_on_second_line ... ok
[INFO] [stdout] test format::tests::list::double_indent_of_nested_list ... ok
[INFO] [stdout] test format::tests::module::keep_blank_line ... ok
[INFO] [stdout] test format::tests::module::keep_no_blank_line ... ok
[INFO] [stdout] test format::tests::list::format_blank_lines_with_multi_line_expression ... ok
[INFO] [stdout] test parse::error::tests::to_string ... ok
[INFO] [stdout] test format::tests::list::format_broken_nested_lists_with_offside ... ok
[INFO] [stdout] test format::tests::comment::block::inline::format_after_third_expression ... ok
[INFO] [stdout] test parse::parser::tests::boolean::parse_boolean_followed_by_comment ... ok
[INFO] [stdout] test format::tests::comment::suffix::format_same_line ... ok
[INFO] [stdout] test parse::parser::tests::comment::block::parse_in_comments ... ok
[INFO] [stdout] test parse::parser::tests::boolean::parse_boolean_followed_by_right_parenthesis ... ok
[INFO] [stdout] test parse::parser::tests::boolean::parse_false ... ok
[INFO] [stdout] test parse::parser::tests::comment::block::parse_empty ... ok
[INFO] [stdout] test parse::parser::tests::comment::block::parse_multi_line ... ok
[INFO] [stdout] test parse::parser::tests::comment::block::parse_one_line ... ok
[INFO] [stdout] test parse::parser::tests::comment::parse_comment ... ok
[INFO] [stdout] test parse::parser::tests::boolean::parse_true ... ok
[INFO] [stdout] test parse::parser::tests::comment::parse_comment_character ... ok
[INFO] [stdout] test parse::parser::tests::comment::parse_comment_in_list ... ok
[INFO] [stdout] test parse::parser::tests::comment::parse_comments_skipping_hash_character ... ok
[INFO] [stdout] test parse::parser::tests::comment::parse_comments_with_blank_lines ... ok
[INFO] [stdout] test parse::parser::tests::comment::parse_comment_with_vector ... ok
[INFO] [stdout] test parse::parser::tests::comment::parse_comments_skipping_hash_semicolon ... ok
[INFO] [stdout] test parse::parser::tests::comment::parse_comments ... ok
[INFO] [stdout] test parse::parser::tests::hash_directive::parse_comment ... ok
[INFO] [stdout] test parse::parser::tests::hash_directive::parse_lang_directive ... ok
[INFO] [stdout] test parse::parser::tests::comment::parse_empty ... ok
[INFO] [stdout] test parse::parser::tests::hash_directive::parse_shebang ... ok
[INFO] [stdout] test parse::parser::tests::parse_bracket_vector ... ok
[INFO] [stdout] test parse::parser::tests::parse_character ... ok
[INFO] [stdout] test parse::parser::tests::parse_invalid_symbol ... ok
[INFO] [stdout] test parse::parser::tests::parse_list ... ok
[INFO] [stdout] test parse::parser::tests::parse_list_with_correct_position ... ok
[INFO] [stdout] test parse::parser::tests::parse_byte_vector ... ok
[INFO] [stdout] test parse::parser::tests::parse_quoted_symbol ... ok
[INFO] [stdout] test parse::parser::tests::parse_vector ... ok
[INFO] [stdout] test parse::parser::tests::quote::parse_hash_semicolon_quote ... ok
[INFO] [stdout] test format::tests::list::format_broken_nested_lists ... ok
[INFO] [stdout] test parse::parser::tests::quote::parse_quasi_quote ... ok
[INFO] [stdout] test parse::parser::tests::quote::parse_hash_quote ... ok
[INFO] [stdout] test parse::parser::tests::parse_symbol ... ok
[INFO] [stdout] test parse::parser::tests::parse_map ... ok
[INFO] [stdout] test parse::parser::tests::quote::parse_quote ... ok
[INFO] [stdout] test parse::parser::tests::quote::parse_quote_with_correct_position ... ok
[INFO] [stdout] test parse::parser::tests::quote::parse_quote_with_space ... ok
[INFO] [stdout] test parse::parser::tests::quote::parse_unquote ... ok
[INFO] [stdout] test parse::parser::tests::string::parse_empty ... ok
[INFO] [stdout] test parse::parser::tests::quote::parse_symbol_and_quoted_list ... ok
[INFO] [stdout] test parse::parser::tests::string::parse_escaped_characters ... ok
[INFO] [stdout] test parse::parser::tests::string::parse_escaped_double_quote ... ok
[INFO] [stdout] test parse::parser::tests::string::parse_escaped_single_quote ... ok
[INFO] [stdout] test parse::parser::tests::string::parse_escaped_unicode ... ok
[INFO] [stdout] test parse::parser::tests::string::parse_multi_line ... ok
[INFO] [stdout] test parse::parser::tests::string::parse_non_empty ... ok
[INFO] [stdout] test parse::parser::tests::string::parse_scheme_hexadecimal_bytes ... ok
[INFO] [stdout] test parse::parser::tests::string::parse_wasm_hexadecimal_bytes ... ok
[INFO] [stdout] test parse::tests::parse_empty_list ... ok
[INFO] [stdout] test parse::tests::parse_lang_directive ... ok
[INFO] [stdout] test parse::tests::parse_last_boolean_in_list ... ok
[INFO] [stdout] test parse::tests::parse_list_with_element ... ok
[INFO] [stdout] test parse::tests::parse_list_with_elements ... ok
[INFO] [stdout] test parse::tests::parse_nothing ... ok
[INFO] [stdout] test parse::tests::parse_shebang ... ok
[INFO] [stdout] test parse::tests::parse_symbol ... ok
[INFO] [stdout] test parse::tests::parse_symbol_quoted_by_hash_and_single_quote ... ok
[INFO] [stdout] test parse::tests::parse_symbol_starting_with_escaped_hash ... ok
[INFO] [stdout] test parse::tests::parse_vector ... ok
[INFO] [stdout] test position_map::tests::line_index::get_line_in_line ... ok
[INFO] [stdout] test position_map::tests::line_index::get_line_in_two_lines ... ok
[INFO] [stdout] test position_map::tests::line_index::get_line_of_empty_source ... ok
[INFO] [stdout] test position_map::tests::line_range::get_in_line ... ok
[INFO] [stdout] test position_map::tests::line_range::get_in_line_with_newline ... ok
[INFO] [stdout] test position_map::tests::line_range::get_in_lines ... ok
[INFO] [stdout] test position_map::tests::slice ... ok
[INFO] [stdout] test parse::parser::tests::quote::parse_splicing_unquote ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 131 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "3c8ab5ea92d007ab0b3ddf38b65e9df6c142aef550df3237db0184ce6c787991", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3c8ab5ea92d007ab0b3ddf38b65e9df6c142aef550df3237db0184ce6c787991", kill_on_drop: false }`
[INFO] [stdout] 3c8ab5ea92d007ab0b3ddf38b65e9df6c142aef550df3237db0184ce6c787991