[INFO] fetching crate spiritless_po 1.0.0...
[INFO] testing spiritless_po-1.0.0 against try#2440211fe03bc45c89b6dc1a3df18382ce91e32b for pr-146098-1
[INFO] extracting crate spiritless_po 1.0.0 into /workspace/builds/worker-1-tc2/source
[INFO] started tweaking crates.io crate spiritless_po 1.0.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate spiritless_po 1.0.0
[INFO] tweaked toml for crates.io crate spiritless_po 1.0.0 written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate spiritless_po 1.0.0 on toolchain 2440211fe03bc45c89b6dc1a3df18382ce91e32b
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate spiritless_po 1.0.0 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" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 498f3496939a4878283802b755765a94f18bd94faabc6518e01be1d1870b4aed
[INFO] running `Command { std: "docker" "start" "-a" "498f3496939a4878283802b755765a94f18bd94faabc6518e01be1d1870b4aed", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "498f3496939a4878283802b755765a94f18bd94faabc6518e01be1d1870b4aed", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "498f3496939a4878283802b755765a94f18bd94faabc6518e01be1d1870b4aed", kill_on_drop: false }`
[INFO] [stdout] 498f3496939a4878283802b755765a94f18bd94faabc6518e01be1d1870b4aed
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ceaafbdf9accf2f7eb922694eda905ded699070f0f53c8d53703090e339e6f62
[INFO] running `Command { std: "docker" "start" "-a" "ceaafbdf9accf2f7eb922694eda905ded699070f0f53c8d53703090e339e6f62", kill_on_drop: false }`
[INFO] [stderr]    Compiling spiritless_po v1.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.88s
[INFO] running `Command { std: "docker" "inspect" "ceaafbdf9accf2f7eb922694eda905ded699070f0f53c8d53703090e339e6f62", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ceaafbdf9accf2f7eb922694eda905ded699070f0f53c8d53703090e339e6f62", kill_on_drop: false }`
[INFO] [stdout] ceaafbdf9accf2f7eb922694eda905ded699070f0f53c8d53703090e339e6f62
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ec7423f6034ff7296bd67c07977f7726a2e1b168f4a8c2979698a9880a28add0
[INFO] running `Command { std: "docker" "start" "-a" "ec7423f6034ff7296bd67c07977f7726a2e1b168f4a8c2979698a9880a28add0", kill_on_drop: false }`
[INFO] [stderr]    Compiling spiritless_po v1.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.54s
[INFO] running `Command { std: "docker" "inspect" "ec7423f6034ff7296bd67c07977f7726a2e1b168f4a8c2979698a9880a28add0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ec7423f6034ff7296bd67c07977f7726a2e1b168f4a8c2979698a9880a28add0", kill_on_drop: false }`
[INFO] [stdout] ec7423f6034ff7296bd67c07977f7726a2e1b168f4a8c2979698a9880a28add0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] f4a112b4712c42c68836173cd285300b7c2402c28c9489957ffd00de3e4cea69
[INFO] running `Command { std: "docker" "start" "-a" "f4a112b4712c42c68836173cd285300b7c2402c28c9489957ffd00de3e4cea69", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/spiritless_po-7cb9a0346e467959)
[INFO] [stdout] 
[INFO] [stdout] running 79 tests
[INFO] [stdout] test catalog::io_char_iterator::tests::invalid_utf8_sequence_3 ... ok
[INFO] [stdout] test catalog::io_char_iterator::tests::invalid_utf8_sequence_1 ... ok
[INFO] [stdout] test catalog::io_char_iterator::tests::invalid_utf8_sequence_2 ... ok
[INFO] [stdout] test catalog::io_char_iterator::tests::normal_ascii ... ok
[INFO] [stdout] test catalog::io_char_iterator::tests::normal_utf_8 ... ok
[INFO] [stdout] test catalog::io_char_iterator::tests::unexpected_eof_1 ... ok
[INFO] [stdout] test catalog::io_char_iterator::tests::unexpected_eof_2 ... ok
[INFO] [stdout] test catalog::io_char_iterator::tests::line_number ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_logical_operators_priority ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_more_than_32bit_uint_compiled ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_compare_operators_association ... ok
[INFO] [stdout] test catalog::io_char_iterator::tests::unexpected_eof_3 ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_more_than_32bit_uint_interpreter ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_numeric_operators_priority_and_association ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_operators_priority ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_parse_error_colon_in_expression ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_parse_error_eq_and_ne_in_expression ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_parse_error_equal_after_keyword ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_operators ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_parse_error_and_in_expression ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_parse_error_invalid_character_in_expression ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_parse_error_get_number ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_conditional_operator_association ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_parse_error_keyword ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_parse_error_nplurals_invalid_character_and_debug_display ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_parse_error_or_in_expression ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_parse_error_too_big_number ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_parse_error_paren_in_expression ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_parse_error_var_or_num_in_expression ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_parse_error_semicolon_after_keyword ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_parse_spaces_after_keyword ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_empty_stream_in_po_entries ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_back_to_back_entries ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_comment_in_po_entries ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_11 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_12 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_10 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_13 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_error_recovering ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_15 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_17 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_14 ... ok
[INFO] [stdout] test catalog::plural_parser::tests::test_result_of_plural_functions_expected_to_use ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_1 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_19 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_2 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_20 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_21 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_23 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_24 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_22 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_27 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_25 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_29 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_3 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_26 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_30 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_5 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_4 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_7 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_28 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_6 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_18 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_16 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_32 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_31 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_8 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_po_entries_9 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_eof_in_text_of_a_po_entry ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_errors_in_po_entries_2 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_errors_in_po_entries_1 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_escape_sequence ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_fuzzy_po_entries ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_invalid_plural_index_msgstr ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_no_quote_at_beginning_of_text_1 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_multi_line_strings_in_po_entries ... ok
[INFO] [stdout] test tests::it_works ... ok
[INFO] [stderr]      Running tests/test_catalog.rs (/opt/rustwide/target/debug/deps/test_catalog-91ae03864c50b22f)
[INFO] [stdout] test catalog::po_parser::tests::test_no_quote_at_beginning_of_text_2 ... ok
[INFO] [stdout] test catalog::po_parser::tests::test_normal_po_entries ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 79 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test test_add_to_non_empty_catalog ... ok
[INFO] [stdout] test test_add_str_to_empty_catalog ... ok
[INFO] [stdout] test test_add_str_to_non_empty_catalog ... ok
[INFO] [stdout] test test_clear ... ok
[INFO] [stdout] test test_debug ... ok
[INFO] [stdout] test test_add_to_empty_catalog ... ok
[INFO] [stdout] test test_clear_statistics ... ok
[INFO] [stdout] test test_clone ... ok
[INFO] [stdout] test test_untranslated_entry ... ok
[INFO] [stdout] test test_merge_1 ... ok
[INFO] [stdout] test test_default ... ok
[INFO] [stdout] test test_merge_2 ... ok
[INFO] [stdout] test test_metadata_statistics_merge ... ok
[INFO] [stdout] test test_new ... ok
[INFO] [stdout] test test_metadata_statistics_add ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_metadata_parser.rs (/opt/rustwide/target/debug/deps/test_metadata_parser-b9c137fd0c16f09e)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test test_empty_keys_in_metadata ... ok
[INFO] [stdout] test test_incomplete_key_in_metadata ... ok
[INFO] [stdout] test test_duplicate_keys_in_metadata ... ok
[INFO] [stdout] test test_no_nl_at_the_end_in_metadata ... ok
[INFO] [stdout] test test_normal_metadata ... ok
[INFO] [stdout] test test_space_only_value_in_metadata ... ok
[INFO] [stderr]    Doc-tests spiritless_po
[INFO] [stdout] test test_spaces_in_metadata ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test src/catalog.rs - catalog::Catalog::add_bytes (line 159) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 15) - compile ... ok
[INFO] [stdout] test src/lib.rs - ReadmeDoctests (line 209) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 28) ... ok
[INFO] [stdout] test src/lib.rs - ReadmeDoctests (line 171) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.47s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "f4a112b4712c42c68836173cd285300b7c2402c28c9489957ffd00de3e4cea69", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f4a112b4712c42c68836173cd285300b7c2402c28c9489957ffd00de3e4cea69", kill_on_drop: false }`
[INFO] [stdout] f4a112b4712c42c68836173cd285300b7c2402c28c9489957ffd00de3e4cea69