Dec 03 06:44:42.033 INFO testing graft-0.1.0 against 1.30.1 for beta-1.31-5
Dec 03 06:44:42.033 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 03 06:44:42.194 INFO [stdout] 52e27a93a6b41828a5c9cf69277b1568dbc0b3d235231a2f8f34aea0aa01effe
Dec 03 06:44:42.197 INFO running `"docker" "start" "-a" "52e27a93a6b41828a5c9cf69277b1568dbc0b3d235231a2f8f34aea0aa01effe"`
Dec 03 06:44:42.703 INFO [stderr] usermod: no changes
Dec 03 06:44:42.811 INFO [stderr]    Compiling twoway v0.1.8
Dec 03 06:44:43.763 INFO [stderr]    Compiling comrak v0.3.1
Dec 03 06:44:59.899 INFO [stderr]    Compiling graft v0.1.0 (/source)
Dec 03 06:45:03.711 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 20.99s
Dec 03 06:45:03.716 INFO [stderr] su: No module specific data is present
Dec 03 06:45:04.067 INFO running `"docker" "inspect" "52e27a93a6b41828a5c9cf69277b1568dbc0b3d235231a2f8f34aea0aa01effe"`
Dec 03 06:45:04.284 INFO running `"docker" "rm" "-f" "52e27a93a6b41828a5c9cf69277b1568dbc0b3d235231a2f8f34aea0aa01effe"`
Dec 03 06:45:04.507 INFO [stdout] 52e27a93a6b41828a5c9cf69277b1568dbc0b3d235231a2f8f34aea0aa01effe
Dec 03 06:45:04.515 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 03 06:45:05.038 INFO [stdout] 2915b52531e479884f0067b9ac9fd953fd471f1b18c69ad0328b9292f9affabd
Dec 03 06:45:05.043 INFO running `"docker" "start" "-a" "2915b52531e479884f0067b9ac9fd953fd471f1b18c69ad0328b9292f9affabd"`
Dec 03 06:45:06.450 INFO [stderr] usermod: no changes
Dec 03 06:45:06.639 INFO [stderr]    Compiling graft v0.1.0 (/source)
Dec 03 06:45:14.479 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.99s
Dec 03 06:45:14.515 INFO [stderr] su: No module specific data is present
Dec 03 06:45:15.080 INFO running `"docker" "inspect" "2915b52531e479884f0067b9ac9fd953fd471f1b18c69ad0328b9292f9affabd"`
Dec 03 06:45:15.325 INFO running `"docker" "rm" "-f" "2915b52531e479884f0067b9ac9fd953fd471f1b18c69ad0328b9292f9affabd"`
Dec 03 06:45:15.641 INFO [stdout] 2915b52531e479884f0067b9ac9fd953fd471f1b18c69ad0328b9292f9affabd
Dec 03 06:45:15.647 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 03 06:45:16.115 INFO [stdout] aaf2281bc897588fb894b3a44f95e3dd71c64ada1bcd9849b67253d3ede2c902
Dec 03 06:45:16.117 INFO running `"docker" "start" "-a" "aaf2281bc897588fb894b3a44f95e3dd71c64ada1bcd9849b67253d3ede2c902"`
Dec 03 06:45:17.451 INFO [stderr] usermod: no changes
Dec 03 06:45:17.611 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.13s
Dec 03 06:45:17.622 INFO [stderr]      Running /target/debug/deps/graft-f70aedc7f950ee76
Dec 03 06:45:17.635 INFO [stdout] 
Dec 03 06:45:17.635 INFO [stdout] running 2 tests
Dec 03 06:45:17.635 INFO [stdout] test section::tests::from ... ok
Dec 03 06:45:17.739 INFO [stdout] test convert::tests::convert ... FAILED
Dec 03 06:45:17.739 INFO [stdout] 
Dec 03 06:45:17.740 INFO [stdout] failures:
Dec 03 06:45:17.740 INFO [stdout] 
Dec 03 06:45:17.740 INFO [stdout] ---- convert::tests::convert stdout ----
Dec 03 06:45:17.740 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.740 INFO [stdout] 
Dec 03 06:45:17.740 INFO [stdout]                 -- @ROOT ~json
Dec 03 06:45:17.740 INFO [stdout]                 {
Dec 03 06:45:17.740 INFO [stdout]                     "yo": "man"
Dec 03 06:45:17.740 INFO [stdout]                 }
Dec 03 06:45:17.740 INFO [stdout]             
Dec 03 06:45:17.740 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.740 INFO [stdout] 
Dec 03 06:45:17.740 INFO [stdout]                 -- @ROOT
Dec 03 06:45:17.740 INFO [stdout]                 yo: man
Dec 03 06:45:17.740 INFO [stdout]             
Dec 03 06:45:17.740 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.740 INFO [stdout] 
Dec 03 06:45:17.740 INFO [stdout]                 -- $foo
Dec 03 06:45:17.740 INFO [stdout]                 -- @main ~text
Dec 03 06:45:17.740 INFO [stdout]                 hello main
Dec 03 06:45:17.740 INFO [stdout]             
Dec 03 06:45:17.740 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.740 INFO [stdout] 
Dec 03 06:45:17.740 INFO [stdout]                 -- $foo
Dec 03 06:45:17.740 INFO [stdout]                 main: hello main
Dec 03 06:45:17.740 INFO [stdout]             
Dec 03 06:45:17.740 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.740 INFO [stdout] 
Dec 03 06:45:17.740 INFO [stdout]                 -- @ROOT $foo
Dec 03 06:45:17.740 INFO [stdout]                 -- @main ~text
Dec 03 06:45:17.740 INFO [stdout]                 hello main
Dec 03 06:45:17.740 INFO [stdout]             
Dec 03 06:45:17.740 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.740 INFO [stdout] -- @ROOT $foo
Dec 03 06:45:17.740 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.740 INFO [stdout] 
Dec 03 06:45:17.740 INFO [stdout]                 -- $foo
Dec 03 06:45:17.740 INFO [stdout]                 -- @main $title ~text
Dec 03 06:45:17.740 INFO [stdout]             
Dec 03 06:45:17.740 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.740 INFO [stdout] 
Dec 03 06:45:17.740 INFO [stdout]                 -- $foo
Dec 03 06:45:17.740 INFO [stdout]                 -- @main $bar
Dec 03 06:45:17.740 INFO [stdout]                 -- @main/bar
Dec 03 06:45:17.740 INFO [stdout]                 x: 20
Dec 03 06:45:17.740 INFO [stdout]                 y: 10
Dec 03 06:45:17.740 INFO [stdout]             
Dec 03 06:45:17.740 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.740 INFO [stdout] 
Dec 03 06:45:17.740 INFO [stdout]                 -- $foo2
Dec 03 06:45:17.740 INFO [stdout]                 -- @main/bar
Dec 03 06:45:17.740 INFO [stdout]                 x: 20
Dec 03 06:45:17.740 INFO [stdout]                 y: 10
Dec 03 06:45:17.740 INFO [stdout]             
Dec 03 06:45:17.740 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.740 INFO [stdout] 
Dec 03 06:45:17.740 INFO [stdout]                 -- $foo2
Dec 03 06:45:17.740 INFO [stdout]                 main2: la la la
Dec 03 06:45:17.740 INFO [stdout]                 -- @main/bar
Dec 03 06:45:17.740 INFO [stdout]                 x: 20
Dec 03 06:45:17.740 INFO [stdout]                 y: 10
Dec 03 06:45:17.740 INFO [stdout]             
Dec 03 06:45:17.740 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.740 INFO [stdout] 
Dec 03 06:45:17.740 INFO [stdout]                 -- $foo
Dec 03 06:45:17.740 INFO [stdout]                 -- @main $bar
Dec 03 06:45:17.740 INFO [stdout]                 -- @main/bar
Dec 03 06:45:17.740 INFO [stdout]                 x: 20
Dec 03 06:45:17.740 INFO [stdout]                 y: 10
Dec 03 06:45:17.740 INFO [stdout]                 -- @main2 $bar
Dec 03 06:45:17.740 INFO [stdout]                 -- @main2/bar
Dec 03 06:45:17.740 INFO [stdout]                 a: 20
Dec 03 06:45:17.740 INFO [stdout]                 b: 10
Dec 03 06:45:17.740 INFO [stdout]             
Dec 03 06:45:17.740 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.740 INFO [stdout] 
Dec 03 06:45:17.740 INFO [stdout]                 -- $foo
Dec 03 06:45:17.740 INFO [stdout]                 -- @main $title ~text
Dec 03 06:45:17.740 INFO [stdout]                 -- @children[] ~text
Dec 03 06:45:17.740 INFO [stdout]                 child 1
Dec 03 06:45:17.740 INFO [stdout]             
Dec 03 06:45:17.740 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.740 INFO [stdout] 
Dec 03 06:45:17.740 INFO [stdout]                 -- $foo
Dec 03 06:45:17.741 INFO [stdout]                 -- @main $title ~text
Dec 03 06:45:17.741 INFO [stdout]                 -- @children[] ~text
Dec 03 06:45:17.741 INFO [stdout]                 child 1
Dec 03 06:45:17.741 INFO [stdout]                 -- @children[] ~text
Dec 03 06:45:17.741 INFO [stdout]                 child 2
Dec 03 06:45:17.741 INFO [stdout]             
Dec 03 06:45:17.741 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.741 INFO [stdout] 
Dec 03 06:45:17.741 INFO [stdout]                 -- $foo
Dec 03 06:45:17.741 INFO [stdout]                 -- @main $title ~text
Dec 03 06:45:17.741 INFO [stdout]                 -- @children[] $bar
Dec 03 06:45:17.741 INFO [stdout]                 -- @children[]/bar
Dec 03 06:45:17.741 INFO [stdout]                 a: 20
Dec 03 06:45:17.741 INFO [stdout]                 b: 10
Dec 03 06:45:17.741 INFO [stdout]                 -- @children[] $bar
Dec 03 06:45:17.741 INFO [stdout]                 -- @children[]/bar
Dec 03 06:45:17.741 INFO [stdout]                 x: 20
Dec 03 06:45:17.741 INFO [stdout]                 y: 10
Dec 03 06:45:17.741 INFO [stdout]             
Dec 03 06:45:17.741 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.741 INFO [stdout] 
Dec 03 06:45:17.741 INFO [stdout]                 -- $foo
Dec 03 06:45:17.741 INFO [stdout]                 -- @main $title ~text
Dec 03 06:45:17.741 INFO [stdout]                 -- @children[] $bar
Dec 03 06:45:17.741 INFO [stdout]                 -- @children[]/bar
Dec 03 06:45:17.741 INFO [stdout]                 a: 20
Dec 03 06:45:17.741 INFO [stdout]                 b: 10
Dec 03 06:45:17.741 INFO [stdout]                 -- @children[] $foo
Dec 03 06:45:17.741 INFO [stdout]                 -- @children[]/children[] ~text
Dec 03 06:45:17.741 INFO [stdout]                 nested child
Dec 03 06:45:17.741 INFO [stdout]                 -- @children[]/main ~text
Dec 03 06:45:17.741 INFO [stdout]                 inner main
Dec 03 06:45:17.741 INFO [stdout]             
Dec 03 06:45:17.741 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.741 INFO [stdout] 
Dec 03 06:45:17.741 INFO [stdout]                 -- $nested
Dec 03 06:45:17.741 INFO [stdout]                 -- @title ~text
Dec 03 06:45:17.741 INFO [stdout]                 the title
Dec 03 06:45:17.741 INFO [stdout]             
Dec 03 06:45:17.741 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.741 INFO [stdout] 
Dec 03 06:45:17.741 INFO [stdout]                 -- $array
Dec 03 06:45:17.741 INFO [stdout]                 -- @title ~text
Dec 03 06:45:17.741 INFO [stdout]                 the title
Dec 03 06:45:17.741 INFO [stdout]             
Dec 03 06:45:17.741 INFO [stdout] ============= TEST ==============
Dec 03 06:45:17.741 INFO [stdout] 
Dec 03 06:45:17.741 INFO [stdout]                 -- $array2
Dec 03 06:45:17.741 INFO [stdout]                 -- @title ~text
Dec 03 06:45:17.741 INFO [stdout]                 the title
Dec 03 06:45:17.741 INFO [stdout]             
Dec 03 06:45:17.741 INFO [stdout] thread 'convert::tests::convert' panicked at 'assertion failed: `(left == right)`
Dec 03 06:45:17.741 INFO [stdout]   left: `Object({"obj": Array([Object({"$ref": String("title")})]), "title": String("the title")})`,
Dec 03 06:45:17.741 INFO [stdout]  right: `Object({"obj": Array([String("the title")]), "title": String("the title")})`', src/convert.rs:152:9
Dec 03 06:45:17.741 INFO [stdout] stack backtrace:
Dec 03 06:45:17.741 INFO [stdout]    0:     0x55c74dc6f87e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h15749a98198ba25f
Dec 03 06:45:17.741 INFO [stdout]                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 03 06:45:17.741 INFO [stdout]    1:     0x55c74dc62846 - std::sys_common::backtrace::print::h0ba65c811294dbf0
Dec 03 06:45:17.741 INFO [stdout]                                at libstd/sys_common/backtrace.rs:71
Dec 03 06:45:17.741 INFO [stdout]                                at libstd/sys_common/backtrace.rs:59
Dec 03 06:45:17.741 INFO [stdout]    2:     0x55c74dc60c6d - std::panicking::default_hook::{{closure}}::h42bb31757f0fee64
Dec 03 06:45:17.741 INFO [stdout]                                at libstd/panicking.rs:211
Dec 03 06:45:17.741 INFO [stdout]    3:     0x55c74dc6097b - std::panicking::default_hook::hebc8848d7aa7dbd9
Dec 03 06:45:17.741 INFO [stdout]                                at libstd/panicking.rs:221
Dec 03 06:45:17.741 INFO [stdout]    4:     0x55c74dc6131c - std::panicking::rust_panic_with_hook::h86e619a638415243
Dec 03 06:45:17.741 INFO [stdout]                                at libstd/panicking.rs:477
Dec 03 06:45:17.741 INFO [stdout]    5:     0x55c74dc60ed9 - std::panicking::continue_panic_fmt::h2d2d2bfb065a70b2
Dec 03 06:45:17.741 INFO [stdout]                                at libstd/panicking.rs:391
Dec 03 06:45:17.741 INFO [stdout]    6:     0x55c74dc60e3d - std::panicking::begin_panic_fmt::ha5097e2056ef3d5a
Dec 03 06:45:17.741 INFO [stdout]                                at libstd/panicking.rs:346
Dec 03 06:45:17.741 INFO [stdout]    7:     0x55c74d70cb56 - graft::convert::tests::t::h66c4bcc4d49e18b2
Dec 03 06:45:17.741 INFO [stdout]                                at src/convert.rs:152
Dec 03 06:45:17.741 INFO [stdout]    8:     0x55c74d71267f - graft::convert::tests::convert::h800a69b760c0d55e
Dec 03 06:45:17.741 INFO [stdout]                                at src/convert.rs:588
Dec 03 06:45:17.741 INFO [stdout]    9:     0x55c74d70cbc9 - graft::convert::tests::convert::{{closure}}::h35a00bfb67a9b7b9
Dec 03 06:45:17.741 INFO [stdout]                                at src/convert.rs:159
Dec 03 06:45:17.741 INFO [stdout]   10:     0x55c74d72066d - core::ops::function::FnOnce::call_once::h623cec3e0836f79c
Dec 03 06:45:17.741 INFO [stdout]                                at libcore/ops/function.rs:238
Dec 03 06:45:17.741 INFO [stdout]   11:     0x55c74d747cfe - <F as alloc::boxed::FnBox<A>>::call_box::hbea525814fa423cc
Dec 03 06:45:17.741 INFO [stdout]                                at libtest/lib.rs:1461
Dec 03 06:45:17.741 INFO [stdout]                                at libcore/ops/function.rs:238
Dec 03 06:45:17.741 INFO [stdout]                                at liballoc/boxed.rs:646
Dec 03 06:45:17.741 INFO [stdout]   12:     0x55c74dc7e759 - __rust_maybe_catch_panic
Dec 03 06:45:17.741 INFO [stdout]                                at libpanic_unwind/lib.rs:103
Dec 03 06:45:17.741 INFO [stdout]   13:     0x55c74d75365d - std::sys_common::backtrace::__rust_begin_short_backtrace::h0ff507d7422944d3
Dec 03 06:45:17.742 INFO [stdout]                                at libstd/panicking.rs:289
Dec 03 06:45:17.742 INFO [stdout]                                at libstd/panic.rs:392
Dec 03 06:45:17.742 INFO [stdout]                                at libtest/lib.rs:1416
Dec 03 06:45:17.742 INFO [stdout]                                at libstd/sys_common/backtrace.rs:136
Dec 03 06:45:17.742 INFO [stdout]   14:     0x55c74d76bc94 - std::panicking::try::do_call::hba0bdcc3670471cc
Dec 03 06:45:17.742 INFO [stdout]                                at libstd/thread/mod.rs:409
Dec 03 06:45:17.742 INFO [stdout]                                at libstd/panic.rs:313
Dec 03 06:45:17.742 INFO [stdout]                                at libstd/panicking.rs:310
Dec 03 06:45:17.742 INFO [stdout]   15:     0x55c74dc7e759 - __rust_maybe_catch_panic
Dec 03 06:45:17.742 INFO [stdout]                                at libpanic_unwind/lib.rs:103
Dec 03 06:45:17.742 INFO [stdout]   16:     0x55c74d75c566 - <F as alloc::boxed::FnBox<A>>::call_box::hdac52587b00591af
Dec 03 06:45:17.742 INFO [stdout]                                at libstd/panicking.rs:289
Dec 03 06:45:17.742 INFO [stdout]                                at libstd/panic.rs:392
Dec 03 06:45:17.742 INFO [stdout]                                at libstd/thread/mod.rs:408
Dec 03 06:45:17.742 INFO [stdout]                                at liballoc/boxed.rs:646
Dec 03 06:45:17.742 INFO [stdout]   17:     0x55c74dc711ea - std::sys_common::thread::start_thread::h75d887c7d2cc4479
Dec 03 06:45:17.742 INFO [stdout]                                at liballoc/boxed.rs:656
Dec 03 06:45:17.742 INFO [stdout]                                at libstd/sys_common/thread.rs:24
Dec 03 06:45:17.742 INFO [stdout]   18:     0x55c74dc61a85 - std::sys::unix::thread::Thread::new::thread_start::h8414caee632bf9ed
Dec 03 06:45:17.742 INFO [stdout]                                at libstd/sys/unix/thread.rs:90
Dec 03 06:45:17.742 INFO [stdout]   19:     0x7f24283b16b9 - start_thread
Dec 03 06:45:17.742 INFO [stdout]   20:     0x7f2427ed141c - clone
Dec 03 06:45:17.742 INFO [stdout]   21:                0x0 - <unknown>
Dec 03 06:45:17.742 INFO [stdout] 
Dec 03 06:45:17.742 INFO [stdout] 
Dec 03 06:45:17.742 INFO [stdout] failures:
Dec 03 06:45:17.742 INFO [stdout]     convert::tests::convert
Dec 03 06:45:17.742 INFO [stdout] 
Dec 03 06:45:17.742 INFO [stdout] test result: FAILED. 1 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 06:45:17.742 INFO [stdout] 
Dec 03 06:45:17.751 INFO [stderr] error: test failed, to rerun pass '--lib'
Dec 03 06:45:17.751 INFO [stderr] su: No module specific data is present
Dec 03 06:45:18.323 INFO running `"docker" "inspect" "aaf2281bc897588fb894b3a44f95e3dd71c64ada1bcd9849b67253d3ede2c902"`
Dec 03 06:45:18.725 INFO running `"docker" "rm" "-f" "aaf2281bc897588fb894b3a44f95e3dd71c64ada1bcd9849b67253d3ede2c902"`
Dec 03 06:45:19.158 INFO [stdout] aaf2281bc897588fb894b3a44f95e3dd71c64ada1bcd9849b67253d3ede2c902
