Dec 07 11:59:55.629 INFO testing graft-0.1.0 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514 Dec 07 11:59:55.629 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 11:59:56.000 INFO [stdout] 3e3c43ddb4f21f006aad1e3c919c5a3b9ac3af526813934006b809c871d795d1 Dec 07 11:59:56.000 INFO running `"docker" "start" "-a" "3e3c43ddb4f21f006aad1e3c919c5a3b9ac3af526813934006b809c871d795d1"` Dec 07 11:59:56.753 INFO [stderr] usermod: no changes Dec 07 11:59:56.907 INFO [stderr] Compiling comrak v0.3.1 Dec 07 12:00:11.564 INFO [stderr] Compiling graft v0.1.0 (/source) Dec 07 12:00:16.216 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 19.43s Dec 07 12:00:16.223 INFO [stderr] su: No module specific data is present Dec 07 12:00:17.258 INFO running `"docker" "inspect" "3e3c43ddb4f21f006aad1e3c919c5a3b9ac3af526813934006b809c871d795d1"` Dec 07 12:00:17.372 INFO running `"docker" "rm" "-f" "3e3c43ddb4f21f006aad1e3c919c5a3b9ac3af526813934006b809c871d795d1"` Dec 07 12:00:17.515 INFO [stdout] 3e3c43ddb4f21f006aad1e3c919c5a3b9ac3af526813934006b809c871d795d1 Dec 07 12:00:17.518 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 12:00:17.680 INFO [stdout] a4c737c62dcae899630a0c6322da47dc97603a3a4bd67c33096e967f8487b674 Dec 07 12:00:17.682 INFO running `"docker" "start" "-a" "a4c737c62dcae899630a0c6322da47dc97603a3a4bd67c33096e967f8487b674"` Dec 07 12:00:18.188 INFO [stderr] usermod: no changes Dec 07 12:00:18.303 INFO [stderr] Compiling graft v0.1.0 (/source) Dec 07 12:00:24.379 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 6.16s Dec 07 12:00:24.385 INFO [stderr] su: No module specific data is present Dec 07 12:00:24.650 INFO running `"docker" "inspect" "a4c737c62dcae899630a0c6322da47dc97603a3a4bd67c33096e967f8487b674"` Dec 07 12:00:24.733 INFO running `"docker" "rm" "-f" "a4c737c62dcae899630a0c6322da47dc97603a3a4bd67c33096e967f8487b674"` Dec 07 12:00:24.882 INFO [stdout] a4c737c62dcae899630a0c6322da47dc97603a3a4bd67c33096e967f8487b674 Dec 07 12:00:24.884 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 12:00:25.125 INFO [stdout] ac39599ab64b6fea887555270a90d0943838c46f34e4585ffe8acd79b1c7ce0e Dec 07 12:00:25.126 INFO running `"docker" "start" "-a" "ac39599ab64b6fea887555270a90d0943838c46f34e4585ffe8acd79b1c7ce0e"` Dec 07 12:00:25.581 INFO [stderr] usermod: no changes Dec 07 12:00:25.682 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.08s Dec 07 12:00:25.704 INFO [stderr] Running /target/debug/deps/graft-39464d4e3a3db9e8 Dec 07 12:00:25.718 INFO [stdout] Dec 07 12:00:25.718 INFO [stdout] running 2 tests Dec 07 12:00:25.718 INFO [stdout] test section::tests::from ... ok Dec 07 12:00:25.812 INFO [stdout] test convert::tests::convert ... FAILED Dec 07 12:00:25.812 INFO [stdout] Dec 07 12:00:25.812 INFO [stdout] failures: Dec 07 12:00:25.812 INFO [stdout] Dec 07 12:00:25.812 INFO [stdout] ---- convert::tests::convert stdout ---- Dec 07 12:00:25.812 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.812 INFO [stdout] Dec 07 12:00:25.812 INFO [stdout] -- @ROOT ~json Dec 07 12:00:25.812 INFO [stdout] { Dec 07 12:00:25.812 INFO [stdout] "yo": "man" Dec 07 12:00:25.812 INFO [stdout] } Dec 07 12:00:25.812 INFO [stdout] Dec 07 12:00:25.812 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.812 INFO [stdout] Dec 07 12:00:25.812 INFO [stdout] -- @ROOT Dec 07 12:00:25.812 INFO [stdout] yo: man Dec 07 12:00:25.812 INFO [stdout] Dec 07 12:00:25.812 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.812 INFO [stdout] Dec 07 12:00:25.812 INFO [stdout] -- $foo Dec 07 12:00:25.812 INFO [stdout] -- @main ~text Dec 07 12:00:25.812 INFO [stdout] hello main Dec 07 12:00:25.812 INFO [stdout] Dec 07 12:00:25.812 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.812 INFO [stdout] Dec 07 12:00:25.812 INFO [stdout] -- $foo Dec 07 12:00:25.812 INFO [stdout] main: hello main Dec 07 12:00:25.812 INFO [stdout] Dec 07 12:00:25.812 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.812 INFO [stdout] Dec 07 12:00:25.812 INFO [stdout] -- @ROOT $foo Dec 07 12:00:25.812 INFO [stdout] -- @main ~text Dec 07 12:00:25.812 INFO [stdout] hello main Dec 07 12:00:25.812 INFO [stdout] Dec 07 12:00:25.812 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.812 INFO [stdout] -- @ROOT $foo Dec 07 12:00:25.812 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.812 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] -- $foo Dec 07 12:00:25.813 INFO [stdout] -- @main $title ~text Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] -- $foo Dec 07 12:00:25.813 INFO [stdout] -- @main $bar Dec 07 12:00:25.813 INFO [stdout] -- @main/bar Dec 07 12:00:25.813 INFO [stdout] x: 20 Dec 07 12:00:25.813 INFO [stdout] y: 10 Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] -- $foo2 Dec 07 12:00:25.813 INFO [stdout] -- @main/bar Dec 07 12:00:25.813 INFO [stdout] x: 20 Dec 07 12:00:25.813 INFO [stdout] y: 10 Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] -- $foo2 Dec 07 12:00:25.813 INFO [stdout] main2: la la la Dec 07 12:00:25.813 INFO [stdout] -- @main/bar Dec 07 12:00:25.813 INFO [stdout] x: 20 Dec 07 12:00:25.813 INFO [stdout] y: 10 Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] -- $foo Dec 07 12:00:25.813 INFO [stdout] -- @main $bar Dec 07 12:00:25.813 INFO [stdout] -- @main/bar Dec 07 12:00:25.813 INFO [stdout] x: 20 Dec 07 12:00:25.813 INFO [stdout] y: 10 Dec 07 12:00:25.813 INFO [stdout] -- @main2 $bar Dec 07 12:00:25.813 INFO [stdout] -- @main2/bar Dec 07 12:00:25.813 INFO [stdout] a: 20 Dec 07 12:00:25.813 INFO [stdout] b: 10 Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] -- $foo Dec 07 12:00:25.813 INFO [stdout] -- @main $title ~text Dec 07 12:00:25.813 INFO [stdout] -- @children[] ~text Dec 07 12:00:25.813 INFO [stdout] child 1 Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] -- $foo Dec 07 12:00:25.813 INFO [stdout] -- @main $title ~text Dec 07 12:00:25.813 INFO [stdout] -- @children[] ~text Dec 07 12:00:25.813 INFO [stdout] child 1 Dec 07 12:00:25.813 INFO [stdout] -- @children[] ~text Dec 07 12:00:25.813 INFO [stdout] child 2 Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] -- $foo Dec 07 12:00:25.813 INFO [stdout] -- @main $title ~text Dec 07 12:00:25.813 INFO [stdout] -- @children[] $bar Dec 07 12:00:25.813 INFO [stdout] -- @children[]/bar Dec 07 12:00:25.813 INFO [stdout] a: 20 Dec 07 12:00:25.813 INFO [stdout] b: 10 Dec 07 12:00:25.813 INFO [stdout] -- @children[] $bar Dec 07 12:00:25.813 INFO [stdout] -- @children[]/bar Dec 07 12:00:25.813 INFO [stdout] x: 20 Dec 07 12:00:25.813 INFO [stdout] y: 10 Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] -- $foo Dec 07 12:00:25.813 INFO [stdout] -- @main $title ~text Dec 07 12:00:25.813 INFO [stdout] -- @children[] $bar Dec 07 12:00:25.813 INFO [stdout] -- @children[]/bar Dec 07 12:00:25.813 INFO [stdout] a: 20 Dec 07 12:00:25.813 INFO [stdout] b: 10 Dec 07 12:00:25.813 INFO [stdout] -- @children[] $foo Dec 07 12:00:25.813 INFO [stdout] -- @children[]/children[] ~text Dec 07 12:00:25.813 INFO [stdout] nested child Dec 07 12:00:25.813 INFO [stdout] -- @children[]/main ~text Dec 07 12:00:25.813 INFO [stdout] inner main Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.813 INFO [stdout] Dec 07 12:00:25.813 INFO [stdout] -- $nested Dec 07 12:00:25.813 INFO [stdout] -- @title ~text Dec 07 12:00:25.814 INFO [stdout] the title Dec 07 12:00:25.814 INFO [stdout] Dec 07 12:00:25.814 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.814 INFO [stdout] Dec 07 12:00:25.814 INFO [stdout] -- $array Dec 07 12:00:25.814 INFO [stdout] -- @title ~text Dec 07 12:00:25.814 INFO [stdout] the title Dec 07 12:00:25.814 INFO [stdout] Dec 07 12:00:25.814 INFO [stdout] ============= TEST ============== Dec 07 12:00:25.814 INFO [stdout] Dec 07 12:00:25.814 INFO [stdout] -- $array2 Dec 07 12:00:25.814 INFO [stdout] -- @title ~text Dec 07 12:00:25.814 INFO [stdout] the title Dec 07 12:00:25.814 INFO [stdout] Dec 07 12:00:25.814 INFO [stdout] thread 'convert::tests::convert' panicked at 'assertion failed: `(left == right)` Dec 07 12:00:25.814 INFO [stdout] left: `Object({"obj": Array([Object({"$ref": String("title")})]), "title": String("the title")})`, Dec 07 12:00:25.814 INFO [stdout] right: `Object({"obj": Array([String("the title")]), "title": String("the title")})`', src/convert.rs:152:9 Dec 07 12:00:25.814 INFO [stdout] stack backtrace: Dec 07 12:00:25.814 INFO [stdout] 0: 0x5643ecdb1da3 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7 Dec 07 12:00:25.814 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 07 12:00:25.814 INFO [stdout] 1: 0x5643ecdac458 - std::sys_common::backtrace::_print::h95865c77318e98b7 Dec 07 12:00:25.814 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 07 12:00:25.814 INFO [stdout] 2: 0x5643ecdb0d12 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5 Dec 07 12:00:25.814 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 07 12:00:25.814 INFO [stdout] at src/libstd/panicking.rs:211 Dec 07 12:00:25.814 INFO [stdout] 3: 0x5643ecdb09fc - std::panicking::default_hook::h4eae6f26f73244c8 Dec 07 12:00:25.814 INFO [stdout] at src/libstd/panicking.rs:221 Dec 07 12:00:25.814 INFO [stdout] 4: 0x5643ecdb1420 - std::panicking::rust_panic_with_hook::h368d37fd53b59464 Dec 07 12:00:25.814 INFO [stdout] at src/libstd/panicking.rs:491 Dec 07 12:00:25.814 INFO [stdout] 5: 0x5643ecdb0fa1 - std::panicking::continue_panic_fmt::h1599d634b3be4304 Dec 07 12:00:25.814 INFO [stdout] at src/libstd/panicking.rs:398 Dec 07 12:00:25.814 INFO [stdout] 6: 0x5643ecdb0eee - std::panicking::begin_panic_fmt::h2c0a418aaab204b3 Dec 07 12:00:25.814 INFO [stdout] at src/libstd/panicking.rs:353 Dec 07 12:00:25.814 INFO [stdout] 7: 0x5643ec83c308 - graft::convert::tests::t::h5bb2600a539f6a34 Dec 07 12:00:25.814 INFO [stdout] at src/convert.rs:152 Dec 07 12:00:25.814 INFO [stdout] 8: 0x5643ec841fba - graft::convert::tests::convert::h8e3477a3cf39a2be Dec 07 12:00:25.814 INFO [stdout] at src/convert.rs:588 Dec 07 12:00:25.814 INFO [stdout] 9: 0x5643ec83c379 - graft::convert::tests::convert::{{closure}}::h02b71ee3cc42099a Dec 07 12:00:25.814 INFO [stdout] at src/convert.rs:159 Dec 07 12:00:25.814 INFO [stdout] 10: 0x5643ec853e5d - core::ops::function::FnOnce::call_once::hdb78448bb62a5e2c Dec 07 12:00:25.814 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 07 12:00:25.814 INFO [stdout] 11: 0x5643ec87f0fe - >::call_box::h994167e0fc25f327 Dec 07 12:00:25.814 INFO [stdout] at src/libtest/lib.rs:1471 Dec 07 12:00:25.814 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 07 12:00:25.814 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 12:00:25.814 INFO [stdout] 12: 0x5643ecdbfd29 - __rust_maybe_catch_panic Dec 07 12:00:25.814 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 12:00:25.814 INFO [stdout] 13: 0x5643ec877003 - std::sys_common::backtrace::__rust_begin_short_backtrace::h5d34cfb78512c8c3 Dec 07 12:00:25.814 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 12:00:25.814 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 12:00:25.814 INFO [stdout] at src/libtest/lib.rs:1426 Dec 07 12:00:25.814 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136 Dec 07 12:00:25.814 INFO [stdout] 14: 0x5643ec877f24 - std::panicking::try::do_call::h7a86b6211ebb5e72 Dec 07 12:00:25.814 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477 Dec 07 12:00:25.814 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319 Dec 07 12:00:25.814 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310 Dec 07 12:00:25.814 INFO [stdout] 15: 0x5643ecdbfd29 - __rust_maybe_catch_panic Dec 07 12:00:25.814 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 12:00:25.814 INFO [stdout] 16: 0x5643ec87efdc - >::call_box::h877dbe22cb3997f4 Dec 07 12:00:25.814 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 12:00:25.814 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 12:00:25.814 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476 Dec 07 12:00:25.814 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 12:00:25.814 INFO [stdout] 17: 0x5643ecdb39ed - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd Dec 07 12:00:25.814 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683 Dec 07 12:00:25.814 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 07 12:00:25.814 INFO [stdout] at src/libstd/sys/unix/thread.rs:90 Dec 07 12:00:25.814 INFO [stdout] 18: 0x7fdd058ca6b9 - start_thread Dec 07 12:00:25.814 INFO [stdout] 19: 0x7fdd053ea41c - clone Dec 07 12:00:25.814 INFO [stdout] 20: 0x0 - Dec 07 12:00:25.814 INFO [stdout] Dec 07 12:00:25.814 INFO [stdout] Dec 07 12:00:25.814 INFO [stdout] failures: Dec 07 12:00:25.814 INFO [stdout] convert::tests::convert Dec 07 12:00:25.814 INFO [stdout] Dec 07 12:00:25.814 INFO [stdout] test result: FAILED. 1 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 12:00:25.814 INFO [stdout] Dec 07 12:00:25.814 INFO [stderr] error: test failed, to rerun pass '--lib' Dec 07 12:00:25.815 INFO [stderr] su: No module specific data is present Dec 07 12:00:26.234 INFO running `"docker" "inspect" "ac39599ab64b6fea887555270a90d0943838c46f34e4585ffe8acd79b1c7ce0e"` Dec 07 12:00:26.310 INFO running `"docker" "rm" "-f" "ac39599ab64b6fea887555270a90d0943838c46f34e4585ffe8acd79b1c7ce0e"` Dec 07 12:00:26.405 INFO [stdout] ac39599ab64b6fea887555270a90d0943838c46f34e4585ffe8acd79b1c7ce0e