[INFO] fetching crate phpserz 0.2.2...
[INFO] testing phpserz-0.2.2 against master#c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38 for pr-146098-8
[INFO] extracting crate phpserz 0.2.2 into /workspace/builds/worker-3-tc1/source
[INFO] started tweaking crates.io crate phpserz 0.2.2
[INFO] finished tweaking crates.io crate phpserz 0.2.2
[INFO] tweaked toml for crates.io crate phpserz 0.2.2 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate phpserz 0.2.2 on toolchain c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate phpserz 0.2.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" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 450163603a047ddec5e5285ff9745f860911cf541de5c15976a63f79b375c1cc
[INFO] running `Command { std: "docker" "start" "-a" "450163603a047ddec5e5285ff9745f860911cf541de5c15976a63f79b375c1cc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "450163603a047ddec5e5285ff9745f860911cf541de5c15976a63f79b375c1cc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "450163603a047ddec5e5285ff9745f860911cf541de5c15976a63f79b375c1cc", kill_on_drop: false }`
[INFO] [stdout] 450163603a047ddec5e5285ff9745f860911cf541de5c15976a63f79b375c1cc
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 372b3bc228fcc787bb83ea15fa99b9f3a1a783b9716aca8eeebf27a0282d32c4
[INFO] running `Command { std: "docker" "start" "-a" "372b3bc228fcc787bb83ea15fa99b9f3a1a783b9716aca8eeebf27a0282d32c4", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde v1.0.219
[INFO] [stderr]    Compiling fast-float2 v0.2.3
[INFO] [stderr]    Compiling phpserz v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 3.31s
[INFO] running `Command { std: "docker" "inspect" "372b3bc228fcc787bb83ea15fa99b9f3a1a783b9716aca8eeebf27a0282d32c4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "372b3bc228fcc787bb83ea15fa99b9f3a1a783b9716aca8eeebf27a0282d32c4", kill_on_drop: false }`
[INFO] [stdout] 372b3bc228fcc787bb83ea15fa99b9f3a1a783b9716aca8eeebf27a0282d32c4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5c41a197e9ce305894dd5e052362f42212d717a24eb418983a35e50e75157828
[INFO] running `Command { std: "docker" "start" "-a" "5c41a197e9ce305894dd5e052362f42212d717a24eb418983a35e50e75157828", kill_on_drop: false }`
[INFO] [stderr]    Compiling aho-corasick v1.1.3
[INFO] [stderr]    Compiling indexmap v2.9.0
[INFO] [stderr]    Compiling serde v1.0.219
[INFO] [stderr]    Compiling syn v2.0.100
[INFO] [stderr]    Compiling glob v0.3.2
[INFO] [stderr]    Compiling toml_edit v0.22.24
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling proc-macro-crate v3.3.0
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling serde_derive v1.0.219
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling rstest_macros v0.26.1
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling rstest v0.26.1
[INFO] [stderr]    Compiling phpserz v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 28.09s
[INFO] running `Command { std: "docker" "inspect" "5c41a197e9ce305894dd5e052362f42212d717a24eb418983a35e50e75157828", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5c41a197e9ce305894dd5e052362f42212d717a24eb418983a35e50e75157828", kill_on_drop: false }`
[INFO] [stdout] 5c41a197e9ce305894dd5e052362f42212d717a24eb418983a35e50e75157828
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 8cef208b608c938e7770bc99032e577d838b4ed1e5db811b892479c346b956be
[INFO] running `Command { std: "docker" "start" "-a" "8cef208b608c938e7770bc99032e577d838b4ed1e5db811b892479c346b956be", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/phpserz-4d0eecf2fd961d32)
[INFO] [stdout] 
[INFO] [stdout] running 116 tests
[INFO] [stdout] test de::tests::test_deserialize_assoc_array_to_tuple_vec ... ok
[INFO] [stdout] test de::tests::test_deserialize_boolean ... ok
[INFO] [stdout] test de::tests::test_deserialize_enum ... ok
[INFO] [stdout] test de::tests::test_deserialize_borrowed_str ... ok
[INFO] [stdout] test de::tests::test_deserialize_enum_in_struct ... ok
[INFO] [stdout] test de::tests::test_deserialize_float ... ok
[INFO] [stdout] test de::tests::test_deserialize_integer ... ok
[INFO] [stdout] test de::tests::test_deserialize_mixed_key_array_to_tuple_vec ... ok
[INFO] [stdout] test de::tests::test_deserialize_large_integer ... ok
[INFO] [stdout] test de::tests::test_deserialize_negative_large_integer ... ok
[INFO] [stdout] test de::tests::test_deserialize_null ... ok
[INFO] [stdout] test de::tests::test_deserialize_object ... ok
[INFO] [stdout] test de::tests::test_deserialize_object_with_null ... ok
[INFO] [stdout] test de::tests::test_deserialize_object_wrapper ... ok
[INFO] [stdout] test de::tests::test_deserialize_option_some ... ok
[INFO] [stdout] test de::tests::test_deserialize_str_explicitly ... ok
[INFO] [stdout] test de::tests::test_deserialize_string_comparison_with_bytes ... ok
[INFO] [stdout] test de::tests::test_deserialize_string ... ok
[INFO] [stdout] test de::tests::test_deserialize_string_explicitly ... ok
[INFO] [stdout] test de::tests::test_from_parser_and_into_parser ... ok
[INFO] [stdout] test de::tests::test_nested_object_with_from_parser ... ok
[INFO] [stdout] test de::tests::test_invalid_utf8_string ... ok
[INFO] [stdout] test de::tests::test_partial_deserialization ... ok
[INFO] [stdout] test de::tests::test_readme ... ok
[INFO] [stdout] test parser::tests::test_invalid_array_structure::case_3 ... ok
[INFO] [stdout] test parser::tests::test_invalid_boolean_values::case_1 ... ok
[INFO] [stdout] test de::tests::test_deserialize_assoc_array_to_hashmap ... ok
[INFO] [stdout] test de::tests::test_unicode_string ... ok
[INFO] [stdout] test parser::tests::test_invalid_array_structure::case_1 ... ok
[INFO] [stdout] test parser::tests::test_invalid_boolean_values::case_3 ... ok
[INFO] [stdout] test parser::tests::test_invalid_boolean_values::case_4 ... ok
[INFO] [stdout] test parser::tests::test_invalid_boolean_values::case_5 ... ok
[INFO] [stdout] test parser::tests::test_invalid_float_values::case_1 ... ok
[INFO] [stdout] test parser::tests::test_invalid_float_values::case_3 ... ok
[INFO] [stdout] test parser::tests::test_invalid_float_values::case_2 ... ok
[INFO] [stdout] test de::tests::test_deserialize_external_tagged_enum ... ok
[INFO] [stdout] test de::tests::test_deserialize_nested_assoc_array ... ok
[INFO] [stdout] test parser::tests::test_invalid_float_values::case_4 ... ok
[INFO] [stdout] test parser::tests::test_invalid_integer_values::case_1 ... ok
[INFO] [stdout] test parser::tests::test_invalid_integer_values::case_2 ... ok
[INFO] [stdout] test parser::tests::test_invalid_integer_values::case_3 ... ok
[INFO] [stdout] test parser::tests::test_invalid_integer_values::case_4 ... ok
[INFO] [stdout] test parser::tests::test_invalid_integer_values::case_5 ... ok
[INFO] [stdout] test parser::tests::test_invalid_integer_values::case_6 ... ok
[INFO] [stdout] test parser::tests::test_invalid_integer_values::case_7 ... ok
[INFO] [stdout] test parser::tests::test_invalid_integer_values::case_8 ... ok
[INFO] [stdout] test parser::tests::test_invalid_object_structure::case_1 ... ok
[INFO] [stdout] test parser::tests::test_invalid_object_structure::case_2 ... ok
[INFO] [stdout] test parser::tests::test_invalid_object_structure::case_4 ... ok
[INFO] [stdout] test parser::tests::test_invalid_object_structure::case_3 ... ok
[INFO] [stdout] test parser::tests::test_invalid_object_structure::case_5 ... ok
[INFO] [stdout] test parser::tests::test_invalid_integer_values::case_9 ... ok
[INFO] [stdout] test parser::tests::test_invalid_object_structure::case_6 ... ok
[INFO] [stdout] test parser::tests::test_invalid_reference::case_1 ... ok
[INFO] [stdout] test parser::tests::test_invalid_reference::case_2 ... ok
[INFO] [stdout] test parser::tests::test_invalid_reference::case_3 ... ok
[INFO] [stdout] test parser::tests::test_invalid_string_length_format::case_2 ... ok
[INFO] [stdout] test parser::tests::test_invalid_string_length_format::case_3 ... ok
[INFO] [stdout] test parser::tests::test_invalid_token ... ok
[INFO] [stdout] test parser::tests::test_parse_array ... ok
[INFO] [stdout] test parser::tests::test_parse_boolean ... ok
[INFO] [stdout] test parser::tests::test_parse_float::case_1 ... ok
[INFO] [stdout] test parser::tests::test_parse_complex_structure ... ok
[INFO] [stdout] test parser::tests::test_parse_float::case_2 ... ok
[INFO] [stdout] test parser::tests::test_parse_float::case_3 ... ok
[INFO] [stdout] test parser::tests::test_parse_float::case_4 ... ok
[INFO] [stdout] test parser::tests::test_parse_float::case_5 ... ok
[INFO] [stdout] test parser::tests::test_invalid_reference::case_4 ... ok
[INFO] [stdout] test parser::tests::test_parse_float::case_7 ... ok
[INFO] [stdout] test parser::tests::test_parse_float::case_8 ... ok
[INFO] [stdout] test parser::tests::test_parse_float::case_6 ... ok
[INFO] [stdout] test parser::tests::test_parse_integer::case_3 ... ok
[INFO] [stdout] test parser::tests::test_parse_integer::case_1 ... ok
[INFO] [stdout] test parser::tests::test_parse_integer::case_4 ... ok
[INFO] [stdout] test parser::tests::test_parse_integer::case_5 ... ok
[INFO] [stdout] test parser::tests::test_parse_integer::case_6 ... ok
[INFO] [stdout] test parser::tests::test_parse_integer::case_7 ... ok
[INFO] [stdout] test parser::tests::test_parse_integer::case_8 ... ok
[INFO] [stdout] test parser::tests::test_multiple_peeks ... ok
[INFO] [stdout] test parser::tests::test_parse_integer::case_2 ... ok
[INFO] [stdout] test de::tests::test_deserialize_borrowed_bytes_fallback ... ok
[INFO] [stdout] test parser::tests::test_invalid_boolean_values::case_2 ... ok
[INFO] [stdout] test parser::tests::test_parse_null ... ok
[INFO] [stdout] test parser::tests::test_parse_object ... ok
[INFO] [stdout] test parser::tests::test_parse_property::case_1 ... ok
[INFO] [stdout] test parser::tests::test_parse_property::case_2 ... ok
[INFO] [stdout] test parser::tests::test_parse_property::case_4 ... ok
[INFO] [stdout] test parser::tests::test_parse_property::case_5 ... ok
[INFO] [stdout] test parser::tests::test_parse_string::case_02 ... ok
[INFO] [stdout] test parser::tests::test_parse_string::case_03 ... ok
[INFO] [stdout] test parser::tests::test_parse_string::case_04 ... ok
[INFO] [stdout] test parser::tests::test_parse_string::case_05 ... ok
[INFO] [stdout] test parser::tests::test_parse_string::case_06 ... ok
[INFO] [stdout] test parser::tests::test_parse_string::case_07 ... ok
[INFO] [stdout] test parser::tests::test_parse_string::case_08 ... ok
[INFO] [stdout] test parser::tests::test_parse_string::case_09 ... ok
[INFO] [stdout] test parser::tests::test_parse_string::case_10 ... ok
[INFO] [stdout] test parser::tests::test_position_with_complex_structure ... ok
[INFO] [stdout] test parser::tests::test_position_with_consume_lookahead ... ok
[INFO] [stdout] test parser::tests::test_position_with_peek ... ok
[INFO] [stdout] test parser::tests::test_invalid_string_length_format::case_1 ... ok
[INFO] [stdout] test parser::tests::test_invalid_array_structure::case_2 ... ok
[INFO] [stdout] test parser::tests::test_parse_property::case_3 ... ok
[INFO] [stdout] test parser::tests::test_parse_string::case_01 ... ok
[INFO] [stdout] test parser::tests::test_string_content_mismatch::case_2 ... ok
[INFO] [stdout] test parser::tests::test_string_content_mismatch::case_3 ... ok
[INFO] [stdout] test parser::tests::test_string_content_mismatch::case_4 ... ok
[INFO] [stdout] test parser::tests::test_string_content_mismatch::case_5 ... ok
[INFO] [stdout] test parser::tests::test_unexpected_end_of_input::case_1 ... ok
[INFO] [stdout] test parser::tests::test_peek_after_next ... ok
[INFO] [stdout] test parser::tests::test_position_tracking ... ok
[INFO] [stdout] test parser::tests::test_position_with_nested_structures ... ok
[INFO] [stdout] test parser::tests::test_readme ... ok
[INFO] [stdout] test parser::tests::test_string_content_mismatch::case_1 ... ok
[INFO] [stdout] test parser::tests::test_unexpected_end_of_input::case_2 ... ok
[INFO] [stdout] test parser::tests::test_unexpected_end_of_input::case_3 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 116 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests phpserz
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test README.md - (line 100) ... ok
[INFO] [stdout] test README.md - (line 45) ... ok
[INFO] [stdout] test src/parser.rs - parser::PhpParser<'a>::peek_token (line 206) ... ok
[INFO] [stdout] test src/parser.rs - parser::PhpParser<'a>::next_token (line 236) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.99s; merged doctests compilation took 0.98s
[INFO] running `Command { std: "docker" "inspect" "8cef208b608c938e7770bc99032e577d838b4ed1e5db811b892479c346b956be", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8cef208b608c938e7770bc99032e577d838b4ed1e5db811b892479c346b956be", kill_on_drop: false }`
[INFO] [stdout] 8cef208b608c938e7770bc99032e577d838b4ed1e5db811b892479c346b956be