Dec 06 19:02:36.858 INFO testing tvm-0.1.0 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514 Dec 06 19:02:36.858 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 06 19:02:37.244 INFO [stdout] 84b364086822623d70778b3a7268074eda983d9d8996b6e625b227cf9ff2d843 Dec 06 19:02:37.248 INFO running `"docker" "start" "-a" "84b364086822623d70778b3a7268074eda983d9d8996b6e625b227cf9ff2d843"` Dec 06 19:02:38.556 INFO [stderr] usermod: no changes Dec 06 19:02:38.776 INFO [stderr] Compiling bounded-spsc-queue v0.4.0 Dec 06 19:02:38.816 INFO [stderr] Compiling ndarray v0.11.2 Dec 06 19:02:38.816 INFO [stderr] Compiling nom v4.1.1 Dec 06 19:02:50.848 INFO [stderr] Compiling tvm v0.1.0 (/source) Dec 06 19:02:53.152 INFO [stderr] warning: the feature `extern_prelude` has been stable since 1.30.0 and no longer requires an attribute to enable Dec 06 19:02:53.152 INFO [stderr] --> src/lib.rs:5:3 Dec 06 19:02:53.152 INFO [stderr] | Dec 06 19:02:53.152 INFO [stderr] 5 | extern_prelude, Dec 06 19:02:53.152 INFO [stderr] | ^^^^^^^^^^^^^^ Dec 06 19:02:53.152 INFO [stderr] | Dec 06 19:02:53.152 INFO [stderr] = note: #[warn(stable_features)] on by default Dec 06 19:02:53.152 INFO [stderr] Dec 06 19:02:57.857 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 19.28s Dec 06 19:02:57.862 INFO [stderr] su: No module specific data is present Dec 06 19:02:58.988 INFO running `"docker" "inspect" "84b364086822623d70778b3a7268074eda983d9d8996b6e625b227cf9ff2d843"` Dec 06 19:02:59.322 INFO running `"docker" "rm" "-f" "84b364086822623d70778b3a7268074eda983d9d8996b6e625b227cf9ff2d843"` Dec 06 19:02:59.680 INFO [stdout] 84b364086822623d70778b3a7268074eda983d9d8996b6e625b227cf9ff2d843 Dec 06 19:02:59.688 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 06 19:03:00.196 INFO [stdout] d8ae12ef25aba40ff41e3e6da68f6edc4d0642a051182fb6ee4befcaf72a5caf Dec 06 19:03:00.202 INFO running `"docker" "start" "-a" "d8ae12ef25aba40ff41e3e6da68f6edc4d0642a051182fb6ee4befcaf72a5caf"` Dec 06 19:03:02.305 INFO [stderr] usermod: no changes Dec 06 19:03:02.404 INFO [stderr] Compiling tvm v0.1.0 (/source) Dec 06 19:03:06.176 INFO [stderr] warning: unused import: `collections::HashMap` Dec 06 19:03:06.176 INFO [stderr] --> tests/test_graph_serde.rs:8:11 Dec 06 19:03:06.176 INFO [stderr] | Dec 06 19:03:06.176 INFO [stderr] 8 | use std::{collections::HashMap, convert::TryFrom, fs, io::Read}; Dec 06 19:03:06.176 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^ Dec 06 19:03:06.176 INFO [stderr] | Dec 06 19:03:06.176 INFO [stderr] = note: #[warn(unused_imports)] on by default Dec 06 19:03:06.176 INFO [stderr] Dec 06 19:03:06.251 INFO [stderr] warning: unused variable: `params` Dec 06 19:03:06.251 INFO [stderr] --> tests/test_graph_serde.rs:19:7 Dec 06 19:03:06.251 INFO [stderr] | Dec 06 19:03:06.251 INFO [stderr] 19 | let params = tvm::runtime::load_param_dict(¶ms_bytes); Dec 06 19:03:06.251 INFO [stderr] | ^^^^^^ help: consider using `_params` instead Dec 06 19:03:06.251 INFO [stderr] | Dec 06 19:03:06.251 INFO [stderr] = note: #[warn(unused_variables)] on by default Dec 06 19:03:06.251 INFO [stderr] Dec 06 19:03:06.264 INFO [stderr] warning: the feature `fs_read_write` has been stable since 1.26.0 and no longer requires an attribute to enable Dec 06 19:03:06.264 INFO [stderr] --> tests/test_graph_serde.rs:1:12 Dec 06 19:03:06.264 INFO [stderr] | Dec 06 19:03:06.264 INFO [stderr] 1 | #![feature(fs_read_write, try_from)] Dec 06 19:03:06.264 INFO [stderr] | ^^^^^^^^^^^^^ Dec 06 19:03:06.264 INFO [stderr] | Dec 06 19:03:06.264 INFO [stderr] = note: #[warn(stable_features)] on by default Dec 06 19:03:06.264 INFO [stderr] Dec 06 19:03:06.889 INFO [stderr] warning: the feature `extern_prelude` has been stable since 1.30.0 and no longer requires an attribute to enable Dec 06 19:03:06.889 INFO [stderr] --> src/lib.rs:5:3 Dec 06 19:03:06.889 INFO [stderr] | Dec 06 19:03:06.889 INFO [stderr] 5 | extern_prelude, Dec 06 19:03:06.889 INFO [stderr] | ^^^^^^^^^^^^^^ Dec 06 19:03:06.889 INFO [stderr] | Dec 06 19:03:06.889 INFO [stderr] = note: #[warn(stable_features)] on by default Dec 06 19:03:06.889 INFO [stderr] Dec 06 19:03:09.328 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 7.00s Dec 06 19:03:09.335 INFO [stderr] su: No module specific data is present Dec 06 19:03:10.378 INFO running `"docker" "inspect" "d8ae12ef25aba40ff41e3e6da68f6edc4d0642a051182fb6ee4befcaf72a5caf"` Dec 06 19:03:10.633 INFO running `"docker" "rm" "-f" "d8ae12ef25aba40ff41e3e6da68f6edc4d0642a051182fb6ee4befcaf72a5caf"` Dec 06 19:03:10.896 INFO [stdout] d8ae12ef25aba40ff41e3e6da68f6edc4d0642a051182fb6ee4befcaf72a5caf Dec 06 19:03:10.904 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 06 19:03:11.298 INFO [stdout] fda18def4adbb2761a981918ae9dbc9cc57c6932ed43d14f738c550c911406dc Dec 06 19:03:11.304 INFO running `"docker" "start" "-a" "fda18def4adbb2761a981918ae9dbc9cc57c6932ed43d14f738c550c911406dc"` Dec 06 19:03:13.076 INFO [stderr] usermod: no changes Dec 06 19:03:13.204 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.10s Dec 06 19:03:13.218 INFO [stderr] Running /target/debug/deps/tvm-9e0b81ea833db283 Dec 06 19:03:13.220 INFO [stdout] Dec 06 19:03:13.220 INFO [stdout] running 3 tests Dec 06 19:03:13.220 INFO [stdout] test runtime::graph::tests::test_str_to_type ... ok Dec 06 19:03:13.224 INFO [stdout] test runtime::threading::tests::test_max_concurrency ... ok Dec 06 19:03:13.484 INFO [stdout] test runtime::threading::tests::test_parallel_launch ... ok Dec 06 19:03:13.484 INFO [stdout] Dec 06 19:03:13.484 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 06 19:03:13.484 INFO [stdout] Dec 06 19:03:13.560 INFO [stderr] Running /target/debug/deps/test_graph_serde-62bbe5242de212b7 Dec 06 19:03:13.568 INFO [stdout] Dec 06 19:03:13.568 INFO [stdout] running 1 test Dec 06 19:03:13.620 INFO [stdout] test test_load_graph ... FAILED Dec 06 19:03:13.621 INFO [stdout] Dec 06 19:03:13.621 INFO [stdout] failures: Dec 06 19:03:13.621 INFO [stdout] Dec 06 19:03:13.621 INFO [stdout] ---- test_load_graph stdout ---- Dec 06 19:03:13.621 INFO [stdout] thread 'test_load_graph' panicked at 'called `Result::unwrap()` on an `Err` value: Os { code: 2, kind: NotFound, message: "No such file or directory" }', src/libcore/result.rs:1009:5 Dec 06 19:03:13.621 INFO [stdout] stack backtrace: Dec 06 19:03:13.621 INFO [stdout] 0: 0x55e4d0dd8963 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7 Dec 06 19:03:13.621 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 06 19:03:13.621 INFO [stdout] 1: 0x55e4d0dd3018 - std::sys_common::backtrace::_print::h95865c77318e98b7 Dec 06 19:03:13.621 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 06 19:03:13.621 INFO [stdout] 2: 0x55e4d0dd78d2 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5 Dec 06 19:03:13.621 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 06 19:03:13.621 INFO [stdout] at src/libstd/panicking.rs:211 Dec 06 19:03:13.621 INFO [stdout] 3: 0x55e4d0dd75bc - std::panicking::default_hook::h4eae6f26f73244c8 Dec 06 19:03:13.621 INFO [stdout] at src/libstd/panicking.rs:221 Dec 06 19:03:13.621 INFO [stdout] 4: 0x55e4d0dd7fe0 - std::panicking::rust_panic_with_hook::h368d37fd53b59464 Dec 06 19:03:13.621 INFO [stdout] at src/libstd/panicking.rs:491 Dec 06 19:03:13.621 INFO [stdout] 5: 0x55e4d0dd7b61 - std::panicking::continue_panic_fmt::h1599d634b3be4304 Dec 06 19:03:13.621 INFO [stdout] at src/libstd/panicking.rs:398 Dec 06 19:03:13.621 INFO [stdout] 6: 0x55e4d0dd7a45 - rust_begin_unwind Dec 06 19:03:13.621 INFO [stdout] at src/libstd/panicking.rs:325 Dec 06 19:03:13.621 INFO [stdout] 7: 0x55e4d0deb3cc - core::panicking::panic_fmt::hdc202e6077c95723 Dec 06 19:03:13.621 INFO [stdout] at src/libcore/panicking.rs:95 Dec 06 19:03:13.621 INFO [stdout] 8: 0x55e4d0d5fe80 - core::result::unwrap_failed::habf408afe1cef0e0 Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/macros.rs:26 Dec 06 19:03:13.621 INFO [stdout] 9: 0x55e4d0d0bcea - >::unwrap::h64b3bbfbc0d89b8e Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/result.rs:808 Dec 06 19:03:13.621 INFO [stdout] 10: 0x55e4d0d09541 - test_graph_serde::test_load_graph::hecbf1a5f6285f6ce Dec 06 19:03:13.621 INFO [stdout] at tests/test_graph_serde.rs:15 Dec 06 19:03:13.621 INFO [stdout] 11: 0x55e4d0d094d9 - test_graph_serde::test_load_graph::{{closure}}::hacc4994edca64873 Dec 06 19:03:13.621 INFO [stdout] at tests/test_graph_serde.rs:13 Dec 06 19:03:13.621 INFO [stdout] 12: 0x55e4d0d0aaed - core::ops::function::FnOnce::call_once::h4864831282fe3513 Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 06 19:03:13.621 INFO [stdout] 13: 0x55e4d0d1570e - >::call_box::h994167e0fc25f327 Dec 06 19:03:13.621 INFO [stdout] at src/libtest/lib.rs:1471 Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 06 19:03:13.621 INFO [stdout] 14: 0x55e4d0de65a9 - __rust_maybe_catch_panic Dec 06 19:03:13.621 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 06 19:03:13.621 INFO [stdout] 15: 0x55e4d0d0d613 - std::sys_common::backtrace::__rust_begin_short_backtrace::h5d34cfb78512c8c3 Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 06 19:03:13.621 INFO [stdout] at src/libtest/lib.rs:1426 Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136 Dec 06 19:03:13.621 INFO [stdout] 16: 0x55e4d0d0e534 - std::panicking::try::do_call::h7a86b6211ebb5e72 Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477 Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319 Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310 Dec 06 19:03:13.621 INFO [stdout] 17: 0x55e4d0de65a9 - __rust_maybe_catch_panic Dec 06 19:03:13.621 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 06 19:03:13.621 INFO [stdout] 18: 0x55e4d0d155ec - >::call_box::h877dbe22cb3997f4 Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476 Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 06 19:03:13.621 INFO [stdout] 19: 0x55e4d0dda56d - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd Dec 06 19:03:13.621 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683 Dec 06 19:03:13.621 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 06 19:03:13.621 INFO [stdout] at src/libstd/sys/unix/thread.rs:90 Dec 06 19:03:13.621 INFO [stdout] 20: 0x7f72610f96b9 - start_thread Dec 06 19:03:13.621 INFO [stdout] 21: 0x7f7260c1941c - clone Dec 06 19:03:13.621 INFO [stdout] 22: 0x0 - Dec 06 19:03:13.621 INFO [stdout] Dec 06 19:03:13.621 INFO [stdout] Dec 06 19:03:13.621 INFO [stdout] failures: Dec 06 19:03:13.621 INFO [stdout] test_load_graph Dec 06 19:03:13.621 INFO [stdout] Dec 06 19:03:13.621 INFO [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Dec 06 19:03:13.621 INFO [stdout] Dec 06 19:03:13.633 INFO [stderr] error: test failed, to rerun pass '--test test_graph_serde' Dec 06 19:03:13.635 INFO [stderr] su: No module specific data is present Dec 06 19:03:14.756 INFO running `"docker" "inspect" "fda18def4adbb2761a981918ae9dbc9cc57c6932ed43d14f738c550c911406dc"` Dec 06 19:03:14.996 INFO running `"docker" "rm" "-f" "fda18def4adbb2761a981918ae9dbc9cc57c6932ed43d14f738c550c911406dc"` Dec 06 19:03:15.417 INFO [stdout] fda18def4adbb2761a981918ae9dbc9cc57c6932ed43d14f738c550c911406dc