Dec 15 01:15:26.928 INFO testing positioned-io-preview-0.3.1 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550 Dec 15 01:15:26.928 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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:15:27.178 INFO [stdout] 9fc4fd6203077ad746b5a5f57faf91c4256d234b13a3e49b42556a65202b9799 Dec 15 01:15:27.184 INFO running `"docker" "start" "-a" "9fc4fd6203077ad746b5a5f57faf91c4256d234b13a3e49b42556a65202b9799"` Dec 15 01:15:27.633 INFO [stderr] usermod: no changes Dec 15 01:15:27.697 INFO [stderr] Compiling positioned-io-preview v0.3.1 (/source) Dec 15 01:15:28.512 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.86s Dec 15 01:15:28.516 INFO [stderr] su: No module specific data is present Dec 15 01:15:28.917 INFO running `"docker" "inspect" "9fc4fd6203077ad746b5a5f57faf91c4256d234b13a3e49b42556a65202b9799"` Dec 15 01:15:29.016 INFO running `"docker" "rm" "-f" "9fc4fd6203077ad746b5a5f57faf91c4256d234b13a3e49b42556a65202b9799"` Dec 15 01:15:29.093 INFO [stdout] 9fc4fd6203077ad746b5a5f57faf91c4256d234b13a3e49b42556a65202b9799 Dec 15 01:15:29.096 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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:15:29.344 INFO [stdout] 40eca64fee20fe8c84a9501207b5ff7674f8c6914d2e83686e04ec39e496384f Dec 15 01:15:29.346 INFO running `"docker" "start" "-a" "40eca64fee20fe8c84a9501207b5ff7674f8c6914d2e83686e04ec39e496384f"` Dec 15 01:15:29.688 INFO [stderr] usermod: no changes Dec 15 01:15:29.765 INFO [stderr] Compiling positioned-io-preview v0.3.1 (/source) Dec 15 01:15:34.305 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 4.60s Dec 15 01:15:34.312 INFO [stderr] su: No module specific data is present Dec 15 01:15:35.304 INFO running `"docker" "inspect" "40eca64fee20fe8c84a9501207b5ff7674f8c6914d2e83686e04ec39e496384f"` Dec 15 01:15:35.679 INFO running `"docker" "rm" "-f" "40eca64fee20fe8c84a9501207b5ff7674f8c6914d2e83686e04ec39e496384f"` Dec 15 01:15:35.990 INFO [stdout] 40eca64fee20fe8c84a9501207b5ff7674f8c6914d2e83686e04ec39e496384f Dec 15 01:15:35.999 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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:15:36.408 INFO [stdout] 02e0a613f293474af7f73c15eba91f26fc23e54e7fa4c8d5073408540ec4b59e Dec 15 01:15:36.410 INFO running `"docker" "start" "-a" "02e0a613f293474af7f73c15eba91f26fc23e54e7fa4c8d5073408540ec4b59e"` Dec 15 01:15:37.443 INFO [stderr] usermod: no changes Dec 15 01:15:37.539 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.06s Dec 15 01:15:37.547 INFO [stderr] Running /target/debug/deps/positioned_io_preview-71be8e3fac9a6c97 Dec 15 01:15:37.555 INFO [stderr] Running /target/debug/deps/model-e316d56bbc68f613 Dec 15 01:15:37.555 INFO [stdout] Dec 15 01:15:37.555 INFO [stdout] running 0 tests Dec 15 01:15:37.555 INFO [stdout] Dec 15 01:15:37.555 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 01:15:37.555 INFO [stdout] Dec 15 01:15:37.555 INFO [stdout] Dec 15 01:15:37.555 INFO [stdout] running 1 test Dec 15 01:15:38.286 INFO [stderr] Running /target/debug/deps/test-5ada8660c660cc70 Dec 15 01:15:38.286 INFO [stdout] test file_matches_model ... ok Dec 15 01:15:38.286 INFO [stdout] Dec 15 01:15:38.286 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 01:15:38.286 INFO [stdout] Dec 15 01:15:38.288 INFO [stdout] Dec 15 01:15:38.288 INFO [stdout] running 10 tests Dec 15 01:15:38.288 INFO [stdout] test test_size_cursor ... ok Dec 15 01:15:38.288 INFO [stdout] test test_refcell ... ok Dec 15 01:15:38.289 INFO [stdout] test test_read_fails ... ok Dec 15 01:15:38.289 INFO [stdout] test test_read_at ... ok Dec 15 01:15:38.289 INFO [stdout] test test_slice ... ok Dec 15 01:15:38.292 INFO [stdout] test test_size ... ok Dec 15 01:15:38.292 INFO [stdout] test test_vector ... ok Dec 15 01:15:38.292 INFO [stdout] test test_mixed_read ... ok Dec 15 01:15:38.299 INFO [stdout] test test_cursor ... ok Dec 15 01:15:38.329 INFO [stdout] test test_byteio ... FAILED Dec 15 01:15:38.329 INFO [stdout] Dec 15 01:15:38.329 INFO [stdout] failures: Dec 15 01:15:38.329 INFO [stdout] Dec 15 01:15:38.329 INFO [stdout] ---- test_byteio stdout ---- Dec 15 01:15:38.329 INFO [stdout] thread 'test_byteio' panicked at 'assertion failed: `(left == right)` Dec 15 01:15:38.329 INFO [stdout] left: `1734437731`, Dec 15 01:15:38.329 INFO [stdout] right: `1936025444`', tests/test.rs:118:5 Dec 15 01:15:38.329 INFO [stdout] stack backtrace: Dec 15 01:15:38.329 INFO [stdout] 0: 0x55c591484eb3 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h2c40bdfb30f25bdd Dec 15 01:15:38.329 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 15 01:15:38.329 INFO [stdout] 1: 0x55c59147f648 - std::sys_common::backtrace::_print::he11ceebc70626ac9 Dec 15 01:15:38.329 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 15 01:15:38.329 INFO [stdout] 2: 0x55c591483e22 - std::panicking::default_hook::{{closure}}::h4fde3ffb19c01413 Dec 15 01:15:38.329 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 15 01:15:38.329 INFO [stdout] at src/libstd/panicking.rs:210 Dec 15 01:15:38.329 INFO [stdout] 3: 0x55c591483b17 - std::panicking::default_hook::hf0c15a583008ed0d Dec 15 01:15:38.329 INFO [stdout] at src/libstd/panicking.rs:218 Dec 15 01:15:38.329 INFO [stdout] 4: 0x55c591484530 - std::panicking::rust_panic_with_hook::hc1663f6bc7813185 Dec 15 01:15:38.329 INFO [stdout] at src/libstd/panicking.rs:487 Dec 15 01:15:38.329 INFO [stdout] 5: 0x55c5914840b1 - std::panicking::continue_panic_fmt::h42bc2d03ddf03b3e Dec 15 01:15:38.329 INFO [stdout] at src/libstd/panicking.rs:394 Dec 15 01:15:38.329 INFO [stdout] 6: 0x55c591483ffe - std::panicking::begin_panic_fmt::h2207969583fb9324 Dec 15 01:15:38.329 INFO [stdout] at src/libstd/panicking.rs:349 Dec 15 01:15:38.329 INFO [stdout] 7: 0x55c591423f88 - test::test_byteio::h27e5fafb7da03c74 Dec 15 01:15:38.329 INFO [stdout] at tests/test.rs:118 Dec 15 01:15:38.329 INFO [stdout] 8: 0x55c591423d69 - test::test_byteio::{{closure}}::h43c739de39a38bfa Dec 15 01:15:38.329 INFO [stdout] at tests/test.rs:114 Dec 15 01:15:38.329 INFO [stdout] 9: 0x55c59142eeed - core::ops::function::FnOnce::call_once::h84fa78d64f34cfab Dec 15 01:15:38.329 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238 Dec 15 01:15:38.329 INFO [stdout] 10: 0x55c59143ab2e - >::call_box::hac337ba1af72dc2b Dec 15 01:15:38.329 INFO [stdout] at src/libtest/lib.rs:1483 Dec 15 01:15:38.329 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238 Dec 15 01:15:38.329 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673 Dec 15 01:15:38.329 INFO [stdout] 11: 0x55c591492b49 - __rust_maybe_catch_panic Dec 15 01:15:38.329 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 15 01:15:38.329 INFO [stdout] 12: 0x55c591458337 - test::run_test::run_test_inner::{{closure}}::hfbfe4a58c0ebb01b Dec 15 01:15:38.329 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285 Dec 15 01:15:38.329 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398 Dec 15 01:15:38.329 INFO [stdout] at src/libtest/lib.rs:1438 Dec 15 01:15:38.329 INFO [stdout] 13: 0x55c591433244 - std::sys_common::backtrace::__rust_begin_short_backtrace::hd1f0cf202092f8d7 Dec 15 01:15:38.329 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/sys_common/backtrace.rs:136 Dec 15 01:15:38.329 INFO [stdout] 14: 0x55c591433834 - std::panicking::try::do_call::h5e99f92fbf448cf6 Dec 15 01:15:38.329 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:479 Dec 15 01:15:38.329 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:319 Dec 15 01:15:38.329 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:306 Dec 15 01:15:38.329 INFO [stdout] 15: 0x55c591492b49 - __rust_maybe_catch_panic Dec 15 01:15:38.329 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 15 01:15:38.329 INFO [stdout] 16: 0x55c59143aa0c - >::call_box::h8ae063aff93ccdb6 Dec 15 01:15:38.329 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285 Dec 15 01:15:38.329 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398 Dec 15 01:15:38.329 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:478 Dec 15 01:15:38.329 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673 Dec 15 01:15:38.329 INFO [stdout] 17: 0x55c591486b0d - std::sys::unix::thread::Thread::new::thread_start::h42c32b292fdd228f Dec 15 01:15:38.329 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:683 Dec 15 01:15:38.329 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 15 01:15:38.329 INFO [stdout] at src/libstd/sys/unix/thread.rs:91 Dec 15 01:15:38.329 INFO [stdout] 18: 0x7f41f89e86b9 - start_thread Dec 15 01:15:38.329 INFO [stdout] 19: 0x7f41f850841c - clone Dec 15 01:15:38.329 INFO [stdout] 20: 0x0 - Dec 15 01:15:38.329 INFO [stdout] Dec 15 01:15:38.329 INFO [stdout] Dec 15 01:15:38.329 INFO [stdout] failures: Dec 15 01:15:38.329 INFO [stdout] test_byteio Dec 15 01:15:38.329 INFO [stdout] Dec 15 01:15:38.329 INFO [stdout] test result: FAILED. 9 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 01:15:38.329 INFO [stdout] Dec 15 01:15:38.330 INFO [stderr] error: test failed, to rerun pass '--test test' Dec 15 01:15:38.336 INFO [stderr] su: No module specific data is present Dec 15 01:15:38.684 INFO running `"docker" "inspect" "02e0a613f293474af7f73c15eba91f26fc23e54e7fa4c8d5073408540ec4b59e"` Dec 15 01:15:38.793 INFO running `"docker" "rm" "-f" "02e0a613f293474af7f73c15eba91f26fc23e54e7fa4c8d5073408540ec4b59e"` Dec 15 01:15:39.008 INFO [stdout] 02e0a613f293474af7f73c15eba91f26fc23e54e7fa4c8d5073408540ec4b59e