Nov 18 06:59:24.446 INFO testing lorawan-0.3.0 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 06:59:24.448 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 06:59:24.999 INFO [stdout] db71ebc78dbf1efe1af9ce5732dda126472c1352a939839d9c4d076e5f553e09
Nov 18 06:59:25.007 INFO running `"docker" "start" "-a" "db71ebc78dbf1efe1af9ce5732dda126472c1352a939839d9c4d076e5f553e09"`
Nov 18 06:59:26.046 INFO [stderr] usermod: no changes
Nov 18 06:59:26.180 INFO [stderr]    Compiling lorawan v0.3.0 (/source)
Nov 18 06:59:27.136 INFO [stderr] warning: unnecessary parentheses around method argument
Nov 18 06:59:27.136 INFO [stderr]    --> src/cmac.rs:108:23
Nov 18 06:59:27.136 INFO [stderr]     |
Nov 18 06:59:27.136 INFO [stderr] 108 |         data.split_at((block_size * n_blocks))
Nov 18 06:59:27.137 INFO [stderr]     |                       ^^^^^^^^^^^^^^^^^^^^^^^ help: remove these parentheses
Nov 18 06:59:27.137 INFO [stderr]     |
Nov 18 06:59:27.137 INFO [stderr]     = note: #[warn(unused_parens)] on by default
Nov 18 06:59:27.138 INFO [stderr] 
Nov 18 06:59:29.119 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.04s
Nov 18 06:59:29.119 INFO [stderr] su: No module specific data is present
Nov 18 06:59:30.175 INFO running `"docker" "inspect" "db71ebc78dbf1efe1af9ce5732dda126472c1352a939839d9c4d076e5f553e09"`
Nov 18 06:59:30.479 INFO running `"docker" "rm" "-f" "db71ebc78dbf1efe1af9ce5732dda126472c1352a939839d9c4d076e5f553e09"`
Nov 18 06:59:30.775 INFO [stdout] db71ebc78dbf1efe1af9ce5732dda126472c1352a939839d9c4d076e5f553e09
Nov 18 06:59:30.782 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 06:59:31.276 INFO [stdout] 57bc0a44f4cfb71d62fb141d2f006c2a9af19f985f319d8946f09d96ac4d7db5
Nov 18 06:59:31.278 INFO running `"docker" "start" "-a" "57bc0a44f4cfb71d62fb141d2f006c2a9af19f985f319d8946f09d96ac4d7db5"`
Nov 18 06:59:32.359 INFO [stderr] usermod: no changes
Nov 18 06:59:32.473 INFO [stderr]    Compiling lorawan v0.3.0 (/source)
Nov 18 06:59:33.911 INFO [stderr] warning: unnecessary parentheses around method argument
Nov 18 06:59:33.911 INFO [stderr]    --> src/cmac.rs:108:23
Nov 18 06:59:33.911 INFO [stderr]     |
Nov 18 06:59:33.911 INFO [stderr] 108 |         data.split_at((block_size * n_blocks))
Nov 18 06:59:33.911 INFO [stderr]     |                       ^^^^^^^^^^^^^^^^^^^^^^^ help: remove these parentheses
Nov 18 06:59:33.911 INFO [stderr]     |
Nov 18 06:59:33.911 INFO [stderr]     = note: #[warn(unused_parens)] on by default
Nov 18 06:59:33.911 INFO [stderr] 
Nov 18 06:59:38.863 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.47s
Nov 18 06:59:38.869 INFO [stderr] su: No module specific data is present
Nov 18 06:59:40.287 INFO running `"docker" "inspect" "57bc0a44f4cfb71d62fb141d2f006c2a9af19f985f319d8946f09d96ac4d7db5"`
Nov 18 06:59:40.562 INFO running `"docker" "rm" "-f" "57bc0a44f4cfb71d62fb141d2f006c2a9af19f985f319d8946f09d96ac4d7db5"`
Nov 18 06:59:40.857 INFO [stdout] 57bc0a44f4cfb71d62fb141d2f006c2a9af19f985f319d8946f09d96ac4d7db5
Nov 18 06:59:40.868 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 06:59:41.219 INFO [stdout] 4babade21b70da93cf7cc9478ebce22e397e2bb83ea6db1a15073bf2bcc8c45c
Nov 18 06:59:41.222 INFO running `"docker" "start" "-a" "4babade21b70da93cf7cc9478ebce22e397e2bb83ea6db1a15073bf2bcc8c45c"`
Nov 18 06:59:42.516 INFO [stderr] usermod: no changes
Nov 18 06:59:42.655 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.11s
Nov 18 06:59:42.655 INFO [stderr]      Running /target/debug/deps/lorawan-6e6cbe7a9b7319d9
Nov 18 06:59:42.659 INFO [stderr]      Running /target/debug/deps/cmac-2a6ad9c27522ee96
Nov 18 06:59:42.660 INFO [stdout] 
Nov 18 06:59:42.660 INFO [stdout] running 0 tests
Nov 18 06:59:42.660 INFO [stdout] 
Nov 18 06:59:42.660 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 06:59:42.661 INFO [stdout] 
Nov 18 06:59:42.669 INFO [stdout] 
Nov 18 06:59:42.669 INFO [stdout] running 3 tests
Nov 18 06:59:42.669 INFO [stdout] test test_cmac_aes128 ... ok
Nov 18 06:59:42.669 INFO [stdout] test test_cmac_aes192 ... ok
Nov 18 06:59:42.670 INFO [stdout] test test_cmac_aes256 ... ok
Nov 18 06:59:42.670 INFO [stdout] 
Nov 18 06:59:42.670 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 06:59:42.671 INFO [stdout] 
Nov 18 06:59:42.679 INFO [stdout] 
Nov 18 06:59:42.679 INFO [stderr]      Running /target/debug/deps/lorawan-a831ce4cc084151f
Nov 18 06:59:42.679 INFO [stdout] running 34 tests
Nov 18 06:59:42.719 INFO [stdout] test test_data_payload_creator ... ok
Nov 18 06:59:42.719 INFO [stdout] test test_complete_data_payload_f_port ... ok
Nov 18 06:59:42.719 INFO [stdout] test test_complete_data_payload_fhdr ... ok
Nov 18 06:59:42.719 INFO [stdout] test test_data_payload_creator_when_big_mac_commands_but_not_fport_0 ... ok
Nov 18 06:59:42.719 INFO [stdout] test test_complete_data_payload_frm_payload ... ok
Nov 18 06:59:42.719 INFO [stdout] test test_data_payload_creator_when_fport_0_but_not_encrypt ... ok
Nov 18 06:59:42.719 INFO [stdout] test test_data_payload_creator_when_encrypt_but_not_fport_0 ... ok
Nov 18 06:59:42.723 INFO [stdout] test test_dl_settings ... ok
Nov 18 06:59:42.723 INFO [stdout] test test_data_payload_creator_when_payload_no_fport ... ok
Nov 18 06:59:42.723 INFO [stdout] test test_f_port_could_be_absent_in_data_payload ... ok
Nov 18 06:59:42.723 INFO [stdout] test test_data_payload_creator_when_mac_commands_in_payload ... ok
Nov 18 06:59:42.723 INFO [stdout] test test_data_payload_creator_when_payload_and_fport_0 ... ok
Nov 18 06:59:42.723 INFO [stdout] test test_join_accept_app_nonce_extraction ... ok
Nov 18 06:59:42.723 INFO [stdout] test test_data_payload_creator_when_mac_commands_in_f_opts ... ok
Nov 18 06:59:42.725 INFO [stdout] test test_join_request_dev_eui_extraction ... ok
Nov 18 06:59:42.725 INFO [stdout] test test_join_request_dev_nonce_extraction ... ok
Nov 18 06:59:42.725 INFO [stdout] test test_join_request_creator ... ok
Nov 18 06:59:42.725 INFO [stdout] test test_mac_payload_has_good_bytes_when_size_correct ... ok
Nov 18 06:59:42.725 INFO [stdout] test test_join_request_app_eui_extraction ... ok
Nov 18 06:59:42.725 INFO [stdout] test test_join_accept_rx_delay_extraction ... ok
Nov 18 06:59:42.725 INFO [stdout] test test_new_data_payload_is_none_if_bytes_too_short ... ok
Nov 18 06:59:42.725 INFO [stdout] test test_new_frequency ... ok
Nov 18 06:59:42.725 INFO [stdout] test test_new_join_accept_payload ... ok
Nov 18 06:59:42.725 INFO [stdout] test test_new_join_accept_payload_mic_validation ... ok
Nov 18 06:59:42.725 INFO [stdout] test test_new_join_accept_payload_with_c_f_list ... ok
Nov 18 06:59:42.725 INFO [stdout] test test_phy_payload_is_none_when_too_few_bytes ... ok
Nov 18 06:59:42.725 INFO [stdout] test test_validate_data_mic_when_type_not_ok ... ok
Nov 18 06:59:42.725 INFO [stdout] test test_validate_data_mic_when_ok ... ok
Nov 18 06:59:42.726 INFO [stdout] test test_validate_join_request_mic_when_ok ... ok
Nov 18 06:59:42.731 INFO [stdout] test test_mhdr_mtype ... ok
Nov 18 06:59:42.731 INFO [stdout] test test_mic ... ok
Nov 18 06:59:42.731 INFO [stdout] test test_join_accept_dl_settings_extraction ... ok
Nov 18 06:59:42.731 INFO [stdout] test test_join_accept_creator ... ok
Nov 18 06:59:42.731 INFO [stdout] test test_mhdr_major ... ok
Nov 18 06:59:42.731 INFO [stdout] 
Nov 18 06:59:42.731 INFO [stdout] test result: ok. 34 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 06:59:42.731 INFO [stdout] 
Nov 18 06:59:42.735 INFO [stderr]      Running /target/debug/deps/maccommandcreator-42838619e7c8af39
Nov 18 06:59:42.739 INFO [stdout] 
Nov 18 06:59:42.739 INFO [stdout] running 20 tests
Nov 18 06:59:42.763 INFO [stdout] test test_dev_status_req_creator ... ok
Nov 18 06:59:42.763 INFO [stdout] test test_dev_status_ans_creator_too_small_margin ... ok
Nov 18 06:59:42.763 INFO [stdout] test test_duty_cycle_req_creator ... ok
Nov 18 06:59:42.763 INFO [stdout] test test_build_mac_commands ... ok
Nov 18 06:59:42.763 INFO [stdout] test test_duty_cycle_ans_creator ... ok
Nov 18 06:59:42.763 INFO [stdout] test test_dev_status_ans_creator ... ok
Nov 18 06:59:42.763 INFO [stdout] test test_dev_status_ans_creator_too_big_margin ... ok
Nov 18 06:59:42.771 INFO [stdout] test test_link_adr_req_creator ... ok
Nov 18 06:59:42.771 INFO [stdout] test test_link_adr_ans_creator ... ok
Nov 18 06:59:42.771 INFO [stdout] test test_link_adr_req_creator_bad_tx_power ... ok
Nov 18 06:59:42.771 INFO [stdout] test test_new_channel_ans_creator ... ok
Nov 18 06:59:42.771 INFO [stdout] test test_link_adr_req_creator_bad_data_rate ... ok
Nov 18 06:59:42.771 INFO [stdout] test test_new_channel_req_creator ... ok
Nov 18 06:59:42.771 INFO [stdout] test test_link_check_ans_creator ... ok
Nov 18 06:59:42.771 INFO [stdout] test test_link_check_req_creator ... ok
Nov 18 06:59:42.771 INFO [stdout] test test_rx_param_setup_req_creator ... ok
Nov 18 06:59:42.771 INFO [stdout] test test_rx_param_setup_ans_creator ... ok
Nov 18 06:59:42.779 INFO [stdout] test test_rx_timing_setup_ans_creator ... ok
Nov 18 06:59:42.779 INFO [stderr]      Running /target/debug/deps/maccommands-bd8adc9337a22c48
Nov 18 06:59:42.779 INFO [stdout] test test_rx_timing_setup_req_creator_bad_delay ... ok
Nov 18 06:59:42.779 INFO [stdout] test test_rx_timing_setup_req_creator ... ok
Nov 18 06:59:42.779 INFO [stdout] 
Nov 18 06:59:42.779 INFO [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 06:59:42.779 INFO [stdout] 
Nov 18 06:59:42.779 INFO [stdout] 
Nov 18 06:59:42.779 INFO [stdout] running 28 tests
Nov 18 06:59:42.823 INFO [stdout] test test_dl_settings ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_data_rate_range_inversed_min_and_max ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_duty_cycle_ans_new ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_data_rate_range_max_equals_min ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_dev_status_req ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_channel_mask ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_dev_status_ans ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_data_rate_range ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_frequency_new_bad_payload ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_frequency_value ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_duty_cycle_req_new ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_link_check_req_new ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_link_adr_req_new ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_link_check_ans_new ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_link_adr_ans_new ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_mac_commands_len_with_creators ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_mac_commands_len_with_mac_cmds ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_new_channel_ans ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_new_channel_req ... ok
Nov 18 06:59:42.823 INFO [stdout] test test_redundancy_channel_mask_control ... ok
Nov 18 06:59:42.827 INFO [stdout] test test_parse_mac_commands_empty_uplink ... ok
Nov 18 06:59:42.827 INFO [stdout] test test_redundancy_number_of_transmissions ... ok
Nov 18 06:59:42.827 INFO [stdout] test test_rx_param_setup_ans_new ... ok
Nov 18 06:59:42.827 INFO [stdout] test test_parse_mac_commands_with_multiple_cmds ... ok
Nov 18 06:59:42.835 INFO [stdout] test test_parse_mac_commands_empty_downlink ... ok
Nov 18 06:59:42.835 INFO [stdout] test test_rx_param_setup_req_new ... ok
Nov 18 06:59:42.847 INFO [stdout] test test_rx_timing_setup_req ... ok
Nov 18 06:59:42.847 INFO [stdout] test test_rx_timing_setup_ans ... ok
Nov 18 06:59:42.847 INFO [stdout] 
Nov 18 06:59:42.847 INFO [stdout] test result: ok. 28 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 06:59:42.847 INFO [stdout] 
Nov 18 06:59:42.857 INFO [stderr]    Doc-tests lorawan
Nov 18 06:59:44.383 INFO [stdout] 
Nov 18 06:59:44.383 INFO [stdout] running 22 tests
Nov 18 06:59:55.107 INFO [stdout] test src/creator.rs - creator::JoinAcceptCreator::new (line 32) ... ok
Nov 18 06:59:55.127 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::DevStatusAnsCreator (line 422) ... ok
Nov 18 06:59:55.417 INFO [stdout] test src/creator.rs - creator::DataPayloadCreator::set_mac_commands (line 416) ... ok
Nov 18 06:59:55.427 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::DutyCycleReqCreator (line 263) ... ok
Nov 18 06:59:55.967 INFO [stdout] test src/creator.rs - creator::DataPayloadCreator::new (line 293) ... ok
Nov 18 06:59:56.987 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::DutyCycleAnsCreator (line 291) ... ok
Nov 18 06:59:57.082 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::DevStatusReqCreator (line 410) ... ok
Nov 18 06:59:57.891 INFO [stdout] test src/creator.rs - creator::JoinRequestCreator::new (line 202) ... ok
Nov 18 07:00:03.950 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::LinkADRReqCreator (line 123) ... ok
Nov 18 07:00:04.667 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::LinkADRAnsCreator (line 207) ... ok
Nov 18 07:00:05.327 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::LinkCheckAnsCreator (line 84) ... ok
Nov 18 07:00:06.375 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::LinkCheckReqCreator (line 72) ... ok
Nov 18 07:00:07.015 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::NewChannelAnsCreator (line 527) ... ok
Nov 18 07:00:07.167 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::RXParamSetupAnsCreator (line 354) ... ok
Nov 18 07:00:07.619 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::NewChannelReqCreator (line 465) ... ok
Nov 18 07:00:08.189 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::RXParamSetupReqCreator (line 303) ... ok
Nov 18 07:00:09.833 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::RXTimingSetupReqCreator (line 570) ... ok
Nov 18 07:00:10.603 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::RXTimingSetupAnsCreator (line 601) ... ok
Nov 18 07:00:10.949 INFO [stdout] test src/maccommands.rs - maccommands::parse_mac_commands (line 195) ... ok
Nov 18 07:00:11.015 INFO [stdout] test src/parser.rs - parser::DataPayload<'a>::new (line 316) ... ok
Nov 18 07:00:11.284 INFO [stdout] test src/parser.rs - parser::PhyPayload<'a>::new (line 31) ... ok
Nov 18 07:00:11.346 INFO [stdout] test src/parser.rs - parser::PhyPayload<'a>::new_decrypted_join_accept (line 79) ... ok
Nov 18 07:00:11.346 INFO [stdout] 
Nov 18 07:00:11.346 INFO [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 07:00:11.346 INFO [stdout] 
Nov 18 07:00:11.368 INFO [stderr] su: No module specific data is present
Nov 18 07:00:11.687 INFO running `"docker" "inspect" "4babade21b70da93cf7cc9478ebce22e397e2bb83ea6db1a15073bf2bcc8c45c"`
Nov 18 07:00:11.817 INFO running `"docker" "rm" "-f" "4babade21b70da93cf7cc9478ebce22e397e2bb83ea6db1a15073bf2bcc8c45c"`
Nov 18 07:00:11.935 INFO [stdout] 4babade21b70da93cf7cc9478ebce22e397e2bb83ea6db1a15073bf2bcc8c45c