Dec 14 22:09:11.990 INFO testing runtime-fmt-0.3.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550 Dec 14 22:09:11.990 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 14 22:09:12.198 INFO [stdout] d83843d7af700f0a30374c83b910e9424c327a32c8b8b48da1795a2fa45c04d4 Dec 14 22:09:12.204 INFO running `"docker" "start" "-a" "d83843d7af700f0a30374c83b910e9424c327a32c8b8b48da1795a2fa45c04d4"` Dec 14 22:09:12.680 INFO [stderr] usermod: no changes Dec 14 22:09:12.714 INFO [stderr] Compiling runtime-fmt v0.3.0 (/source) Dec 14 22:09:13.471 INFO [stderr] warning: the feature `conservative_impl_trait` has been stable since 1.26.0 and no longer requires an attribute to enable Dec 14 22:09:13.471 INFO [stderr] --> src/lib.rs:18:12 Dec 14 22:09:13.471 INFO [stderr] | Dec 14 22:09:13.471 INFO [stderr] 18 | #![feature(conservative_impl_trait)] Dec 14 22:09:13.471 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^ Dec 14 22:09:13.471 INFO [stderr] | Dec 14 22:09:13.471 INFO [stderr] = note: #[warn(stable_features)] on by default Dec 14 22:09:13.471 INFO [stderr] Dec 14 22:09:13.800 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1.10s Dec 14 22:09:13.803 INFO [stderr] su: No module specific data is present Dec 14 22:09:14.222 INFO running `"docker" "inspect" "d83843d7af700f0a30374c83b910e9424c327a32c8b8b48da1795a2fa45c04d4"` Dec 14 22:09:14.316 INFO running `"docker" "rm" "-f" "d83843d7af700f0a30374c83b910e9424c327a32c8b8b48da1795a2fa45c04d4"` Dec 14 22:09:14.392 INFO [stdout] d83843d7af700f0a30374c83b910e9424c327a32c8b8b48da1795a2fa45c04d4 Dec 14 22:09:14.397 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 14 22:09:14.639 INFO [stdout] 69b0a6e4035c41e7a9a0793ec8fc0c3796b59f5f733ccff8905cf0ded4fdabd1 Dec 14 22:09:14.644 INFO running `"docker" "start" "-a" "69b0a6e4035c41e7a9a0793ec8fc0c3796b59f5f733ccff8905cf0ded4fdabd1"` Dec 14 22:09:15.043 INFO [stderr] usermod: no changes Dec 14 22:09:15.091 INFO [stderr] Compiling runtime-fmt-derive v0.2.0 Dec 14 22:09:17.237 INFO [stderr] Compiling runtime-fmt v0.3.0 (/source) Dec 14 22:09:20.827 INFO [stderr] warning: the feature `conservative_impl_trait` has been stable since 1.26.0 and no longer requires an attribute to enable Dec 14 22:09:20.827 INFO [stderr] --> src/lib.rs:18:12 Dec 14 22:09:20.827 INFO [stderr] | Dec 14 22:09:20.827 INFO [stderr] 18 | #![feature(conservative_impl_trait)] Dec 14 22:09:20.827 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^ Dec 14 22:09:20.827 INFO [stderr] | Dec 14 22:09:20.827 INFO [stderr] = note: #[warn(stable_features)] on by default Dec 14 22:09:20.827 INFO [stderr] Dec 14 22:09:24.161 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 9.10s Dec 14 22:09:24.171 INFO [stderr] su: No module specific data is present Dec 14 22:09:24.480 INFO running `"docker" "inspect" "69b0a6e4035c41e7a9a0793ec8fc0c3796b59f5f733ccff8905cf0ded4fdabd1"` Dec 14 22:09:24.571 INFO running `"docker" "rm" "-f" "69b0a6e4035c41e7a9a0793ec8fc0c3796b59f5f733ccff8905cf0ded4fdabd1"` Dec 14 22:09:24.743 INFO [stdout] 69b0a6e4035c41e7a9a0793ec8fc0c3796b59f5f733ccff8905cf0ded4fdabd1 Dec 14 22:09:24.750 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 14 22:09:24.950 INFO [stdout] ef7456de3946dce28647e01f011ed94c93e32751e6fbc7b4db9d229feb2a01bb Dec 14 22:09:24.951 INFO running `"docker" "start" "-a" "ef7456de3946dce28647e01f011ed94c93e32751e6fbc7b4db9d229feb2a01bb"` Dec 14 22:09:25.341 INFO [stderr] usermod: no changes Dec 14 22:09:25.378 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.02s Dec 14 22:09:25.379 INFO [stderr] Running /target/debug/deps/runtime_fmt-4ed3d9bf9a38ee0d Dec 14 22:09:25.388 INFO [stdout] Dec 14 22:09:25.388 INFO [stdout] running 14 tests Dec 14 22:09:25.396 INFO [stdout] test fmt_macros::tests::format_mixture ... ok Dec 14 22:09:25.396 INFO [stdout] test fmt_macros::tests::format_counts ... ok Dec 14 22:09:25.396 INFO [stdout] test fmt_macros::tests::format_nothing ... ok Dec 14 22:09:25.396 INFO [stdout] test fmt_macros::tests::format_flags ... ok Dec 14 22:09:25.396 INFO [stdout] test fmt_macros::tests::format_align_fill ... ok Dec 14 22:09:25.396 INFO [stdout] test fmt_macros::tests::invalid01 ... ok Dec 14 22:09:25.396 INFO [stdout] test fmt_macros::tests::invalid04 ... ok Dec 14 22:09:25.396 INFO [stdout] test fmt_macros::tests::invalid05 ... ok Dec 14 22:09:25.396 INFO [stdout] test fmt_macros::tests::invalid06 ... ok Dec 14 22:09:25.396 INFO [stdout] test fmt_macros::tests::invalid02 ... ok Dec 14 22:09:25.396 INFO [stdout] test fmt_macros::tests::simple ... ok Dec 14 22:09:25.398 INFO [stdout] test fmt_macros::tests::format_position ... ok Dec 14 22:09:25.398 INFO [stdout] test fmt_macros::tests::format_type ... ok Dec 14 22:09:25.398 INFO [stdout] test fmt_macros::tests::format_position_nothing_else ... ok Dec 14 22:09:25.398 INFO [stdout] Dec 14 22:09:25.398 INFO [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 14 22:09:25.398 INFO [stdout] Dec 14 22:09:25.398 INFO [stderr] Running /target/debug/deps/bad-8ec231a4fbab0102 Dec 14 22:09:25.404 INFO [stdout] Dec 14 22:09:25.404 INFO [stdout] running 4 tests Dec 14 22:09:25.404 INFO [stdout] test bad_format ... ok Dec 14 22:09:25.404 INFO [stdout] test bad_syntax ... ok Dec 14 22:09:25.404 INFO [stdout] test bad_usize ... ok Dec 14 22:09:25.407 INFO [stdout] test bad_index ... ok Dec 14 22:09:25.407 INFO [stdout] Dec 14 22:09:25.407 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 14 22:09:25.407 INFO [stdout] Dec 14 22:09:25.407 INFO [stderr] Running /target/debug/deps/equivalence-5c431c7e3fe3a17f Dec 14 22:09:25.411 INFO [stdout] Dec 14 22:09:25.411 INFO [stdout] running 1 test Dec 14 22:09:25.411 INFO [stdout] test simple_equivalence ... ok Dec 14 22:09:25.411 INFO [stdout] Dec 14 22:09:25.411 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 14 22:09:25.411 INFO [stdout] Dec 14 22:09:25.411 INFO [stderr] Running /target/debug/deps/flexible-2d11d4bd5e4c93c4 Dec 14 22:09:25.413 INFO [stdout] Dec 14 22:09:25.413 INFO [stdout] running 3 tests Dec 14 22:09:25.413 INFO [stdout] test unused_is_fine ... ok Dec 14 22:09:25.414 INFO [stdout] test formatted_format_str ... ok Dec 14 22:09:25.415 INFO [stdout] test non_usize_pad ... ok Dec 14 22:09:25.415 INFO [stderr] Running /target/debug/deps/ifmt-6b0ba83e17f11f60 Dec 14 22:09:25.415 INFO [stdout] Dec 14 22:09:25.415 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 14 22:09:25.415 INFO [stdout] Dec 14 22:09:25.416 INFO [stdout] Dec 14 22:09:25.416 INFO [stdout] running 6 tests Dec 14 22:09:25.418 INFO [stdout] test test_format_args ... ok Dec 14 22:09:25.418 INFO [stdout] test test_order ... ok Dec 14 22:09:25.418 INFO [stdout] test test_print ... ok Dec 14 22:09:25.418 INFO [stdout] test test_once ... ok Dec 14 22:09:25.430 INFO [stdout] test test_write ... ok Dec 14 22:09:25.459 INFO [stdout] test main ... FAILED Dec 14 22:09:25.459 INFO [stderr] error: test failed, to rerun pass '--test ifmt' Dec 14 22:09:25.459 INFO [stdout] Dec 14 22:09:25.459 INFO [stdout] failures: Dec 14 22:09:25.459 INFO [stdout] Dec 14 22:09:25.459 INFO [stdout] ---- main stdout ---- Dec 14 22:09:25.459 INFO [stdout] thread 'main' panicked at 'assertion failed: `(left == right)` Dec 14 22:09:25.459 INFO [stdout] left: `"-0.0"`, Dec 14 22:09:25.459 INFO [stdout] right: `"-0"`', tests/ifmt.rs:182:5 Dec 14 22:09:25.459 INFO [stdout] stack backtrace: Dec 14 22:09:25.459 INFO [stdout] 0: 0x55b1d6fbf463 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h2c40bdfb30f25bdd Dec 14 22:09:25.459 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 14 22:09:25.459 INFO [stdout] 1: 0x55b1d6fb9bf8 - std::sys_common::backtrace::_print::he11ceebc70626ac9 Dec 14 22:09:25.459 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 14 22:09:25.459 INFO [stdout] 2: 0x55b1d6fbe3d2 - std::panicking::default_hook::{{closure}}::h4fde3ffb19c01413 Dec 14 22:09:25.459 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 14 22:09:25.459 INFO [stdout] at src/libstd/panicking.rs:210 Dec 14 22:09:25.459 INFO [stdout] 3: 0x55b1d6fbe0c7 - std::panicking::default_hook::hf0c15a583008ed0d Dec 14 22:09:25.459 INFO [stdout] at src/libstd/panicking.rs:218 Dec 14 22:09:25.459 INFO [stdout] 4: 0x55b1d6fbeae0 - std::panicking::rust_panic_with_hook::hc1663f6bc7813185 Dec 14 22:09:25.459 INFO [stdout] at src/libstd/panicking.rs:487 Dec 14 22:09:25.459 INFO [stdout] 5: 0x55b1d6fbe661 - std::panicking::continue_panic_fmt::h42bc2d03ddf03b3e Dec 14 22:09:25.459 INFO [stdout] at src/libstd/panicking.rs:394 Dec 14 22:09:25.459 INFO [stdout] 6: 0x55b1d6fbe5ae - std::panicking::begin_panic_fmt::h2207969583fb9324 Dec 14 22:09:25.459 INFO [stdout] at src/libstd/panicking.rs:349 Dec 14 22:09:25.459 INFO [stdout] 7: 0x55b1d6f24354 - ifmt::main::h5e2a9dcc522943d0 Dec 14 22:09:25.459 INFO [stdout] at tests/ifmt.rs:182 Dec 14 22:09:25.459 INFO [stdout] 8: 0x55b1d6f16189 - ifmt::main::{{closure}}::hb34f5a679f844701 Dec 14 22:09:25.459 INFO [stdout] at tests/ifmt.rs:73 Dec 14 22:09:25.459 INFO [stdout] 9: 0x55b1d6f4aa1d - core::ops::function::FnOnce::call_once::hc13778124d3b2fb3 Dec 14 22:09:25.459 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238 Dec 14 22:09:25.459 INFO [stdout] 10: 0x55b1d6f6de5e - >::call_box::hac337ba1af72dc2b Dec 14 22:09:25.459 INFO [stdout] at src/libtest/lib.rs:1483 Dec 14 22:09:25.459 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238 Dec 14 22:09:25.459 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673 Dec 14 22:09:25.459 INFO [stdout] 11: 0x55b1d6fcd0a9 - __rust_maybe_catch_panic Dec 14 22:09:25.459 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 14 22:09:25.459 INFO [stdout] 12: 0x55b1d6f8b667 - test::run_test::run_test_inner::{{closure}}::hfbfe4a58c0ebb01b Dec 14 22:09:25.459 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285 Dec 14 22:09:25.459 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398 Dec 14 22:09:25.459 INFO [stdout] at src/libtest/lib.rs:1438 Dec 14 22:09:25.459 INFO [stdout] 13: 0x55b1d6f66574 - std::sys_common::backtrace::__rust_begin_short_backtrace::hd1f0cf202092f8d7 Dec 14 22:09:25.459 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/sys_common/backtrace.rs:136 Dec 14 22:09:25.459 INFO [stdout] 14: 0x55b1d6f66b64 - std::panicking::try::do_call::h5e99f92fbf448cf6 Dec 14 22:09:25.459 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:479 Dec 14 22:09:25.459 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:319 Dec 14 22:09:25.459 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:306 Dec 14 22:09:25.459 INFO [stdout] 15: 0x55b1d6fcd0a9 - __rust_maybe_catch_panic Dec 14 22:09:25.459 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 14 22:09:25.459 INFO [stdout] 16: 0x55b1d6f6dd3c - >::call_box::h8ae063aff93ccdb6 Dec 14 22:09:25.459 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285 Dec 14 22:09:25.459 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398 Dec 14 22:09:25.459 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:478 Dec 14 22:09:25.459 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673 Dec 14 22:09:25.459 INFO [stdout] 17: 0x55b1d6fc106d - std::sys::unix::thread::Thread::new::thread_start::h42c32b292fdd228f Dec 14 22:09:25.459 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:683 Dec 14 22:09:25.459 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 14 22:09:25.459 INFO [stdout] at src/libstd/sys/unix/thread.rs:91 Dec 14 22:09:25.459 INFO [stdout] 18: 0x7fe52ae596b9 - start_thread Dec 14 22:09:25.459 INFO [stdout] 19: 0x7fe52a97941c - clone Dec 14 22:09:25.459 INFO [stdout] 20: 0x0 - Dec 14 22:09:25.459 INFO [stdout] Dec 14 22:09:25.459 INFO [stdout] Dec 14 22:09:25.459 INFO [stdout] failures: Dec 14 22:09:25.459 INFO [stdout] main Dec 14 22:09:25.459 INFO [stdout] Dec 14 22:09:25.459 INFO [stdout] test result: FAILED. 5 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Dec 14 22:09:25.459 INFO [stdout] Dec 14 22:09:25.463 INFO [stderr] su: No module specific data is present Dec 14 22:09:25.730 INFO running `"docker" "inspect" "ef7456de3946dce28647e01f011ed94c93e32751e6fbc7b4db9d229feb2a01bb"` Dec 14 22:09:25.824 INFO running `"docker" "rm" "-f" "ef7456de3946dce28647e01f011ed94c93e32751e6fbc7b4db9d229feb2a01bb"` Dec 14 22:09:25.944 INFO [stdout] ef7456de3946dce28647e01f011ed94c93e32751e6fbc7b4db9d229feb2a01bb