Nov 18 01:58:58.982 INFO testing resol-vbus-0.1.1 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 01:58:58.984 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 01:58:59.394 INFO [stdout] 0b2394390528f070b58b015fb14595d7a552ec4550aa69904220bf53fc6b8919
Nov 18 01:58:59.396 INFO running `"docker" "start" "-a" "0b2394390528f070b58b015fb14595d7a552ec4550aa69904220bf53fc6b8919"`
Nov 18 01:58:59.864 INFO [stderr] usermod: no changes
Nov 18 01:58:59.910 INFO [stderr]    Compiling resol-vbus v0.1.1 (/source)
Nov 18 01:59:02.171 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.28s
Nov 18 01:59:02.173 INFO [stderr] su: No module specific data is present
Nov 18 01:59:02.435 INFO running `"docker" "inspect" "0b2394390528f070b58b015fb14595d7a552ec4550aa69904220bf53fc6b8919"`
Nov 18 01:59:02.499 INFO running `"docker" "rm" "-f" "0b2394390528f070b58b015fb14595d7a552ec4550aa69904220bf53fc6b8919"`
Nov 18 01:59:02.587 INFO [stdout] 0b2394390528f070b58b015fb14595d7a552ec4550aa69904220bf53fc6b8919
Nov 18 01:59:02.594 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 01:59:02.776 INFO [stdout] 333360f54cdfd43407762688abc580f6c13d215cac8b56fd5cf79325f1bf738e
Nov 18 01:59:02.778 INFO running `"docker" "start" "-a" "333360f54cdfd43407762688abc580f6c13d215cac8b56fd5cf79325f1bf738e"`
Nov 18 01:59:03.178 INFO [stderr] usermod: no changes
Nov 18 01:59:03.223 INFO [stderr]    Compiling resol-vbus v0.1.1 (/source)
Nov 18 01:59:09.571 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.37s
Nov 18 01:59:09.578 INFO [stderr] su: No module specific data is present
Nov 18 01:59:10.099 INFO running `"docker" "inspect" "333360f54cdfd43407762688abc580f6c13d215cac8b56fd5cf79325f1bf738e"`
Nov 18 01:59:10.264 INFO running `"docker" "rm" "-f" "333360f54cdfd43407762688abc580f6c13d215cac8b56fd5cf79325f1bf738e"`
Nov 18 01:59:10.377 INFO [stdout] 333360f54cdfd43407762688abc580f6c13d215cac8b56fd5cf79325f1bf738e
Nov 18 01:59:10.381 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 01:59:10.618 INFO [stdout] 1a601b90bb5bb4c6517d47b9b6a444341dc48354158f02d3e7aa900c9dfc364e
Nov 18 01:59:10.625 INFO running `"docker" "start" "-a" "1a601b90bb5bb4c6517d47b9b6a444341dc48354158f02d3e7aa900c9dfc364e"`
Nov 18 01:59:11.176 INFO [stderr] usermod: no changes
Nov 18 01:59:11.229 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Nov 18 01:59:11.229 INFO [stderr]      Running /target/debug/deps/resol_vbus-9e601fa5d97b479a
Nov 18 01:59:11.229 INFO [stdout] 
Nov 18 01:59:11.229 INFO [stdout] running 52 tests
Nov 18 01:59:11.229 INFO [stdout] test data::tests::test_partial_cmp ... ok
Nov 18 01:59:11.229 INFO [stdout] test data_set::tests::test_add_data ... ok
Nov 18 01:59:11.229 INFO [stdout] test data::tests::test_eq ... ok
Nov 18 01:59:11.229 INFO [stdout] test data::tests::test_as_header ... ok
Nov 18 01:59:11.229 INFO [stdout] test data_set::tests::test_sort ... ok
Nov 18 01:59:11.229 INFO [stdout] test datagram::tests::test_debug_fmt ... ok
Nov 18 01:59:11.229 INFO [stdout] test datagram::tests::test_to_id_string ... ok
Nov 18 01:59:11.229 INFO [stdout] test header::tests::test_debug_fmt ... ok
Nov 18 01:59:11.229 INFO [stdout] test data_set::tests::test_add_data_set ... ok
Nov 18 01:59:11.229 INFO [stdout] test data_set::tests::test_remove_data_older_than ... ok
Nov 18 01:59:11.229 INFO [stdout] test live_data_decoder::tests::test_data_from_checked_bytes ... ok
Nov 18 01:59:11.229 INFO [stdout] test live_data_decoder::tests::test_length_from_bytes ... ok
Nov 18 01:59:11.229 INFO [stdout] test blob_reader::tests::test_read ... ok
Nov 18 01:59:11.229 INFO [stdout] test live_data_encoder::tests::test_bytes_from_data ... ok
Nov 18 01:59:11.229 INFO [stdout] test live_data_encoder::tests::test_length_from_data ... ok
Nov 18 01:59:11.229 INFO [stdout] test header::tests::test_to_id_string ... ok
Nov 18 01:59:11.229 INFO [stdout] test blob_reader::tests::test_new ... ok
Nov 18 01:59:11.230 INFO [stdout] test blob_reader::tests::test_consume ... ok
Nov 18 01:59:11.230 INFO [stdout] test live_data_recording_reader::tests::test_read_data ... ok
Nov 18 01:59:11.231 INFO [stdout] test packet::tests::test_to_id_string ... ok
Nov 18 01:59:11.268 INFO [stdout] test blob_reader::tests::test_as_bytes ... ok
Nov 18 01:59:11.269 INFO [stdout] test live_data_reader::tests::test_read_bytes ... ok
Nov 18 01:59:11.269 INFO [stdout] test recording_decoder::tests::test_length_from_bytes ... ok
Nov 18 01:59:11.269 INFO [stdout] test recording_decoder::tests::test_data_from_checked_bytes ... ok
Nov 18 01:59:11.269 INFO [stdout] test live_data_recording_reader::tests::test_read_topology_data_set ... ok
Nov 18 01:59:11.269 INFO [stdout] test packet::tests::test_debug_fmt ... ok
Nov 18 01:59:11.269 INFO [stdout] test live_data_writer::tests::test_write_data ... ok
Nov 18 01:59:11.269 INFO [stdout] test live_data_reader::tests::test_read_data ... ok
Nov 18 01:59:11.269 INFO [stdout] test recording_decoder::tests::test_data_from_bytes ... ok
Nov 18 01:59:11.269 INFO [stdout] test recording_decoder::tests::test_timestamp_from_checked_bytes ... ok
Nov 18 01:59:11.269 INFO [stdout] test specification::tests::test_get_field_spec ... ok
Nov 18 01:59:11.269 INFO [stdout] test specification::tests::test_from_file ... ok
Nov 18 01:59:11.269 INFO [stdout] test specification::tests::test_get_power_of_10 ... ok
Nov 18 01:59:11.269 INFO [stdout] test specification::tests::test_get_device_spec ... ok
Nov 18 01:59:11.275 INFO [stdout] test specification::tests::test_get_raw_value_f64 ... ok
Nov 18 01:59:11.275 INFO [stdout] test specification::tests::test_fmt_raw_value ... ok
Nov 18 01:59:11.275 INFO [stdout] test recording_reader::tests::test_read_to_next_data_set_record ... ok
Nov 18 01:59:11.277 INFO [stdout] test specification::tests::test_get_packet_spec ... ok
Nov 18 01:59:11.277 INFO [stdout] test specification_file::tests::test_from_bytes ... ok
Nov 18 01:59:11.277 INFO [stdout] test recording_reader::tests::test_read_record ... ok
Nov 18 01:59:11.277 INFO [stdout] test telegram::tests::test_to_id_string ... ok
Nov 18 01:59:11.278 INFO [stdout] test utils::tests::test_calc_and_compare_checksum_v0 ... ok
Nov 18 01:59:11.278 INFO [stdout] test specification::tests::test_get_raw_value_i64 ... ok
Nov 18 01:59:11.279 INFO [stdout] test utils::tests::test_copy_bytes_extracting_septett ... ok
Nov 18 01:59:11.279 INFO [stdout] test recording_reader::tests::test_read_data_set ... ok
Nov 18 01:59:11.279 INFO [stdout] test utils::tests::test_calc_checksum_v0 ... ok
Nov 18 01:59:11.279 INFO [stdout] test utils::tests::test_copy_bytes_injecting_septett ... ok
Nov 18 01:59:11.282 INFO [stdout] test telegram::tests::test_debug_fmt ... ok
Nov 18 01:59:11.282 INFO [stderr]    Doc-tests resol-vbus
Nov 18 01:59:11.282 INFO [stdout] test telegram::tests::test_frame_count ... ok
Nov 18 01:59:11.282 INFO [stdout] test telegram::tests::test_frame_count_from_command ... ok
Nov 18 01:59:11.282 INFO [stdout] test utils::tests::test_calc_and_set_checksum_v0 ... ok
Nov 18 01:59:11.282 INFO [stdout] test test_utils::test_to_hex_string ... ok
Nov 18 01:59:11.282 INFO [stdout] 
Nov 18 01:59:11.282 INFO [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 01:59:11.282 INFO [stdout] 
Nov 18 01:59:12.387 INFO [stdout] 
Nov 18 01:59:12.387 INFO [stdout] running 0 tests
Nov 18 01:59:12.387 INFO [stdout] 
Nov 18 01:59:12.387 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 01:59:12.387 INFO [stdout] 
Nov 18 01:59:12.398 INFO [stderr] su: No module specific data is present
Nov 18 01:59:12.632 INFO running `"docker" "inspect" "1a601b90bb5bb4c6517d47b9b6a444341dc48354158f02d3e7aa900c9dfc364e"`
Nov 18 01:59:12.764 INFO running `"docker" "rm" "-f" "1a601b90bb5bb4c6517d47b9b6a444341dc48354158f02d3e7aa900c9dfc364e"`
Nov 18 01:59:12.849 INFO [stdout] 1a601b90bb5bb4c6517d47b9b6a444341dc48354158f02d3e7aa900c9dfc364e