Dec 03 17:39:43.756 INFO testing build-plan-0.1.1 against 1.30.1 for beta-1.31-5
Dec 03 17:39:43.756 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-4/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 03 17:39:43.936 INFO [stdout] 8929b0e7f2de6f35beee8ce74ff892a5d332ca1b0c585f229e4ea43923022a98
Dec 03 17:39:43.937 INFO running `"docker" "start" "-a" "8929b0e7f2de6f35beee8ce74ff892a5d332ca1b0c585f229e4ea43923022a98"`
Dec 03 17:39:44.248 INFO [stderr] usermod: no changes
Dec 03 17:39:44.295 INFO [stderr]    Compiling build-plan v0.1.1 (/source)
Dec 03 17:39:45.532 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.27s
Dec 03 17:39:45.535 INFO [stderr] su: No module specific data is present
Dec 03 17:39:45.775 INFO running `"docker" "inspect" "8929b0e7f2de6f35beee8ce74ff892a5d332ca1b0c585f229e4ea43923022a98"`
Dec 03 17:39:45.852 INFO running `"docker" "rm" "-f" "8929b0e7f2de6f35beee8ce74ff892a5d332ca1b0c585f229e4ea43923022a98"`
Dec 03 17:39:45.948 INFO [stdout] 8929b0e7f2de6f35beee8ce74ff892a5d332ca1b0c585f229e4ea43923022a98
Dec 03 17:39:45.949 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-4/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 03 17:39:46.100 INFO [stdout] 6905da4ee9250eaa1e30cf4079e44ac73a139b9ff07b6ea8191ee9a45e2e3be0
Dec 03 17:39:46.105 INFO running `"docker" "start" "-a" "6905da4ee9250eaa1e30cf4079e44ac73a139b9ff07b6ea8191ee9a45e2e3be0"`
Dec 03 17:39:46.510 INFO [stderr] usermod: no changes
Dec 03 17:39:46.550 INFO [stderr]    Compiling build-plan v0.1.1 (/source)
Dec 03 17:39:50.549 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.02s
Dec 03 17:39:50.551 INFO [stderr] su: No module specific data is present
Dec 03 17:39:50.769 INFO running `"docker" "inspect" "6905da4ee9250eaa1e30cf4079e44ac73a139b9ff07b6ea8191ee9a45e2e3be0"`
Dec 03 17:39:50.829 INFO running `"docker" "rm" "-f" "6905da4ee9250eaa1e30cf4079e44ac73a139b9ff07b6ea8191ee9a45e2e3be0"`
Dec 03 17:39:50.898 INFO [stdout] 6905da4ee9250eaa1e30cf4079e44ac73a139b9ff07b6ea8191ee9a45e2e3be0
Dec 03 17:39:50.901 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-4/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 03 17:39:51.094 INFO [stdout] 01b96757d5fbaeac7c122b9ecaa685b86d8e2c546451bc9aae543ddbf2f530f2
Dec 03 17:39:51.096 INFO running `"docker" "start" "-a" "01b96757d5fbaeac7c122b9ecaa685b86d8e2c546451bc9aae543ddbf2f530f2"`
Dec 03 17:39:51.470 INFO [stderr] usermod: no changes
Dec 03 17:39:51.502 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Dec 03 17:39:51.503 INFO [stderr]      Running /target/debug/deps/build_plan-00e5bc23450cb8ff
Dec 03 17:39:51.504 INFO [stdout] 
Dec 03 17:39:51.504 INFO [stdout] running 0 tests
Dec 03 17:39:51.504 INFO [stdout] 
Dec 03 17:39:51.504 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 17:39:51.504 INFO [stdout] 
Dec 03 17:39:51.505 INFO [stderr]      Running /target/debug/deps/integration-08d0a6ffbbde57e7
Dec 03 17:39:51.506 INFO [stdout] 
Dec 03 17:39:51.506 INFO [stdout] running 1 test
Dec 03 17:39:51.541 INFO [stdout] test reflect ... FAILED
Dec 03 17:39:51.541 INFO [stdout] 
Dec 03 17:39:51.541 INFO [stdout] failures:
Dec 03 17:39:51.541 INFO [stdout] 
Dec 03 17:39:51.541 INFO [stdout] ---- reflect stdout ----
Dec 03 17:39:51.541 INFO [stdout] thread 'reflect' panicked at 'called `Result::unwrap()` on an `Err` value: Error("EOF while parsing a value", line: 1, column: 0)', libcore/result.rs:1009:5
Dec 03 17:39:51.541 INFO [stdout] stack backtrace:
Dec 03 17:39:51.541 INFO [stdout]    0:     0x56279d4414be - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h15749a98198ba25f
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 03 17:39:51.541 INFO [stdout]    1:     0x56279d430046 - std::sys_common::backtrace::print::h0ba65c811294dbf0
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/sys_common/backtrace.rs:71
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/sys_common/backtrace.rs:59
Dec 03 17:39:51.541 INFO [stdout]    2:     0x56279d42e46d - std::panicking::default_hook::{{closure}}::h42bb31757f0fee64
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/panicking.rs:211
Dec 03 17:39:51.541 INFO [stdout]    3:     0x56279d42e17b - std::panicking::default_hook::hebc8848d7aa7dbd9
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/panicking.rs:221
Dec 03 17:39:51.541 INFO [stdout]    4:     0x56279d42eb1c - std::panicking::rust_panic_with_hook::h86e619a638415243
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/panicking.rs:477
Dec 03 17:39:51.541 INFO [stdout]    5:     0x56279d42e6d9 - std::panicking::continue_panic_fmt::h2d2d2bfb065a70b2
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/panicking.rs:391
Dec 03 17:39:51.541 INFO [stdout]    6:     0x56279d42e5d5 - rust_begin_unwind
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/panicking.rs:326
Dec 03 17:39:51.541 INFO [stdout]    7:     0x56279d4862db - core::panicking::panic_fmt::h2155aa66b67fe83c
Dec 03 17:39:51.541 INFO [stdout]                                at libcore/panicking.rs:77
Dec 03 17:39:51.541 INFO [stdout]    8:     0x56279d3bcf98 - core::result::unwrap_failed::hc97d91f9b0cbc823
Dec 03 17:39:51.541 INFO [stdout]                                at libcore/macros.rs:26
Dec 03 17:39:51.541 INFO [stdout]    9:     0x56279d3bb753 - <core::result::Result<T, E>>::unwrap::hc0456f8f6f451836
Dec 03 17:39:51.541 INFO [stdout]                                at libcore/result.rs:808
Dec 03 17:39:51.541 INFO [stdout]   10:     0x56279d3c1fba - integration::reflect::h2715b3265cf44168
Dec 03 17:39:51.541 INFO [stdout]                                at tests/integration.rs:18
Dec 03 17:39:51.541 INFO [stdout]   11:     0x56279d3c1dd9 - integration::reflect::{{closure}}::hc279ed8764d8a12c
Dec 03 17:39:51.541 INFO [stdout]                                at tests/integration.rs:9
Dec 03 17:39:51.541 INFO [stdout]   12:     0x56279d3be72d - core::ops::function::FnOnce::call_once::h116bb63cb6526585
Dec 03 17:39:51.541 INFO [stdout]                                at libcore/ops/function.rs:238
Dec 03 17:39:51.541 INFO [stdout]   13:     0x56279d3c44fe - <F as alloc::boxed::FnBox<A>>::call_box::hbea525814fa423cc
Dec 03 17:39:51.541 INFO [stdout]                                at libtest/lib.rs:1461
Dec 03 17:39:51.541 INFO [stdout]                                at libcore/ops/function.rs:238
Dec 03 17:39:51.541 INFO [stdout]                                at liballoc/boxed.rs:646
Dec 03 17:39:51.541 INFO [stdout]   14:     0x56279d453069 - __rust_maybe_catch_panic
Dec 03 17:39:51.541 INFO [stdout]                                at libpanic_unwind/lib.rs:103
Dec 03 17:39:51.541 INFO [stdout]   15:     0x56279d3cfe5d - std::sys_common::backtrace::__rust_begin_short_backtrace::h0ff507d7422944d3
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/panicking.rs:289
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/panic.rs:392
Dec 03 17:39:51.541 INFO [stdout]                                at libtest/lib.rs:1416
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/sys_common/backtrace.rs:136
Dec 03 17:39:51.541 INFO [stdout]   16:     0x56279d3e8494 - std::panicking::try::do_call::hba0bdcc3670471cc
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/thread/mod.rs:409
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/panic.rs:313
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/panicking.rs:310
Dec 03 17:39:51.541 INFO [stdout]   17:     0x56279d453069 - __rust_maybe_catch_panic
Dec 03 17:39:51.541 INFO [stdout]                                at libpanic_unwind/lib.rs:103
Dec 03 17:39:51.541 INFO [stdout]   18:     0x56279d3d8d66 - <F as alloc::boxed::FnBox<A>>::call_box::hdac52587b00591af
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/panicking.rs:289
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/panic.rs:392
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/thread/mod.rs:408
Dec 03 17:39:51.541 INFO [stdout]                                at liballoc/boxed.rs:646
Dec 03 17:39:51.541 INFO [stdout]   19:     0x56279d4433da - std::sys_common::thread::start_thread::h75d887c7d2cc4479
Dec 03 17:39:51.541 INFO [stdout]                                at liballoc/boxed.rs:656
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/sys_common/thread.rs:24
Dec 03 17:39:51.541 INFO [stdout]   20:     0x56279d42f285 - std::sys::unix::thread::Thread::new::thread_start::h8414caee632bf9ed
Dec 03 17:39:51.541 INFO [stdout]                                at libstd/sys/unix/thread.rs:90
Dec 03 17:39:51.541 INFO [stdout]   21:     0x7f057dac26b9 - start_thread
Dec 03 17:39:51.541 INFO [stdout]   22:     0x7f057d5e241c - clone
Dec 03 17:39:51.541 INFO [stdout]   23:                0x0 - <unknown>
Dec 03 17:39:51.541 INFO [stdout] 
Dec 03 17:39:51.541 INFO [stdout] 
Dec 03 17:39:51.541 INFO [stdout] failures:
Dec 03 17:39:51.542 INFO [stdout]     reflect
Dec 03 17:39:51.542 INFO [stdout] 
Dec 03 17:39:51.542 INFO [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 17:39:51.542 INFO [stdout] 
Dec 03 17:39:51.542 INFO [stderr] error: test failed, to rerun pass '--test integration'
Dec 03 17:39:51.543 INFO [stderr] su: No module specific data is present
Dec 03 17:39:51.820 INFO running `"docker" "inspect" "01b96757d5fbaeac7c122b9ecaa685b86d8e2c546451bc9aae543ddbf2f530f2"`
Dec 03 17:39:51.884 INFO running `"docker" "rm" "-f" "01b96757d5fbaeac7c122b9ecaa685b86d8e2c546451bc9aae543ddbf2f530f2"`
Dec 03 17:39:51.960 INFO [stdout] 01b96757d5fbaeac7c122b9ecaa685b86d8e2c546451bc9aae543ddbf2f530f2
