Dec 15 05:37:28.356 INFO testing lorawan-0.3.0 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 05:37:28.357 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 15 05:37:28.780 INFO [stdout] 778f9d1c2225c04f79506501d4394a116309b5e71dec04f382791f6702fa837a
Dec 15 05:37:28.785 INFO running `"docker" "start" "-a" "778f9d1c2225c04f79506501d4394a116309b5e71dec04f382791f6702fa837a"`
Dec 15 05:37:30.011 INFO [stderr] usermod: no changes
Dec 15 05:37:30.131 INFO [stderr]    Compiling lorawan v0.3.0 (/source)
Dec 15 05:37:31.382 INFO [stderr] warning: unnecessary parentheses around method argument
Dec 15 05:37:31.382 INFO [stderr]    --> src/cmac.rs:108:23
Dec 15 05:37:31.382 INFO [stderr]     |
Dec 15 05:37:31.382 INFO [stderr] 108 |         data.split_at((block_size * n_blocks))
Dec 15 05:37:31.382 INFO [stderr]     |                       ^^^^^^^^^^^^^^^^^^^^^^^ help: remove these parentheses
Dec 15 05:37:31.382 INFO [stderr]     |
Dec 15 05:37:31.382 INFO [stderr]     = note: #[warn(unused_parens)] on by default
Dec 15 05:37:31.382 INFO [stderr] 
Dec 15 05:37:33.448 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.40s
Dec 15 05:37:33.458 INFO [stderr] su: No module specific data is present
Dec 15 05:37:34.555 INFO running `"docker" "inspect" "778f9d1c2225c04f79506501d4394a116309b5e71dec04f382791f6702fa837a"`
Dec 15 05:37:34.885 INFO running `"docker" "rm" "-f" "778f9d1c2225c04f79506501d4394a116309b5e71dec04f382791f6702fa837a"`
Dec 15 05:37:35.135 INFO [stdout] 778f9d1c2225c04f79506501d4394a116309b5e71dec04f382791f6702fa837a
Dec 15 05:37:35.143 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 15 05:37:35.660 INFO [stdout] 2e395f4cdfda22fdfb1f1c5afe18969df7ff4672376b428e8b77be08fcb5e13b
Dec 15 05:37:35.663 INFO running `"docker" "start" "-a" "2e395f4cdfda22fdfb1f1c5afe18969df7ff4672376b428e8b77be08fcb5e13b"`
Dec 15 05:37:37.099 INFO [stderr] usermod: no changes
Dec 15 05:37:37.239 INFO [stderr]    Compiling lorawan v0.3.0 (/source)
Dec 15 05:37:39.056 INFO [stderr] warning: unnecessary parentheses around method argument
Dec 15 05:37:39.056 INFO [stderr]    --> src/cmac.rs:108:23
Dec 15 05:37:39.056 INFO [stderr]     |
Dec 15 05:37:39.056 INFO [stderr] 108 |         data.split_at((block_size * n_blocks))
Dec 15 05:37:39.056 INFO [stderr]     |                       ^^^^^^^^^^^^^^^^^^^^^^^ help: remove these parentheses
Dec 15 05:37:39.056 INFO [stderr]     |
Dec 15 05:37:39.056 INFO [stderr]     = note: #[warn(unused_parens)] on by default
Dec 15 05:37:39.056 INFO [stderr] 
Dec 15 05:37:42.614 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.49s
Dec 15 05:37:42.619 INFO [stderr] su: No module specific data is present
Dec 15 05:37:43.708 INFO running `"docker" "inspect" "2e395f4cdfda22fdfb1f1c5afe18969df7ff4672376b428e8b77be08fcb5e13b"`
Dec 15 05:37:44.043 INFO running `"docker" "rm" "-f" "2e395f4cdfda22fdfb1f1c5afe18969df7ff4672376b428e8b77be08fcb5e13b"`
Dec 15 05:37:44.415 INFO [stdout] 2e395f4cdfda22fdfb1f1c5afe18969df7ff4672376b428e8b77be08fcb5e13b
Dec 15 05:37:44.420 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 15 05:37:44.875 INFO [stdout] bfa1d5c17ccb019a1ac06191f24e253fc5b039548a4bcbf7d7c20d5008066c30
Dec 15 05:37:44.877 INFO running `"docker" "start" "-a" "bfa1d5c17ccb019a1ac06191f24e253fc5b039548a4bcbf7d7c20d5008066c30"`
Dec 15 05:37:46.979 INFO [stderr] usermod: no changes
Dec 15 05:37:47.083 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Dec 15 05:37:47.095 INFO [stderr]      Running /target/debug/deps/lorawan-bac47f15e317f9b9
Dec 15 05:37:47.095 INFO [stderr]      Running /target/debug/deps/cmac-098ddb3e8c0f72c3
Dec 15 05:37:47.095 INFO [stdout] 
Dec 15 05:37:47.095 INFO [stdout] running 0 tests
Dec 15 05:37:47.095 INFO [stdout] 
Dec 15 05:37:47.095 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:37:47.095 INFO [stdout] 
Dec 15 05:37:47.095 INFO [stdout] 
Dec 15 05:37:47.095 INFO [stdout] running 3 tests
Dec 15 05:37:47.103 INFO [stdout] test test_cmac_aes256 ... ok
Dec 15 05:37:47.103 INFO [stdout] test test_cmac_aes192 ... ok
Dec 15 05:37:47.103 INFO [stdout] test test_cmac_aes128 ... ok
Dec 15 05:37:47.103 INFO [stdout] 
Dec 15 05:37:47.103 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:37:47.103 INFO [stdout] 
Dec 15 05:37:47.110 INFO [stderr]      Running /target/debug/deps/lorawan-730e652c6a2473cd
Dec 15 05:37:47.115 INFO [stdout] 
Dec 15 05:37:47.115 INFO [stdout] running 34 tests
Dec 15 05:37:47.115 INFO [stdout] test test_data_payload_creator ... ok
Dec 15 05:37:47.115 INFO [stdout] test test_data_payload_creator_when_encrypt_but_not_fport_0 ... ok
Dec 15 05:37:47.115 INFO [stdout] test test_complete_data_payload_frm_payload ... ok
Dec 15 05:37:47.115 INFO [stdout] test test_complete_data_payload_fhdr ... ok
Dec 15 05:37:47.115 INFO [stdout] test test_data_payload_creator_when_big_mac_commands_but_not_fport_0 ... ok
Dec 15 05:37:47.115 INFO [stdout] test test_data_payload_creator_when_mac_commands_in_payload ... ok
Dec 15 05:37:47.115 INFO [stdout] test test_data_payload_creator_when_payload_no_fport ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_data_payload_creator_when_payload_and_fport_0 ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_complete_data_payload_f_port ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_dl_settings ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_join_accept_app_nonce_extraction ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_f_port_could_be_absent_in_data_payload ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_data_payload_creator_when_fport_0_but_not_encrypt ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_data_payload_creator_when_mac_commands_in_f_opts ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_join_accept_rx_delay_extraction ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_join_request_app_eui_extraction ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_join_request_creator ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_join_accept_dl_settings_extraction ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_join_request_dev_nonce_extraction ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_join_accept_creator ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_mac_payload_has_good_bytes_when_size_correct ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_join_request_dev_eui_extraction ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_mhdr_major ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_mhdr_mtype ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_mic ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_new_data_payload_is_none_if_bytes_too_short ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_new_frequency ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_new_join_accept_payload ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_new_join_accept_payload_mic_validation ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_new_join_accept_payload_with_c_f_list ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_phy_payload_is_none_when_too_few_bytes ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_validate_data_mic_when_ok ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_validate_data_mic_when_type_not_ok ... ok
Dec 15 05:37:47.127 INFO [stdout] test test_validate_join_request_mic_when_ok ... ok
Dec 15 05:37:47.127 INFO [stdout] 
Dec 15 05:37:47.127 INFO [stdout] test result: ok. 34 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:37:47.127 INFO [stdout] 
Dec 15 05:37:47.147 INFO [stdout] 
Dec 15 05:37:47.147 INFO [stdout] running 20 tests
Dec 15 05:37:47.147 INFO [stdout] test test_duty_cycle_ans_creator ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_dev_status_req_creator ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_dev_status_ans_creator_too_small_margin ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_build_mac_commands ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_dev_status_ans_creator_too_big_margin ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_link_adr_req_creator ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_link_adr_req_creator_bad_data_rate ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_link_adr_req_creator_bad_tx_power ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_link_check_ans_creator ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_link_check_req_creator ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_new_channel_ans_creator ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_new_channel_req_creator ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_rx_param_setup_ans_creator ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_rx_param_setup_req_creator ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_rx_timing_setup_ans_creator ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_rx_timing_setup_req_creator ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_rx_timing_setup_req_creator_bad_delay ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_duty_cycle_req_creator ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_link_adr_ans_creator ... ok
Dec 15 05:37:47.147 INFO [stdout] test test_dev_status_ans_creator ... ok
Dec 15 05:37:47.147 INFO [stdout] 
Dec 15 05:37:47.147 INFO [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:37:47.147 INFO [stdout] 
Dec 15 05:37:47.147 INFO [stdout] 
Dec 15 05:37:47.147 INFO [stdout] running 28 tests
Dec 15 05:37:47.147 INFO [stderr]      Running /target/debug/deps/maccommandcreator-397a40acac6d1a3f
Dec 15 05:37:47.147 INFO [stderr]      Running /target/debug/deps/maccommands-bce12a1a67a0ae04
Dec 15 05:37:47.151 INFO [stdout] test test_data_rate_range_max_equals_min ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_data_rate_range_inversed_min_and_max ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_dev_status_req ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_data_rate_range ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_dev_status_ans ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_channel_mask ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_duty_cycle_ans_new ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_frequency_new_bad_payload ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_frequency_value ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_dl_settings ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_duty_cycle_req_new ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_link_adr_req_new ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_link_check_req_new ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_parse_mac_commands_empty_uplink ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_link_adr_ans_new ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_parse_mac_commands_with_multiple_cmds ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_redundancy_channel_mask_control ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_redundancy_number_of_transmissions ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_rx_param_setup_ans_new ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_rx_param_setup_req_new ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_rx_timing_setup_ans ... ok
Dec 15 05:37:47.151 INFO [stdout] test test_rx_timing_setup_req ... ok
Dec 15 05:37:47.159 INFO [stderr]    Doc-tests lorawan
Dec 15 05:37:47.159 INFO [stdout] test test_link_check_ans_new ... ok
Dec 15 05:37:47.159 INFO [stdout] test test_mac_commands_len_with_creators ... ok
Dec 15 05:37:47.159 INFO [stdout] test test_new_channel_ans ... ok
Dec 15 05:37:47.159 INFO [stdout] test test_parse_mac_commands_empty_downlink ... ok
Dec 15 05:37:47.159 INFO [stdout] test test_mac_commands_len_with_mac_cmds ... ok
Dec 15 05:37:47.159 INFO [stdout] test test_new_channel_req ... ok
Dec 15 05:37:47.159 INFO [stdout] 
Dec 15 05:37:47.159 INFO [stdout] test result: ok. 28 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:37:47.159 INFO [stdout] 
Dec 15 05:37:48.865 INFO [stdout] 
Dec 15 05:37:48.865 INFO [stdout] running 22 tests
Dec 15 05:38:00.643 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::DevStatusReqCreator (line 410) ... ok
Dec 15 05:38:01.831 INFO [stdout] test src/creator.rs - creator::DataPayloadCreator::set_mac_commands (line 416) ... ok
Dec 15 05:38:02.727 INFO [stdout] test src/creator.rs - creator::DataPayloadCreator::new (line 293) ... ok
Dec 15 05:38:02.843 INFO [stdout] test src/creator.rs - creator::JoinRequestCreator::new (line 202) ... ok
Dec 15 05:38:03.271 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::DutyCycleAnsCreator (line 291) ... ok
Dec 15 05:38:03.339 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::DutyCycleReqCreator (line 263) ... ok
Dec 15 05:38:04.883 INFO [stdout] test src/creator.rs - creator::JoinAcceptCreator::new (line 32) ... ok
Dec 15 05:38:05.042 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::DevStatusAnsCreator (line 422) ... ok
Dec 15 05:38:09.483 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::NewChannelReqCreator (line 465) ... ok
Dec 15 05:38:11.183 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::LinkADRAnsCreator (line 207) ... ok
Dec 15 05:38:11.382 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::LinkCheckAnsCreator (line 84) ... ok
Dec 15 05:38:13.355 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::RXParamSetupReqCreator (line 303) ... ok
Dec 15 05:38:13.767 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::LinkADRReqCreator (line 123) ... ok
Dec 15 05:38:13.947 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::LinkCheckReqCreator (line 72) ... ok
Dec 15 05:38:14.096 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::NewChannelAnsCreator (line 527) ... ok
Dec 15 05:38:15.247 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::RXParamSetupAnsCreator (line 354) ... ok
Dec 15 05:38:15.603 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::RXTimingSetupAnsCreator (line 601) ... ok
Dec 15 05:38:16.923 INFO [stdout] test src/maccommands.rs - maccommands::parse_mac_commands (line 195) ... ok
Dec 15 05:38:17.050 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::RXTimingSetupReqCreator (line 570) ... ok
Dec 15 05:38:17.659 INFO [stdout] test src/parser.rs - parser::DataPayload<'a>::new (line 316) ... ok
Dec 15 05:38:17.897 INFO [stdout] test src/parser.rs - parser::PhyPayload<'a>::new_decrypted_join_accept (line 79) ... ok
Dec 15 05:38:18.029 INFO [stdout] test src/parser.rs - parser::PhyPayload<'a>::new (line 31) ... ok
Dec 15 05:38:18.029 INFO [stdout] 
Dec 15 05:38:18.029 INFO [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:38:18.029 INFO [stdout] 
Dec 15 05:38:18.050 INFO [stderr] su: No module specific data is present
Dec 15 05:38:18.413 INFO running `"docker" "inspect" "bfa1d5c17ccb019a1ac06191f24e253fc5b039548a4bcbf7d7c20d5008066c30"`
Dec 15 05:38:18.600 INFO running `"docker" "rm" "-f" "bfa1d5c17ccb019a1ac06191f24e253fc5b039548a4bcbf7d7c20d5008066c30"`
Dec 15 05:38:18.746 INFO [stdout] bfa1d5c17ccb019a1ac06191f24e253fc5b039548a4bcbf7d7c20d5008066c30