Dec 15 01:51:35.800 INFO testing pfmt-0.4.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 01:51:35.800 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 15 01:51:35.945 INFO [stdout] 64b1076ad7172bb967759df01e5df9181b9e2f8b7c49c01a0088d8e3ab44b670
Dec 15 01:51:35.953 INFO running `"docker" "start" "-a" "64b1076ad7172bb967759df01e5df9181b9e2f8b7c49c01a0088d8e3ab44b670"`
Dec 15 01:51:36.303 INFO [stderr] usermod: no changes
Dec 15 01:51:36.379 INFO [stderr]    Compiling pfmt v0.4.0 (/source)
Dec 15 01:51:39.114 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.79s
Dec 15 01:51:39.117 INFO [stderr] su: No module specific data is present
Dec 15 01:51:39.440 INFO running `"docker" "inspect" "64b1076ad7172bb967759df01e5df9181b9e2f8b7c49c01a0088d8e3ab44b670"`
Dec 15 01:51:39.536 INFO running `"docker" "rm" "-f" "64b1076ad7172bb967759df01e5df9181b9e2f8b7c49c01a0088d8e3ab44b670"`
Dec 15 01:51:39.666 INFO [stdout] 64b1076ad7172bb967759df01e5df9181b9e2f8b7c49c01a0088d8e3ab44b670
Dec 15 01:51:39.668 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 15 01:51:39.925 INFO [stdout] 1e10f9f9d19a899c3a00d7d552c4529741655925f61f48bafc0c239ad46bb11c
Dec 15 01:51:39.932 INFO running `"docker" "start" "-a" "1e10f9f9d19a899c3a00d7d552c4529741655925f61f48bafc0c239ad46bb11c"`
Dec 15 01:51:40.786 INFO [stderr] usermod: no changes
Dec 15 01:51:40.847 INFO [stderr]    Compiling galvanic-test v0.1.5
Dec 15 01:51:40.847 INFO [stderr]    Compiling galvanic-assert v0.8.7
Dec 15 01:51:42.174 INFO [stderr]    Compiling pfmt v0.4.0 (/source)
Dec 15 01:51:48.268 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.46s
Dec 15 01:51:48.285 INFO [stderr] su: No module specific data is present
Dec 15 01:51:48.899 INFO running `"docker" "inspect" "1e10f9f9d19a899c3a00d7d552c4529741655925f61f48bafc0c239ad46bb11c"`
Dec 15 01:51:49.296 INFO running `"docker" "rm" "-f" "1e10f9f9d19a899c3a00d7d552c4529741655925f61f48bafc0c239ad46bb11c"`
Dec 15 01:51:49.667 INFO [stdout] 1e10f9f9d19a899c3a00d7d552c4529741655925f61f48bafc0c239ad46bb11c
Dec 15 01:51:49.675 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 15 01:51:50.121 INFO [stdout] 71f26df2a7103b48e9193d5ca80c1defe9f67b0dfb61adc219a0e9eb88e4afb8
Dec 15 01:51:50.129 INFO running `"docker" "start" "-a" "71f26df2a7103b48e9193d5ca80c1defe9f67b0dfb61adc219a0e9eb88e4afb8"`
Dec 15 01:51:52.041 INFO [stderr] usermod: no changes
Dec 15 01:51:52.171 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.11s
Dec 15 01:51:52.179 INFO [stderr]      Running /target/debug/deps/pfmt-690f3ec8ae2ea19b
Dec 15 01:51:52.179 INFO [stdout] 
Dec 15 01:51:52.179 INFO [stdout] running 69 tests
Dec 15 01:51:52.213 INFO [stdout] test extras::extras_tests::closures::lazy ... ok
Dec 15 01:51:52.214 INFO [stdout] test extras::extras_tests::closures::ad_hoc_full ... ok
Dec 15 01:51:52.215 INFO [stdout] test extras::extras_tests::closures::ad_hoc_args ... ok
Dec 15 01:51:52.223 INFO [stdout] test extras::extras_tests::closures::mutable_lazy ... ok
Dec 15 01:51:52.227 INFO [stdout] test extras::extras_tests::mono::several_monos ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::common_options::truncate_right ... ok
Dec 15 01:51:52.227 INFO [stdout] test extras::extras_tests::closures::ad_hoc_opts ... ok
Dec 15 01:51:52.227 INFO [stdout] test extras::extras_tests::mono::monos_and_hashmaps ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::common_options::truncate_left ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::boolean::flags ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::char::boring ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::floats::norm_rounding_down ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::floats::negative ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::floats::exp_precision_pos ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::floats::norm_rounding_usual ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::general::integers_simple_1 ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::floats::norm_rounding_up ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::general::unknown_fmt ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::general::separated_by_colons ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::general::unknown_fmt_nested ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::integers::base_prefixes ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::integers::bases_for_negative_numbers ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::integers::basic ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::integers::rounding ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::common_options::width_center ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::integers::different_bases ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::floats::exp_precision_neg ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::floats::exp_negative_power ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::common_options::width_right ... ok
Dec 15 01:51:52.227 INFO [stdout] test fmt_tests::common_options::width_left ... ok
Dec 15 01:51:52.235 INFO [stdout] test fmt_tests::integers::rounding_in_different_bases ... ok
Dec 15 01:51:52.235 INFO [stdout] test fmt_tests::nested_fmts::single_nested ... ok
Dec 15 01:51:52.235 INFO [stdout] test fmt_tests::nested_fmts::namespace_only ... ok
Dec 15 01:51:52.235 INFO [stdout] test parse::tests::arguments::empty_arguments ... ok
Dec 15 01:51:52.235 INFO [stdout] test fmt_tests::nested_fmts::double_nested ... ok
Dec 15 01:51:52.235 INFO [stdout] test parse::tests::basic_tests::escapes_in_placeholder_names ... ok
Dec 15 01:51:52.235 INFO [stdout] test parse::tests::arguments::literal_and_placeholder_as_one_arg ... ok
Dec 15 01:51:52.235 INFO [stdout] test parse::tests::arguments::single_argument ... ok
Dec 15 01:51:52.235 INFO [stdout] test parse::tests::arguments::two_literals ... ok
Dec 15 01:51:52.239 INFO [stdout] test parse::tests::basic_tests::escapes_in_literals ... ok
Dec 15 01:51:52.239 INFO [stdout] test fmt_tests::placeholder_substitution::placeholder_in_options ... ok
Dec 15 01:51:52.239 INFO [stdout] test parse::tests::basic_tests::escapes_in_option_names ... ok
Dec 15 01:51:52.239 INFO [stdout] test parse::tests::basic_tests::literal ... ok
Dec 15 01:51:52.239 INFO [stdout] test parse::tests::basic_tests::multiple_options ... ok
Dec 15 01:51:52.239 INFO [stdout] test parse::tests::basic_tests::several_segments_in_name ... ok
Dec 15 01:51:52.243 INFO [stdout] test parse::tests::basic_tests::single_placeholder_1 ... ok
Dec 15 01:51:52.243 INFO [stdout] test parse::tests::basic_tests::flags_after_argument_2 ... ok
Dec 15 01:51:52.243 INFO [stdout] test parse::tests::basic_tests::flags_after_argument_1 ... ok
Dec 15 01:51:52.243 INFO [stdout] test parse::tests::basic_tests::several_placeholders ... ok
Dec 15 01:51:52.243 INFO [stdout] test parse::tests::basic_tests::explicit_separator_before_literal ... ok
Dec 15 01:51:52.243 INFO [stdout] test parse::tests::basic_tests::flags_after_name ... ok
Dec 15 01:51:52.247 INFO [stdout] test fmt_tests::integers::rounding_for_negatives ... ok
Dec 15 01:51:52.247 INFO [stdout] test parse::tests::errors::empty_name_segment_2 ... ok
Dec 15 01:51:52.247 INFO [stdout] test parse::tests::errors::empty_name_segment_3 ... ok
Dec 15 01:51:52.247 INFO [stdout] test parse::tests::errors::empty_name_segment_4 ... ok
Dec 15 01:51:52.247 INFO [stdout] test parse::tests::errors::empty_option_name_1 ... ok
Dec 15 01:51:52.248 INFO [stdout] test parse::tests::errors::empty_option_name_2 ... ok
Dec 15 01:51:52.248 INFO [stdout] test parse::tests::errors::unbalanced_brackets_1 ... ok
Dec 15 01:51:52.251 INFO [stdout] test table_tests::tuples::defaulting ... ok
Dec 15 01:51:52.271 INFO [stdout] test parse::tests::errors::unbalanced_brackets_4 ... ok
Dec 15 01:51:52.271 INFO [stdout] test parse::tests::errors::empty_name_segment_1 ... ok
Dec 15 01:51:52.271 INFO [stdout] test parse::tests::errors::unbalanced_brackets_2 ... ok
Dec 15 01:51:52.271 INFO [stdout] test table_tests::tuples::lifetimes ... ok
Dec 15 01:51:52.271 INFO [stdout] test parse::tests::errors::unbalanced_brackets_3 ... ok
Dec 15 01:51:52.271 INFO [stdout] test parse::tests::basic_tests::single_placeholder_2 ... ok
Dec 15 01:51:52.271 INFO [stdout] test table_tests::tuples::precedence ... ok
Dec 15 01:51:52.275 INFO [stdout] test table_tests::vec::boring ... ok
Dec 15 01:51:52.275 INFO [stdout] test table_tests::vec::unknown_fmt_1 ... ok
Dec 15 01:51:52.283 INFO [stdout] test table_tests::vec::unknown_fmt_2 ... ok
Dec 15 01:51:52.283 INFO [stdout] 
Dec 15 01:51:52.283 INFO [stdout] test result: ok. 69 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 01:51:52.283 INFO [stdout] 
Dec 15 01:51:52.283 INFO [stderr]    Doc-tests pfmt
Dec 15 01:51:54.079 INFO [stdout] 
Dec 15 01:51:54.079 INFO [stdout] running 10 tests
Dec 15 01:52:10.983 INFO [stdout] test src/lib.rs -  (line 140) ... ok
Dec 15 01:52:12.647 INFO [stdout] test src/lib.rs -  (line 268) ... ok
Dec 15 01:52:13.219 INFO [stdout] test src/extras.rs - extras (line 14) ... ok
Dec 15 01:52:13.433 INFO [stdout] test src/lib.rs -  (line 110) ... ok
Dec 15 01:52:13.433 INFO [stdout] test src/lib.rs -  (line 152) ... ok
Dec 15 01:52:13.435 INFO [stdout] test src/extras.rs - extras (line 34) ... ok
Dec 15 01:52:13.723 INFO [stdout] test src/lib.rs -  (line 127) ... ok
Dec 15 01:52:13.772 INFO [stdout] test src/lib.rs -  (line 167) ... ok
Dec 15 01:52:17.699 INFO [stdout] test src/lib.rs -  (line 292) ... ok
Dec 15 01:52:17.891 INFO [stdout] test src/lib.rs -  (line 96) ... ok
Dec 15 01:52:17.891 INFO [stdout] 
Dec 15 01:52:17.891 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 01:52:17.891 INFO [stdout] 
Dec 15 01:52:17.943 INFO [stderr] su: No module specific data is present
Dec 15 01:52:19.237 INFO running `"docker" "inspect" "71f26df2a7103b48e9193d5ca80c1defe9f67b0dfb61adc219a0e9eb88e4afb8"`
Dec 15 01:52:19.521 INFO running `"docker" "rm" "-f" "71f26df2a7103b48e9193d5ca80c1defe9f67b0dfb61adc219a0e9eb88e4afb8"`
Dec 15 01:52:19.766 INFO [stdout] 71f26df2a7103b48e9193d5ca80c1defe9f67b0dfb61adc219a0e9eb88e4afb8