Dec 06 14:46:48.380 INFO testing DD5HT/dxtracker against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514 Dec 06 14:46:48.380 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 14:46:48.571 INFO [stdout] 59853d57894965430b7e5e35aa20ce105ffd858d57886a0c5d9539b521281aef Dec 06 14:46:48.574 INFO running `"docker" "start" "-a" "59853d57894965430b7e5e35aa20ce105ffd858d57886a0c5d9539b521281aef"` Dec 06 14:46:48.956 INFO [stderr] usermod: no changes Dec 06 14:46:49.069 INFO [stderr] Compiling syn v0.14.7 Dec 06 14:46:54.328 INFO [stderr] Compiling serde_derive v1.0.70 Dec 06 14:47:03.300 INFO [stderr] Compiling dxtracker v0.1.2 (/source) Dec 06 14:47:10.772 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 21.79s Dec 06 14:47:10.778 INFO [stderr] su: No module specific data is present Dec 06 14:47:11.132 INFO running `"docker" "inspect" "59853d57894965430b7e5e35aa20ce105ffd858d57886a0c5d9539b521281aef"` Dec 06 14:47:11.336 INFO running `"docker" "rm" "-f" "59853d57894965430b7e5e35aa20ce105ffd858d57886a0c5d9539b521281aef"` Dec 06 14:47:11.420 INFO [stdout] 59853d57894965430b7e5e35aa20ce105ffd858d57886a0c5d9539b521281aef Dec 06 14:47:11.421 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 14:47:11.601 INFO [stdout] d1326412a91e0cce44f43b542f76c5ce68725f95ffccbdfc231108075fbae453 Dec 06 14:47:11.605 INFO running `"docker" "start" "-a" "d1326412a91e0cce44f43b542f76c5ce68725f95ffccbdfc231108075fbae453"` Dec 06 14:47:12.221 INFO [stderr] usermod: no changes Dec 06 14:47:12.292 INFO [stderr] Compiling dxtracker v0.1.2 (/source) Dec 06 14:47:15.448 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 3.21s Dec 06 14:47:15.450 INFO [stderr] su: No module specific data is present Dec 06 14:47:15.730 INFO running `"docker" "inspect" "d1326412a91e0cce44f43b542f76c5ce68725f95ffccbdfc231108075fbae453"` Dec 06 14:47:15.792 INFO running `"docker" "rm" "-f" "d1326412a91e0cce44f43b542f76c5ce68725f95ffccbdfc231108075fbae453"` Dec 06 14:47:15.857 INFO [stdout] d1326412a91e0cce44f43b542f76c5ce68725f95ffccbdfc231108075fbae453 Dec 06 14:47:15.859 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 14:47:16.063 INFO [stdout] e5275c79d40c00f7dde15bee29e0d138221ed5562fa0848f4c66e93168b85cc6 Dec 06 14:47:16.065 INFO running `"docker" "start" "-a" "e5275c79d40c00f7dde15bee29e0d138221ed5562fa0848f4c66e93168b85cc6"` Dec 06 14:47:16.418 INFO [stderr] usermod: no changes Dec 06 14:47:16.507 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.07s Dec 06 14:47:16.516 INFO [stderr] Running /target/debug/deps/dxtracker-4024b2b874840d45 Dec 06 14:47:16.516 INFO [stdout] Dec 06 14:47:16.516 INFO [stdout] running 3 tests Dec 06 14:47:16.516 INFO [stdout] test cluster::tests::filter_entry_test ... ok Dec 06 14:47:16.522 INFO [stdout] test dxcc_filter::tests::match_call_test ... ok Dec 06 14:47:16.523 INFO [stdout] test dxcc_filter::tests::prefix_regex_test ... ok Dec 06 14:47:16.523 INFO [stdout] Dec 06 14:47:16.523 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 06 14:47:16.523 INFO [stdout] Dec 06 14:47:16.525 INFO [stderr] Running /target/debug/deps/dxtool-51a8affa5eed92f6 Dec 06 14:47:16.526 INFO [stdout] Dec 06 14:47:16.526 INFO [stdout] running 0 tests Dec 06 14:47:16.526 INFO [stdout] Dec 06 14:47:16.526 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 06 14:47:16.526 INFO [stdout] Dec 06 14:47:16.526 INFO [stderr] Running /target/debug/deps/integration_test-634416bfe4a097a9 Dec 06 14:47:16.527 INFO [stdout] Dec 06 14:47:16.527 INFO [stdout] running 2 tests Dec 06 14:47:16.562 INFO [stdout] test cluster_insert_remove ... FAILED Dec 06 14:47:16.562 INFO [stdout] test load_config ... FAILED Dec 06 14:47:16.562 INFO [stdout] Dec 06 14:47:16.562 INFO [stdout] failures: Dec 06 14:47:16.562 INFO [stdout] Dec 06 14:47:16.562 INFO [stdout] ---- cluster_insert_remove stdout ---- Dec 06 14:47:16.562 INFO [stdout] thread 'cluster_insert_remove' panicked at 'assertion failed: dxtracker::dir_build().is_ok()', tests/integration_test.rs:30:5 Dec 06 14:47:16.562 INFO [stdout] stack backtrace: Dec 06 14:47:16.562 INFO [stdout] 0: 0x56264073bf83 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7 Dec 06 14:47:16.562 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 06 14:47:16.562 INFO [stdout] 1: 0x562640736638 - std::sys_common::backtrace::_print::h95865c77318e98b7 Dec 06 14:47:16.562 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 06 14:47:16.562 INFO [stdout] 2: 0x56264073aef2 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5 Dec 06 14:47:16.562 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 06 14:47:16.562 INFO [stdout] at src/libstd/panicking.rs:211 Dec 06 14:47:16.562 INFO [stdout] 3: 0x56264073abdc - std::panicking::default_hook::h4eae6f26f73244c8 Dec 06 14:47:16.562 INFO [stdout] at src/libstd/panicking.rs:221 Dec 06 14:47:16.562 INFO [stdout] 4: 0x56264073b600 - std::panicking::rust_panic_with_hook::h368d37fd53b59464 Dec 06 14:47:16.562 INFO [stdout] at src/libstd/panicking.rs:491 Dec 06 14:47:16.562 INFO [stdout] 5: 0x5626407289e7 - std::panicking::begin_panic::h7fc08b5b5e6e08a4 Dec 06 14:47:16.562 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:425 Dec 06 14:47:16.562 INFO [stdout] 6: 0x56264067cee4 - integration_test::create_directory::h82e82c334ed45f6b Dec 06 14:47:16.562 INFO [stdout] at tests/integration_test.rs:30 Dec 06 14:47:16.562 INFO [stdout] 7: 0x56264067cf0b - integration_test::open_callsign_list::hdc55629357b0e164 Dec 06 14:47:16.562 INFO [stdout] at tests/integration_test.rs:34 Dec 06 14:47:16.562 INFO [stdout] 8: 0x56264067d3a3 - integration_test::cluster_insert_remove::h5fa1024d75421db6 Dec 06 14:47:16.562 INFO [stdout] at tests/integration_test.rs:7 Dec 06 14:47:16.562 INFO [stdout] 9: 0x56264067d379 - integration_test::cluster_insert_remove::{{closure}}::h12fee5892afb4b63 Dec 06 14:47:16.562 INFO [stdout] at tests/integration_test.rs:6 Dec 06 14:47:16.562 INFO [stdout] 10: 0x56264067f9ed - core::ops::function::FnOnce::call_once::hb6a90f4b2c9a0c1e Dec 06 14:47:16.562 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 06 14:47:16.562 INFO [stdout] 11: 0x56264068882e - >::call_box::h994167e0fc25f327 Dec 06 14:47:16.562 INFO [stdout] at src/libtest/lib.rs:1471 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 06 14:47:16.563 INFO [stdout] 12: 0x562640749cd9 - __rust_maybe_catch_panic Dec 06 14:47:16.563 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 06 14:47:16.563 INFO [stdout] 13: 0x562640680733 - std::sys_common::backtrace::__rust_begin_short_backtrace::h5d34cfb78512c8c3 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 06 14:47:16.563 INFO [stdout] at src/libtest/lib.rs:1426 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136 Dec 06 14:47:16.563 INFO [stdout] 14: 0x562640681654 - std::panicking::try::do_call::h7a86b6211ebb5e72 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310 Dec 06 14:47:16.563 INFO [stdout] 15: 0x562640749cd9 - __rust_maybe_catch_panic Dec 06 14:47:16.563 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 06 14:47:16.563 INFO [stdout] 16: 0x56264068870c - >::call_box::h877dbe22cb3997f4 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 06 14:47:16.563 INFO [stdout] 17: 0x56264073dc9d - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683 Dec 06 14:47:16.563 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 06 14:47:16.563 INFO [stdout] at src/libstd/sys/unix/thread.rs:90 Dec 06 14:47:16.563 INFO [stdout] 18: 0x7fde2e79a6b9 - start_thread Dec 06 14:47:16.563 INFO [stdout] 19: 0x7fde2e2ba41c - clone Dec 06 14:47:16.563 INFO [stdout] 20: 0x0 - Dec 06 14:47:16.563 INFO [stdout] Dec 06 14:47:16.563 INFO [stdout] ---- load_config stdout ---- Dec 06 14:47:16.563 INFO [stdout] thread 'load_config' panicked at 'assertion failed: dxtracker::dir_build().is_ok()', tests/integration_test.rs:30:5 Dec 06 14:47:16.563 INFO [stdout] stack backtrace: Dec 06 14:47:16.563 INFO [stdout] 0: 0x56264073bf83 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7 Dec 06 14:47:16.563 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 06 14:47:16.563 INFO [stdout] 1: 0x562640736638 - std::sys_common::backtrace::_print::h95865c77318e98b7 Dec 06 14:47:16.563 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 06 14:47:16.563 INFO [stdout] 2: 0x56264073aef2 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5 Dec 06 14:47:16.563 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 06 14:47:16.563 INFO [stdout] at src/libstd/panicking.rs:211 Dec 06 14:47:16.563 INFO [stdout] 3: 0x56264073abdc - std::panicking::default_hook::h4eae6f26f73244c8 Dec 06 14:47:16.563 INFO [stdout] at src/libstd/panicking.rs:221 Dec 06 14:47:16.563 INFO [stdout] 4: 0x56264073b600 - std::panicking::rust_panic_with_hook::h368d37fd53b59464 Dec 06 14:47:16.563 INFO [stdout] at src/libstd/panicking.rs:491 Dec 06 14:47:16.563 INFO [stdout] 5: 0x5626407289e7 - std::panicking::begin_panic::h7fc08b5b5e6e08a4 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:425 Dec 06 14:47:16.563 INFO [stdout] 6: 0x56264067cee4 - integration_test::create_directory::h82e82c334ed45f6b Dec 06 14:47:16.563 INFO [stdout] at tests/integration_test.rs:30 Dec 06 14:47:16.563 INFO [stdout] 7: 0x56264067d233 - integration_test::create_config::hf916fa91cb4197d6 Dec 06 14:47:16.563 INFO [stdout] at tests/integration_test.rs:44 Dec 06 14:47:16.563 INFO [stdout] 8: 0x56264067da63 - integration_test::load_config::h25e5e3c7767b60ab Dec 06 14:47:16.563 INFO [stdout] at tests/integration_test.rs:21 Dec 06 14:47:16.563 INFO [stdout] 9: 0x56264067da39 - integration_test::load_config::{{closure}}::h83491258b0abbb4d Dec 06 14:47:16.563 INFO [stdout] at tests/integration_test.rs:18 Dec 06 14:47:16.563 INFO [stdout] 10: 0x56264067fa2d - core::ops::function::FnOnce::call_once::hfcfa7df50ad38792 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 06 14:47:16.563 INFO [stdout] 11: 0x56264068882e - >::call_box::h994167e0fc25f327 Dec 06 14:47:16.563 INFO [stdout] at src/libtest/lib.rs:1471 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 06 14:47:16.563 INFO [stdout] 12: 0x562640749cd9 - __rust_maybe_catch_panic Dec 06 14:47:16.563 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 06 14:47:16.563 INFO [stdout] 13: 0x562640680733 - std::sys_common::backtrace::__rust_begin_short_backtrace::h5d34cfb78512c8c3 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 06 14:47:16.563 INFO [stdout] at src/libtest/lib.rs:1426 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136 Dec 06 14:47:16.563 INFO [stdout] 14: 0x562640681654 - std::panicking::try::do_call::h7a86b6211ebb5e72 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310 Dec 06 14:47:16.563 INFO [stdout] 15: 0x562640749cd9 - __rust_maybe_catch_panic Dec 06 14:47:16.563 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 06 14:47:16.563 INFO [stdout] 16: 0x56264068870c - >::call_box::h877dbe22cb3997f4 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476 Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 06 14:47:16.563 INFO [stdout] 17: 0x56264073dc9d - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd Dec 06 14:47:16.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683 Dec 06 14:47:16.563 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 06 14:47:16.563 INFO [stdout] at src/libstd/sys/unix/thread.rs:90 Dec 06 14:47:16.563 INFO [stdout] 18: 0x7fde2e79a6b9 - start_thread Dec 06 14:47:16.563 INFO [stdout] 19: 0x7fde2e2ba41c - clone Dec 06 14:47:16.563 INFO [stdout] 20: 0x0 - Dec 06 14:47:16.563 INFO [stdout] Dec 06 14:47:16.563 INFO [stdout] Dec 06 14:47:16.563 INFO [stdout] failures: Dec 06 14:47:16.563 INFO [stdout] cluster_insert_remove Dec 06 14:47:16.563 INFO [stdout] load_config Dec 06 14:47:16.563 INFO [stdout] Dec 06 14:47:16.564 INFO [stdout] test result: FAILED. 0 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out Dec 06 14:47:16.564 INFO [stdout] Dec 06 14:47:16.564 INFO [stderr] error: test failed, to rerun pass '--test integration_test' Dec 06 14:47:16.565 INFO [stderr] su: No module specific data is present Dec 06 14:47:16.845 INFO running `"docker" "inspect" "e5275c79d40c00f7dde15bee29e0d138221ed5562fa0848f4c66e93168b85cc6"` Dec 06 14:47:16.922 INFO running `"docker" "rm" "-f" "e5275c79d40c00f7dde15bee29e0d138221ed5562fa0848f4c66e93168b85cc6"` Dec 06 14:47:17.049 INFO [stdout] e5275c79d40c00f7dde15bee29e0d138221ed5562fa0848f4c66e93168b85cc6