Dec 02 13:47:57.784 INFO testing tobytcp-0.11.0 against 1.30.1 for beta-1.31-5
Dec 02 13:47:57.784 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-3/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/beta-1.31-5/1.30.1:/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 +1.30.1 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 13:47:58.104 INFO [stdout] e1fc4ad6d6bdba6f9171fcee95d424390f865026ff65346b20616d175acf6912
Dec 02 13:47:58.106 INFO running `"docker" "start" "-a" "e1fc4ad6d6bdba6f9171fcee95d424390f865026ff65346b20616d175acf6912"`
Dec 02 13:47:59.715 INFO [stderr] usermod: no changes
Dec 02 13:47:59.803 INFO [stderr]    Compiling uuid v0.6.5
Dec 02 13:48:01.355 INFO [stderr]    Compiling tobytcp v0.11.0 (/source)
Dec 02 13:48:03.023 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.27s
Dec 02 13:48:03.023 INFO [stderr] su: No module specific data is present
Dec 02 13:48:03.535 INFO running `"docker" "inspect" "e1fc4ad6d6bdba6f9171fcee95d424390f865026ff65346b20616d175acf6912"`
Dec 02 13:48:03.837 INFO running `"docker" "rm" "-f" "e1fc4ad6d6bdba6f9171fcee95d424390f865026ff65346b20616d175acf6912"`
Dec 02 13:48:04.143 INFO [stdout] e1fc4ad6d6bdba6f9171fcee95d424390f865026ff65346b20616d175acf6912
Dec 02 13:48:04.149 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-3/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 13:48:04.704 INFO [stdout] 37a711bc9b73e49bc7eddf1fe703301230beefa9c5eeb134b26bf251b85e2813
Dec 02 13:48:04.709 INFO running `"docker" "start" "-a" "37a711bc9b73e49bc7eddf1fe703301230beefa9c5eeb134b26bf251b85e2813"`
Dec 02 13:48:05.759 INFO [stderr] usermod: no changes
Dec 02 13:48:05.875 INFO [stderr]    Compiling tobytcp v0.11.0 (/source)
Dec 02 13:48:08.899 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.11s
Dec 02 13:48:08.899 INFO [stderr] su: No module specific data is present
Dec 02 13:48:09.721 INFO running `"docker" "inspect" "37a711bc9b73e49bc7eddf1fe703301230beefa9c5eeb134b26bf251b85e2813"`
Dec 02 13:48:10.041 INFO running `"docker" "rm" "-f" "37a711bc9b73e49bc7eddf1fe703301230beefa9c5eeb134b26bf251b85e2813"`
Dec 02 13:48:10.290 INFO [stdout] 37a711bc9b73e49bc7eddf1fe703301230beefa9c5eeb134b26bf251b85e2813
Dec 02 13:48:10.299 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-3/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 13:48:10.828 INFO [stdout] 2a58b672e26508762b3cbefd57f36883ac318f71f8822b731ec0195b7f3f786b
Dec 02 13:48:10.830 INFO running `"docker" "start" "-a" "2a58b672e26508762b3cbefd57f36883ac318f71f8822b731ec0195b7f3f786b"`
Dec 02 13:48:12.126 INFO [stderr] usermod: no changes
Dec 02 13:48:12.212 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Dec 02 13:48:12.212 INFO [stderr]      Running /target/debug/deps/tobytcp-bbd429468375df05
Dec 02 13:48:12.213 INFO [stdout] 
Dec 02 13:48:12.213 INFO [stdout] running 8 tests
Dec 02 13:48:12.219 INFO [stdout] test protocol::tests::encode_single_byte ... ok
Dec 02 13:48:12.219 INFO [stdout] test protocol::tests::encode_bigger_message ... ok
Dec 02 13:48:12.283 INFO [stdout] test tests::test_send_data ... ok
Dec 02 13:48:12.399 INFO [stdout] test tests::test_echo_single ... ok
Dec 02 13:48:12.427 INFO [stdout] test tests::test_echo_loop ... ok
Dec 02 13:48:12.503 INFO [stdout] test tests::test_writes_no_recv ... FAILED
Dec 02 13:48:13.395 INFO [stdout] test tests::test_concurrent_conns_writes ... ok
Dec 02 13:48:14.242 INFO [stdout] test tests::test_concurrent_conns_writes_big_data ... ok
Dec 02 13:48:14.242 INFO [stdout] 
Dec 02 13:48:14.242 INFO [stdout] failures:
Dec 02 13:48:14.242 INFO [stdout] 
Dec 02 13:48:14.242 INFO [stdout] ---- tests::test_writes_no_recv stdout ----
Dec 02 13:48:14.242 INFO [stdout] thread 'tests::test_writes_no_recv' panicked at 'assertion failed: got_msg.load(Ordering::Relaxed)', src/lib.rs:491:9
Dec 02 13:48:14.242 INFO [stdout] stack backtrace:
Dec 02 13:48:14.242 INFO [stdout]    0:     0x562d008b5ebe - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h15749a98198ba25f
Dec 02 13:48:14.242 INFO [stdout]                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 02 13:48:14.242 INFO [stdout]    1:     0x562d008a7a96 - std::sys_common::backtrace::print::h0ba65c811294dbf0
Dec 02 13:48:14.242 INFO [stdout]                                at libstd/sys_common/backtrace.rs:71
Dec 02 13:48:14.242 INFO [stdout]                                at libstd/sys_common/backtrace.rs:59
Dec 02 13:48:14.242 INFO [stdout]    2:     0x562d008a5d8d - std::panicking::default_hook::{{closure}}::h42bb31757f0fee64
Dec 02 13:48:14.242 INFO [stdout]                                at libstd/panicking.rs:211
Dec 02 13:48:14.242 INFO [stdout]    3:     0x562d008a5a9b - std::panicking::default_hook::hebc8848d7aa7dbd9
Dec 02 13:48:14.242 INFO [stdout]                                at libstd/panicking.rs:221
Dec 02 13:48:14.242 INFO [stdout]    4:     0x562d008a643c - std::panicking::rust_panic_with_hook::h86e619a638415243
Dec 02 13:48:14.242 INFO [stdout]                                at libstd/panicking.rs:477
Dec 02 13:48:14.242 INFO [stdout]    5:     0x562d00894a2f - std::panicking::begin_panic::h333c340ba80cd9de
Dec 02 13:48:14.242 INFO [stdout]                                at libstd/panicking.rs:411
Dec 02 13:48:14.242 INFO [stdout]    6:     0x562d00823028 - tobytcp::tests::test_writes_no_recv::h35b723b2ea51731a
Dec 02 13:48:14.242 INFO [stdout]                                at src/lib.rs:491
Dec 02 13:48:14.242 INFO [stdout]    7:     0x562d00822d19 - tobytcp::tests::test_writes_no_recv::{{closure}}::hc900b41e913e29a7
Dec 02 13:48:14.242 INFO [stdout]                                at src/lib.rs:464
Dec 02 13:48:14.242 INFO [stdout]    8:     0x562d008428ad - core::ops::function::FnOnce::call_once::h40bd6da32e64e922
Dec 02 13:48:14.242 INFO [stdout]                                at libcore/ops/function.rs:238
Dec 02 13:48:14.242 INFO [stdout]    9:     0x562d0085089e - <F as alloc::boxed::FnBox<A>>::call_box::hbea525814fa423cc
Dec 02 13:48:14.242 INFO [stdout]                                at libtest/lib.rs:1461
Dec 02 13:48:14.242 INFO [stdout]                                at libcore/ops/function.rs:238
Dec 02 13:48:14.242 INFO [stdout]                                at liballoc/boxed.rs:646
Dec 02 13:48:14.242 INFO [stdout]   10:     0x562d008c6719 - __rust_maybe_catch_panic
Dec 02 13:48:14.242 INFO [stdout]                                at libpanic_unwind/lib.rs:103
Dec 02 13:48:14.242 INFO [stdout]   11:     0x562d0085c1fd - std::sys_common::backtrace::__rust_begin_short_backtrace::h0ff507d7422944d3
Dec 02 13:48:14.242 INFO [stdout]                                at libstd/panicking.rs:289
Dec 02 13:48:14.242 INFO [stdout]                                at libstd/panic.rs:392
Dec 02 13:48:14.243 INFO [stdout]                                at libtest/lib.rs:1416
Dec 02 13:48:14.243 INFO [stdout]                                at libstd/sys_common/backtrace.rs:136
Dec 02 13:48:14.243 INFO [stdout]   12:     0x562d00874834 - std::panicking::try::do_call::hba0bdcc3670471cc
Dec 02 13:48:14.243 INFO [stdout]                                at libstd/thread/mod.rs:409
Dec 02 13:48:14.243 INFO [stdout]                                at libstd/panic.rs:313
Dec 02 13:48:14.243 INFO [stdout]                                at libstd/panicking.rs:310
Dec 02 13:48:14.243 INFO [stdout]   13:     0x562d008c6719 - __rust_maybe_catch_panic
Dec 02 13:48:14.243 INFO [stdout]                                at libpanic_unwind/lib.rs:103
Dec 02 13:48:14.243 INFO [stdout]   14:     0x562d00865106 - <F as alloc::boxed::FnBox<A>>::call_box::hdac52587b00591af
Dec 02 13:48:14.243 INFO [stdout]                                at libstd/panicking.rs:289
Dec 02 13:48:14.243 INFO [stdout]                                at libstd/panic.rs:392
Dec 02 13:48:14.243 INFO [stdout]                                at libstd/thread/mod.rs:408
Dec 02 13:48:14.243 INFO [stdout]                                at liballoc/boxed.rs:646
Dec 02 13:48:14.243 INFO [stdout]   15:     0x562d008b7b5a - std::sys_common::thread::start_thread::h75d887c7d2cc4479
Dec 02 13:48:14.243 INFO [stdout]                                at liballoc/boxed.rs:656
Dec 02 13:48:14.243 INFO [stdout]                                at libstd/sys_common/thread.rs:24
Dec 02 13:48:14.243 INFO [stdout]   16:     0x562d008a6ba5 - std::sys::unix::thread::Thread::new::thread_start::h8414caee632bf9ed
Dec 02 13:48:14.243 INFO [stdout]                                at libstd/sys/unix/thread.rs:90
Dec 02 13:48:14.243 INFO [stdout]   17:     0x7fc95ac136b9 - start_thread
Dec 02 13:48:14.243 INFO [stdout]   18:     0x7fc95a73341c - clone
Dec 02 13:48:14.243 INFO [stdout]   19:                0x0 - <unknown>
Dec 02 13:48:14.243 INFO [stdout] 
Dec 02 13:48:14.243 INFO [stdout] 
Dec 02 13:48:14.243 INFO [stdout] failures:
Dec 02 13:48:14.243 INFO [stdout]     tests::test_writes_no_recv
Dec 02 13:48:14.243 INFO [stdout] 
Dec 02 13:48:14.243 INFO [stdout] test result: FAILED. 7 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 13:48:14.243 INFO [stdout] 
Dec 02 13:48:14.250 INFO [stderr] error: test failed, to rerun pass '--lib'
Dec 02 13:48:14.253 INFO [stderr] su: No module specific data is present
Dec 02 13:48:14.757 INFO running `"docker" "inspect" "2a58b672e26508762b3cbefd57f36883ac318f71f8822b731ec0195b7f3f786b"`
Dec 02 13:48:15.056 INFO running `"docker" "rm" "-f" "2a58b672e26508762b3cbefd57f36883ac318f71f8822b731ec0195b7f3f786b"`
Dec 02 13:48:15.458 INFO [stdout] 2a58b672e26508762b3cbefd57f36883ac318f71f8822b731ec0195b7f3f786b
