Dec 07 21:02:10.127 INFO testing chainbuf-0.0.9 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514 Dec 07 21:02:10.127 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 21:02:10.284 INFO [stdout] 5292817b66ad49bdcb0cb566720d3d85545d0501f74de180ff29dee590e43ee3 Dec 07 21:02:10.286 INFO running `"docker" "start" "-a" "5292817b66ad49bdcb0cb566720d3d85545d0501f74de180ff29dee590e43ee3"` Dec 07 21:02:10.637 INFO [stderr] usermod: no changes Dec 07 21:02:10.699 INFO [stderr] Compiling chainbuf v0.0.9 (/source) Dec 07 21:02:11.812 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1.15s Dec 07 21:02:11.815 INFO [stderr] su: No module specific data is present Dec 07 21:02:12.075 INFO running `"docker" "inspect" "5292817b66ad49bdcb0cb566720d3d85545d0501f74de180ff29dee590e43ee3"` Dec 07 21:02:12.124 INFO running `"docker" "rm" "-f" "5292817b66ad49bdcb0cb566720d3d85545d0501f74de180ff29dee590e43ee3"` Dec 07 21:02:12.191 INFO [stdout] 5292817b66ad49bdcb0cb566720d3d85545d0501f74de180ff29dee590e43ee3 Dec 07 21:02:12.192 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 21:02:12.416 INFO [stdout] e85708a960c5299f3401e77496b9ba89534f87d699d7c87f774bc19efec77ce6 Dec 07 21:02:12.421 INFO running `"docker" "start" "-a" "e85708a960c5299f3401e77496b9ba89534f87d699d7c87f774bc19efec77ce6"` Dec 07 21:02:12.979 INFO [stderr] usermod: no changes Dec 07 21:02:13.039 INFO [stderr] Compiling chainbuf v0.0.9 (/source) Dec 07 21:02:15.351 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 2.35s Dec 07 21:02:15.355 INFO [stderr] su: No module specific data is present Dec 07 21:02:15.694 INFO running `"docker" "inspect" "e85708a960c5299f3401e77496b9ba89534f87d699d7c87f774bc19efec77ce6"` Dec 07 21:02:15.753 INFO running `"docker" "rm" "-f" "e85708a960c5299f3401e77496b9ba89534f87d699d7c87f774bc19efec77ce6"` Dec 07 21:02:15.835 INFO [stdout] e85708a960c5299f3401e77496b9ba89534f87d699d7c87f774bc19efec77ce6 Dec 07 21:02:15.838 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 21:02:16.023 INFO [stdout] a94f1040a0698805cbd182abbd2605aab2ffaec46e7967d99874a4b02e68b1ac Dec 07 21:02:16.025 INFO running `"docker" "start" "-a" "a94f1040a0698805cbd182abbd2605aab2ffaec46e7967d99874a4b02e68b1ac"` Dec 07 21:02:16.540 INFO [stderr] usermod: no changes Dec 07 21:02:16.591 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.03s Dec 07 21:02:16.591 INFO [stderr] Running /target/debug/deps/chainbuf-25232c1c3f7a1893 Dec 07 21:02:16.598 INFO [stdout] Dec 07 21:02:16.598 INFO [stdout] running 0 tests Dec 07 21:02:16.598 INFO [stdout] Dec 07 21:02:16.598 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 21:02:16.598 INFO [stdout] Dec 07 21:02:16.599 INFO [stderr] Running /target/debug/deps/integration-e158052a1fe15106 Dec 07 21:02:16.601 INFO [stdout] Dec 07 21:02:16.601 INFO [stdout] running 2 tests Dec 07 21:02:16.603 INFO [stdout] test integration_test::test_append_file::test_append_flie ... ok Dec 07 21:02:16.604 INFO [stdout] test integration_test::test_writev::test_write_to_fd_works ... ok Dec 07 21:02:16.604 INFO [stdout] Dec 07 21:02:16.604 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 21:02:16.604 INFO [stdout] Dec 07 21:02:16.604 INFO [stderr] Running /target/debug/deps/unit-1cddf896e53d54e7 Dec 07 21:02:16.606 INFO [stdout] Dec 07 21:02:16.606 INFO [stdout] running 38 tests Dec 07 21:02:16.620 INFO [stdout] test unit_test::test_append_bytes_changes_length ... ok Dec 07 21:02:16.620 INFO [stdout] test unit_test::test_appended_slice_can_be_pulled ... ok Dec 07 21:02:16.620 INFO [stdout] test unit_test::test_append_slice_changes_length ... ok Dec 07 21:02:16.623 INFO [stdout] test unit_test::test_chains_with_different_content_are_not_equal ... ok Dec 07 21:02:16.624 INFO [stdout] test unit_test::test_concat_appends_content ... ok Dec 07 21:02:16.624 INFO [stdout] test unit_test::test_append_copies_data ... ok Dec 07 21:02:16.624 INFO [stdout] test unit_test::test_copy_bytes_from_returns_copies_bytes ... ok Dec 07 21:02:16.625 INFO [stdout] test unit_test::test_copy_bytes_from_returns_empty_vec_from_empty_chain ... ok Dec 07 21:02:16.625 INFO [stdout] test unit_test::test_copy_bytes_returns_less_than_requested_if_chain_does_not_have_data ... ok Dec 07 21:02:16.626 INFO [stdout] test unit_test::test_find_returns_none_on_empty_chain ... ok Dec 07 21:02:16.628 INFO [stdout] test unit_test::test_find_returns_zero_on_empty_needle ... ok Dec 07 21:02:16.628 INFO [stdout] test unit_test::test_concat_increase_dst_length ... ok Dec 07 21:02:16.632 INFO [stdout] test unit_test::test_move_from_moves_data ... ok Dec 07 21:02:16.636 INFO [stdout] test unit_test::test_chains_with_same_content_are_equal ... ok Dec 07 21:02:16.639 INFO [stdout] test unit_test::test_move_from_returns_number_of_bytes_moved ... ok Dec 07 21:02:16.640 INFO [stdout] test unit_test::test_prepend_bytes_changes_length ... ok Dec 07 21:02:16.640 INFO [stdout] test unit_test::test_pullup_all_returns_all_data ... ok Dec 07 21:02:16.644 INFO [stdout] test unit_test::test_from_foreign_moves_all_data ... ok Dec 07 21:02:16.648 INFO [stdout] test unit_test::test_pullup_from_returns_data_from_correct_offset ... ok Dec 07 21:02:16.648 INFO [stdout] test unit_test::test_pullup_returns_none_on_empty_chain ... ok Dec 07 21:02:16.649 INFO [stdout] test unit_test::test_pullup_from_returns_none_on_empty_chain ... ok Dec 07 21:02:16.653 INFO [stdout] test unit_test::test_pullup_does_not_change_length ... ok Dec 07 21:02:16.653 INFO [stdout] test unit_test::test_drain_changes_chain_length ... ok Dec 07 21:02:16.660 INFO [stdout] test unit_test::test_pullup_returns_what_has_been_appended ... ok Dec 07 21:02:16.660 INFO [stdout] test unit_test::test_pullup_to_returns_none_if_nothing_found ... ok Dec 07 21:02:16.660 INFO [stdout] test unit_test::test_pullup_to_returns_correct_sequence ... ok Dec 07 21:02:16.660 INFO [stdout] test unit_test::test_pullup_returns_none_when_too_much_data_requested ... ok Dec 07 21:02:16.670 INFO [stdout] test unit_test::test_find_returns_none_if_not_found ... ok Dec 07 21:02:16.672 INFO [stdout] test unit_test::test_move_from_move_on_node_edge ... ok Dec 07 21:02:16.672 INFO [stdout] test unit_test::test_reset_empties_chain ... ok Dec 07 21:02:16.674 INFO [stdout] test unit_test::test_to_utf8_returns_correct_string ... ok Dec 07 21:02:16.674 INFO [stdout] test unit_test::test_to_utf8_str_returns_none_on_non_utf8 ... ok Dec 07 21:02:16.680 INFO [stdout] test unit_test::test_pullup_to_returns_none_on_empty_chain ... ok Dec 07 21:02:16.680 INFO [stdout] test unit_test::test_pullup_works_on_large_sequences ... ok Dec 07 21:02:16.680 INFO [stdout] test unit_test::test_reserve_and_written_modifies_chain ... ok Dec 07 21:02:16.681 INFO [stdout] test unit_test::test_reserve_returns_buffer_of_requested_size ... ok Dec 07 21:02:16.681 INFO [stdout] test unit_test::test_reserve_returns_free_buffer ... ok Dec 07 21:02:16.732 INFO [stdout] test unit_test::test_find_returns_correct_offset ... FAILED Dec 07 21:02:16.732 INFO [stderr] error: test failed, to rerun pass '--test unit' Dec 07 21:02:16.732 INFO [stdout] Dec 07 21:02:16.732 INFO [stdout] failures: Dec 07 21:02:16.733 INFO [stdout] Dec 07 21:02:16.733 INFO [stdout] ---- unit_test::test_find_returns_correct_offset stdout ---- Dec 07 21:02:16.733 INFO [stdout] thread 'unit_test::test_find_returns_correct_offset' panicked at 'assertion failed: `(left == right)` Dec 07 21:02:16.733 INFO [stdout] left: `901`, Dec 07 21:02:16.733 INFO [stdout] right: `900`', tests/unit.rs:362:9 Dec 07 21:02:16.733 INFO [stdout] stack backtrace: Dec 07 21:02:16.733 INFO [stdout] 0: 0x559a2c601d83 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7 Dec 07 21:02:16.733 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 07 21:02:16.733 INFO [stdout] 1: 0x559a2c5fc3e8 - std::sys_common::backtrace::_print::h95865c77318e98b7 Dec 07 21:02:16.733 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 07 21:02:16.733 INFO [stdout] 2: 0x559a2c600ca2 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5 Dec 07 21:02:16.733 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 07 21:02:16.733 INFO [stdout] at src/libstd/panicking.rs:211 Dec 07 21:02:16.733 INFO [stdout] 3: 0x559a2c60098c - std::panicking::default_hook::h4eae6f26f73244c8 Dec 07 21:02:16.733 INFO [stdout] at src/libstd/panicking.rs:221 Dec 07 21:02:16.733 INFO [stdout] 4: 0x559a2c6013b0 - std::panicking::rust_panic_with_hook::h368d37fd53b59464 Dec 07 21:02:16.733 INFO [stdout] at src/libstd/panicking.rs:491 Dec 07 21:02:16.733 INFO [stdout] 5: 0x559a2c600f31 - std::panicking::continue_panic_fmt::h1599d634b3be4304 Dec 07 21:02:16.733 INFO [stdout] at src/libstd/panicking.rs:398 Dec 07 21:02:16.733 INFO [stdout] 6: 0x559a2c600e7e - std::panicking::begin_panic_fmt::h2c0a418aaab204b3 Dec 07 21:02:16.733 INFO [stdout] at src/libstd/panicking.rs:353 Dec 07 21:02:16.733 INFO [stdout] 7: 0x559a2c584651 - unit::unit_test::test_find_returns_correct_offset::h1548bf4c887ffeca Dec 07 21:02:16.733 INFO [stdout] at tests/unit.rs:362 Dec 07 21:02:16.733 INFO [stdout] 8: 0x559a2c583fa9 - unit::unit_test::test_find_returns_correct_offset::{{closure}}::h67514e8b27518888 Dec 07 21:02:16.733 INFO [stdout] at tests/unit.rs:340 Dec 07 21:02:16.733 INFO [stdout] 9: 0x559a2c58b10d - core::ops::function::FnOnce::call_once::h3cd7c5131d61059a Dec 07 21:02:16.733 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 07 21:02:16.733 INFO [stdout] 10: 0x559a2c595c8e - >::call_box::h994167e0fc25f327 Dec 07 21:02:16.733 INFO [stdout] at src/libtest/lib.rs:1471 Dec 07 21:02:16.733 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 07 21:02:16.733 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 21:02:16.733 INFO [stdout] 11: 0x559a2c60fa09 - __rust_maybe_catch_panic Dec 07 21:02:16.733 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 21:02:16.733 INFO [stdout] 12: 0x559a2c58db93 - std::sys_common::backtrace::__rust_begin_short_backtrace::h5d34cfb78512c8c3 Dec 07 21:02:16.733 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 21:02:16.733 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 21:02:16.733 INFO [stdout] at src/libtest/lib.rs:1426 Dec 07 21:02:16.733 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136 Dec 07 21:02:16.733 INFO [stdout] 13: 0x559a2c58eab4 - std::panicking::try::do_call::h7a86b6211ebb5e72 Dec 07 21:02:16.733 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477 Dec 07 21:02:16.733 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319 Dec 07 21:02:16.733 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310 Dec 07 21:02:16.733 INFO [stdout] 14: 0x559a2c60fa09 - __rust_maybe_catch_panic Dec 07 21:02:16.733 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 21:02:16.733 INFO [stdout] 15: 0x559a2c595b6c - >::call_box::h877dbe22cb3997f4 Dec 07 21:02:16.733 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 21:02:16.733 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 21:02:16.733 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476 Dec 07 21:02:16.733 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 21:02:16.733 INFO [stdout] 16: 0x559a2c6039cd - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd Dec 07 21:02:16.733 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683 Dec 07 21:02:16.733 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 07 21:02:16.733 INFO [stdout] at src/libstd/sys/unix/thread.rs:90 Dec 07 21:02:16.733 INFO [stdout] 17: 0x7fb69899f6b9 - start_thread Dec 07 21:02:16.733 INFO [stdout] 18: 0x7fb6984bf41c - clone Dec 07 21:02:16.733 INFO [stdout] 19: 0x0 - Dec 07 21:02:16.733 INFO [stdout] Dec 07 21:02:16.733 INFO [stdout] Dec 07 21:02:16.733 INFO [stdout] failures: Dec 07 21:02:16.733 INFO [stdout] unit_test::test_find_returns_correct_offset Dec 07 21:02:16.733 INFO [stdout] Dec 07 21:02:16.733 INFO [stdout] test result: FAILED. 37 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 21:02:16.733 INFO [stdout] Dec 07 21:02:16.737 INFO [stderr] su: No module specific data is present Dec 07 21:02:17.654 INFO running `"docker" "inspect" "a94f1040a0698805cbd182abbd2605aab2ffaec46e7967d99874a4b02e68b1ac"` Dec 07 21:02:17.994 INFO running `"docker" "rm" "-f" "a94f1040a0698805cbd182abbd2605aab2ffaec46e7967d99874a4b02e68b1ac"` Dec 07 21:02:18.260 INFO [stdout] a94f1040a0698805cbd182abbd2605aab2ffaec46e7967d99874a4b02e68b1ac