Dec 01 16:55:30.361 INFO testing gastamper/sholog against 1.30.1 for beta-1.31-5
Dec 01 16:55:30.361 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-1/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 01 16:55:30.672 INFO [stdout] f9cca92b5bab1e8d9b6ef6e039af7f32fe43ba31bfbe75e54bc8e6f71dce1510
Dec 01 16:55:30.674 INFO running `"docker" "start" "-a" "f9cca92b5bab1e8d9b6ef6e039af7f32fe43ba31bfbe75e54bc8e6f71dce1510"`
Dec 01 16:55:31.399 INFO [stderr] usermod: no changes
Dec 01 16:55:31.513 INFO [stderr]    Compiling openssl v0.10.11
Dec 01 16:55:31.513 INFO [stderr]    Compiling openssl-src v110.0.5+1.1.0h
Dec 01 16:55:32.206 INFO [stderr]    Compiling openssl-sys v0.9.35
Dec 01 16:57:15.491 INFO [stderr]    Compiling sholog v0.1.0 (/source)
Dec 01 16:57:19.699 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 48s
Dec 01 16:57:19.706 INFO [stderr] su: No module specific data is present
Dec 01 16:57:20.196 INFO running `"docker" "inspect" "f9cca92b5bab1e8d9b6ef6e039af7f32fe43ba31bfbe75e54bc8e6f71dce1510"`
Dec 01 16:57:20.469 INFO running `"docker" "rm" "-f" "f9cca92b5bab1e8d9b6ef6e039af7f32fe43ba31bfbe75e54bc8e6f71dce1510"`
Dec 01 16:57:20.708 INFO [stdout] f9cca92b5bab1e8d9b6ef6e039af7f32fe43ba31bfbe75e54bc8e6f71dce1510
Dec 01 16:57:20.710 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-1/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 01 16:57:21.071 INFO [stdout] 43f949f95924b25f3af617ec00af72750eb18c0758a66a8fa3fe777dc19101fc
Dec 01 16:57:21.077 INFO running `"docker" "start" "-a" "43f949f95924b25f3af617ec00af72750eb18c0758a66a8fa3fe777dc19101fc"`
Dec 01 16:57:21.847 INFO [stderr] usermod: no changes
Dec 01 16:57:21.935 INFO [stderr]    Compiling sholog v0.1.0 (/source)
Dec 01 16:57:25.764 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.89s
Dec 01 16:57:25.764 INFO [stderr] su: No module specific data is present
Dec 01 16:57:26.335 INFO running `"docker" "inspect" "43f949f95924b25f3af617ec00af72750eb18c0758a66a8fa3fe777dc19101fc"`
Dec 01 16:57:26.615 INFO running `"docker" "rm" "-f" "43f949f95924b25f3af617ec00af72750eb18c0758a66a8fa3fe777dc19101fc"`
Dec 01 16:57:26.822 INFO [stdout] 43f949f95924b25f3af617ec00af72750eb18c0758a66a8fa3fe777dc19101fc
Dec 01 16:57:26.824 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-1/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 01 16:57:27.252 INFO [stdout] e29aa5dd00a74bfaaf72ece1fb1d1dceb57c7b2d41f5e2a4f2b487ba80acb5ec
Dec 01 16:57:27.266 INFO running `"docker" "start" "-a" "e29aa5dd00a74bfaaf72ece1fb1d1dceb57c7b2d41f5e2a4f2b487ba80acb5ec"`
Dec 01 16:57:28.415 INFO [stderr] usermod: no changes
Dec 01 16:57:28.529 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Dec 01 16:57:28.555 INFO [stderr]      Running /target/debug/deps/sholog-1044b0573f106033
Dec 01 16:57:28.565 INFO [stdout] 
Dec 01 16:57:28.565 INFO [stdout] running 1 test
Dec 01 16:57:28.641 INFO [stdout] test test::testssl ... FAILED
Dec 01 16:57:28.641 INFO [stdout] 
Dec 01 16:57:28.641 INFO [stdout] failures:
Dec 01 16:57:28.641 INFO [stdout] 
Dec 01 16:57:28.641 INFO [stdout] ---- test::testssl stdout ----
Dec 01 16:57:28.641 INFO [stdout] Server: Building SSL Acceptor
Dec 01 16:57:28.641 INFO [stdout] thread 'test::testssl' panicked at 'called `Result::unwrap()` on an `Err` value: ErrorStack([Error { code: 33558530, library: "system library", function: "fopen", reason: "No such file or directory", file: "crypto/bio/bss_file.c", line: 292, data: "fopen(\'server.key\',\'r\')" }, Error { code: 537346050, library: "BIO routines", function: "file_ctrl", reason: "system lib", file: "crypto/bio/bss_file.c", line: 294 }, Error { code: 336265218, library: "SSL routines", function: "SSL_CTX_use_PrivateKey_file", reason: "system lib", file: "ssl/ssl_rsa.c", line: 534 }])', libcore/result.rs:1009:5
Dec 01 16:57:28.641 INFO [stdout] stack backtrace:
Dec 01 16:57:28.641 INFO [stdout]    0:     0x560cede43aae - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h15749a98198ba25f
Dec 01 16:57:28.641 INFO [stdout]                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 01 16:57:28.641 INFO [stdout]    1:     0x560cede35476 - std::sys_common::backtrace::print::h0ba65c811294dbf0
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/sys_common/backtrace.rs:71
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/sys_common/backtrace.rs:59
Dec 01 16:57:28.642 INFO [stdout]    2:     0x560cede3373d - std::panicking::default_hook::{{closure}}::h42bb31757f0fee64
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/panicking.rs:211
Dec 01 16:57:28.642 INFO [stdout]    3:     0x560cede3344b - std::panicking::default_hook::hebc8848d7aa7dbd9
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/panicking.rs:221
Dec 01 16:57:28.642 INFO [stdout]    4:     0x560cede33dec - std::panicking::rust_panic_with_hook::h86e619a638415243
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/panicking.rs:477
Dec 01 16:57:28.642 INFO [stdout]    5:     0x560cede339a9 - std::panicking::continue_panic_fmt::h2d2d2bfb065a70b2
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/panicking.rs:391
Dec 01 16:57:28.642 INFO [stdout]    6:     0x560cede338a5 - rust_begin_unwind
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/panicking.rs:326
Dec 01 16:57:28.642 INFO [stdout]    7:     0x560cede82a0b - core::panicking::panic_fmt::h2155aa66b67fe83c
Dec 01 16:57:28.642 INFO [stdout]                                at libcore/panicking.rs:77
Dec 01 16:57:28.642 INFO [stdout]    8:     0x560cedceb493 - core::result::unwrap_failed::h7e903ebea1644eab
Dec 01 16:57:28.642 INFO [stdout]                                at libcore/macros.rs:26
Dec 01 16:57:28.642 INFO [stdout]    9:     0x560cedceaef2 - <core::result::Result<T, E>>::unwrap::h934202fe67518bff
Dec 01 16:57:28.642 INFO [stdout]                                at libcore/result.rs:808
Dec 01 16:57:28.642 INFO [stdout]   10:     0x560cedc9724a - sholog::test::test_ssl::h7b391f4d180401af
Dec 01 16:57:28.642 INFO [stdout]                                at src/test.rs:10
Dec 01 16:57:28.642 INFO [stdout]   11:     0x560cedc9885c - sholog::test::testssl::h938eb614902b649b
Dec 01 16:57:28.642 INFO [stdout]                                at src/test.rs:70
Dec 01 16:57:28.642 INFO [stdout]   12:     0x560cedc98839 - sholog::test::testssl::{{closure}}::hb4977f8068774790
Dec 01 16:57:28.642 INFO [stdout]                                at src/test.rs:69
Dec 01 16:57:28.642 INFO [stdout]   13:     0x560cedca704d - core::ops::function::FnOnce::call_once::h234ef679a374c987
Dec 01 16:57:28.642 INFO [stdout]                                at libcore/ops/function.rs:238
Dec 01 16:57:28.642 INFO [stdout]   14:     0x560cedcaa82e - <F as alloc::boxed::FnBox<A>>::call_box::hbea525814fa423cc
Dec 01 16:57:28.642 INFO [stdout]                                at libtest/lib.rs:1461
Dec 01 16:57:28.642 INFO [stdout]                                at libcore/ops/function.rs:238
Dec 01 16:57:28.642 INFO [stdout]                                at liballoc/boxed.rs:646
Dec 01 16:57:28.642 INFO [stdout]   15:     0x560cede52a39 - __rust_maybe_catch_panic
Dec 01 16:57:28.642 INFO [stdout]                                at libpanic_unwind/lib.rs:103
Dec 01 16:57:28.642 INFO [stdout]   16:     0x560cedcb618d - std::sys_common::backtrace::__rust_begin_short_backtrace::h0ff507d7422944d3
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/panicking.rs:289
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/panic.rs:392
Dec 01 16:57:28.642 INFO [stdout]                                at libtest/lib.rs:1416
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/sys_common/backtrace.rs:136
Dec 01 16:57:28.642 INFO [stdout]   17:     0x560cedcce7c4 - std::panicking::try::do_call::hba0bdcc3670471cc
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/thread/mod.rs:409
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/panic.rs:313
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/panicking.rs:310
Dec 01 16:57:28.642 INFO [stdout]   18:     0x560cede52a39 - __rust_maybe_catch_panic
Dec 01 16:57:28.642 INFO [stdout]                                at libpanic_unwind/lib.rs:103
Dec 01 16:57:28.642 INFO [stdout]   19:     0x560cedcbf096 - <F as alloc::boxed::FnBox<A>>::call_box::hdac52587b00591af
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/panicking.rs:289
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/panic.rs:392
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/thread/mod.rs:408
Dec 01 16:57:28.642 INFO [stdout]                                at liballoc/boxed.rs:646
Dec 01 16:57:28.642 INFO [stdout]   20:     0x560cede455ea - std::sys_common::thread::start_thread::h75d887c7d2cc4479
Dec 01 16:57:28.642 INFO [stdout]                                at liballoc/boxed.rs:656
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/sys_common/thread.rs:24
Dec 01 16:57:28.642 INFO [stdout]   21:     0x560cede34615 - std::sys::unix::thread::Thread::new::thread_start::h8414caee632bf9ed
Dec 01 16:57:28.642 INFO [stdout]                                at libstd/sys/unix/thread.rs:90
Dec 01 16:57:28.642 INFO [stdout]   22:     0x7ffbca25c6b9 - start_thread
Dec 01 16:57:28.642 INFO [stdout]   23:     0x7ffbc9d7c41c - clone
Dec 01 16:57:28.642 INFO [stdout]   24:                0x0 - <unknown>
Dec 01 16:57:28.642 INFO [stdout] 
Dec 01 16:57:28.642 INFO [stdout] 
Dec 01 16:57:28.642 INFO [stdout] failures:
Dec 01 16:57:28.642 INFO [stdout]     test::testssl
Dec 01 16:57:28.642 INFO [stdout] 
Dec 01 16:57:28.642 INFO [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 16:57:28.642 INFO [stdout] 
Dec 01 16:57:28.647 INFO [stderr] error: test failed, to rerun pass '--bin sholog'
Dec 01 16:57:28.647 INFO [stderr] su: No module specific data is present
Dec 01 16:57:29.386 INFO running `"docker" "inspect" "e29aa5dd00a74bfaaf72ece1fb1d1dceb57c7b2d41f5e2a4f2b487ba80acb5ec"`
Dec 01 16:57:29.623 INFO running `"docker" "rm" "-f" "e29aa5dd00a74bfaaf72ece1fb1d1dceb57c7b2d41f5e2a4f2b487ba80acb5ec"`
Dec 01 16:57:29.817 INFO [stdout] e29aa5dd00a74bfaaf72ece1fb1d1dceb57c7b2d41f5e2a4f2b487ba80acb5ec
