Dec 15 05:37:24.833 INFO testing lorawan-0.3.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 05:37:24.833 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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:25.184 INFO [stdout] 336aeef3ecc31c5fbc87abaa71af4d8d1786c84b297e45f11158af18f13a4941
Dec 15 05:37:25.189 INFO running `"docker" "start" "-a" "336aeef3ecc31c5fbc87abaa71af4d8d1786c84b297e45f11158af18f13a4941"`
Dec 15 05:37:26.275 INFO [stderr] usermod: no changes
Dec 15 05:37:26.391 INFO [stderr]    Compiling lorawan v0.3.0 (/source)
Dec 15 05:37:27.431 INFO [stderr] warning: unnecessary parentheses around method argument
Dec 15 05:37:27.431 INFO [stderr]    --> src/cmac.rs:108:23
Dec 15 05:37:27.431 INFO [stderr]     |
Dec 15 05:37:27.431 INFO [stderr] 108 |         data.split_at((block_size * n_blocks))
Dec 15 05:37:27.431 INFO [stderr]     |                       ^^^^^^^^^^^^^^^^^^^^^^^ help: remove these parentheses
Dec 15 05:37:27.431 INFO [stderr]     |
Dec 15 05:37:27.431 INFO [stderr]     = note: #[warn(unused_parens)] on by default
Dec 15 05:37:27.431 INFO [stderr] 
Dec 15 05:37:29.123 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.82s
Dec 15 05:37:29.127 INFO [stderr] su: No module specific data is present
Dec 15 05:37:29.747 INFO running `"docker" "inspect" "336aeef3ecc31c5fbc87abaa71af4d8d1786c84b297e45f11158af18f13a4941"`
Dec 15 05:37:29.947 INFO running `"docker" "rm" "-f" "336aeef3ecc31c5fbc87abaa71af4d8d1786c84b297e45f11158af18f13a4941"`
Dec 15 05:37:30.179 INFO [stdout] 336aeef3ecc31c5fbc87abaa71af4d8d1786c84b297e45f11158af18f13a4941
Dec 15 05:37:30.181 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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:30.576 INFO [stdout] b9d71cf71daab82c1c010ca9d20cd3c182a910eb0a4b215d85674cf9e1be19b5
Dec 15 05:37:30.579 INFO running `"docker" "start" "-a" "b9d71cf71daab82c1c010ca9d20cd3c182a910eb0a4b215d85674cf9e1be19b5"`
Dec 15 05:37:32.024 INFO [stderr] usermod: no changes
Dec 15 05:37:32.100 INFO [stderr]    Compiling lorawan v0.3.0 (/source)
Dec 15 05:37:35.383 INFO [stderr] warning: unnecessary parentheses around method argument
Dec 15 05:37:35.383 INFO [stderr]    --> src/cmac.rs:108:23
Dec 15 05:37:35.383 INFO [stderr]     |
Dec 15 05:37:35.383 INFO [stderr] 108 |         data.split_at((block_size * n_blocks))
Dec 15 05:37:35.383 INFO [stderr]     |                       ^^^^^^^^^^^^^^^^^^^^^^^ help: remove these parentheses
Dec 15 05:37:35.383 INFO [stderr]     |
Dec 15 05:37:35.383 INFO [stderr]     = note: #[warn(unused_parens)] on by default
Dec 15 05:37:35.383 INFO [stderr] 
Dec 15 05:37:38.435 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.39s
Dec 15 05:37:38.435 INFO [stderr] su: No module specific data is present
Dec 15 05:37:39.580 INFO running `"docker" "inspect" "b9d71cf71daab82c1c010ca9d20cd3c182a910eb0a4b215d85674cf9e1be19b5"`
Dec 15 05:37:39.829 INFO running `"docker" "rm" "-f" "b9d71cf71daab82c1c010ca9d20cd3c182a910eb0a4b215d85674cf9e1be19b5"`
Dec 15 05:37:40.103 INFO [stdout] b9d71cf71daab82c1c010ca9d20cd3c182a910eb0a4b215d85674cf9e1be19b5
Dec 15 05:37:40.107 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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:40.519 INFO [stdout] bbdbd9d1f36eaf2d5d13bb021c738a85b74c8d746573c4fa6faca38b41795ed1
Dec 15 05:37:40.521 INFO running `"docker" "start" "-a" "bbdbd9d1f36eaf2d5d13bb021c738a85b74c8d746573c4fa6faca38b41795ed1"`
Dec 15 05:37:41.354 INFO [stderr] usermod: no changes
Dec 15 05:37:41.427 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 15 05:37:41.440 INFO [stderr]      Running /target/debug/deps/lorawan-4bb753619f3f32b3
Dec 15 05:37:41.441 INFO [stderr]      Running /target/debug/deps/cmac-4f6215ef04343687
Dec 15 05:37:41.441 INFO [stdout] 
Dec 15 05:37:41.441 INFO [stdout] running 0 tests
Dec 15 05:37:41.441 INFO [stdout] 
Dec 15 05:37:41.441 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:37:41.441 INFO [stdout] 
Dec 15 05:37:41.447 INFO [stdout] 
Dec 15 05:37:41.447 INFO [stdout] running 3 tests
Dec 15 05:37:41.448 INFO [stdout] test test_cmac_aes256 ... ok
Dec 15 05:37:41.449 INFO [stdout] test test_cmac_aes192 ... ok
Dec 15 05:37:41.450 INFO [stdout] test test_cmac_aes128 ... ok
Dec 15 05:37:41.450 INFO [stdout] 
Dec 15 05:37:41.450 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:37:41.450 INFO [stdout] 
Dec 15 05:37:41.451 INFO [stderr]      Running /target/debug/deps/lorawan-e1c54ae4084c58ae
Dec 15 05:37:41.461 INFO [stdout] 
Dec 15 05:37:41.461 INFO [stdout] running 34 tests
Dec 15 05:37:41.462 INFO [stdout] test test_complete_data_payload_f_port ... ok
Dec 15 05:37:41.462 INFO [stdout] test test_complete_data_payload_fhdr ... ok
Dec 15 05:37:41.462 INFO [stdout] test test_complete_data_payload_frm_payload ... ok
Dec 15 05:37:41.462 INFO [stdout] test test_data_payload_creator ... ok
Dec 15 05:37:41.462 INFO [stdout] test test_data_payload_creator_when_payload_and_fport_0 ... ok
Dec 15 05:37:41.463 INFO [stdout] test test_data_payload_creator_when_payload_no_fport ... ok
Dec 15 05:37:41.463 INFO [stdout] test test_data_payload_creator_when_mac_commands_in_f_opts ... ok
Dec 15 05:37:41.464 INFO [stdout] test test_data_payload_creator_when_mac_commands_in_payload ... ok
Dec 15 05:37:41.464 INFO [stdout] test test_dl_settings ... ok
Dec 15 05:37:41.464 INFO [stdout] test test_data_payload_creator_when_fport_0_but_not_encrypt ... ok
Dec 15 05:37:41.464 INFO [stdout] test test_join_accept_app_nonce_extraction ... ok
Dec 15 05:37:41.464 INFO [stdout] test test_data_payload_creator_when_encrypt_but_not_fport_0 ... ok
Dec 15 05:37:41.464 INFO [stdout] test test_join_accept_creator ... ok
Dec 15 05:37:41.464 INFO [stdout] test test_data_payload_creator_when_big_mac_commands_but_not_fport_0 ... ok
Dec 15 05:37:41.464 INFO [stdout] test test_join_request_creator ... ok
Dec 15 05:37:41.464 INFO [stdout] test test_f_port_could_be_absent_in_data_payload ... ok
Dec 15 05:37:41.465 INFO [stdout] test test_join_request_dev_eui_extraction ... ok
Dec 15 05:37:41.465 INFO [stdout] test test_join_request_dev_nonce_extraction ... ok
Dec 15 05:37:41.465 INFO [stdout] test test_mac_payload_has_good_bytes_when_size_correct ... ok
Dec 15 05:37:41.465 INFO [stdout] test test_mic ... ok
Dec 15 05:37:41.465 INFO [stdout] test test_new_data_payload_is_none_if_bytes_too_short ... ok
Dec 15 05:37:41.465 INFO [stdout] test test_new_frequency ... ok
Dec 15 05:37:41.465 INFO [stdout] test test_join_accept_dl_settings_extraction ... ok
Dec 15 05:37:41.465 INFO [stdout] test test_join_accept_rx_delay_extraction ... ok
Dec 15 05:37:41.465 INFO [stdout] test test_new_join_accept_payload_with_c_f_list ... ok
Dec 15 05:37:41.465 INFO [stdout] test test_join_request_app_eui_extraction ... ok
Dec 15 05:37:41.465 INFO [stdout] test test_mhdr_mtype ... ok
Dec 15 05:37:41.465 INFO [stdout] test test_mhdr_major ... ok
Dec 15 05:37:41.466 INFO [stdout] test test_new_join_accept_payload_mic_validation ... ok
Dec 15 05:37:41.466 INFO [stdout] test test_new_join_accept_payload ... ok
Dec 15 05:37:41.466 INFO [stdout] test test_validate_data_mic_when_ok ... ok
Dec 15 05:37:41.471 INFO [stdout] test test_validate_data_mic_when_type_not_ok ... ok
Dec 15 05:37:41.471 INFO [stdout] test test_validate_join_request_mic_when_ok ... ok
Dec 15 05:37:41.471 INFO [stdout] test test_phy_payload_is_none_when_too_few_bytes ... ok
Dec 15 05:37:41.471 INFO [stdout] 
Dec 15 05:37:41.471 INFO [stdout] test result: ok. 34 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:37:41.471 INFO [stdout] 
Dec 15 05:37:41.471 INFO [stderr]      Running /target/debug/deps/maccommandcreator-a7452bd0a614612b
Dec 15 05:37:41.473 INFO [stdout] 
Dec 15 05:37:41.473 INFO [stdout] running 20 tests
Dec 15 05:37:41.473 INFO [stdout] test test_link_adr_ans_creator ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_duty_cycle_req_creator ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_duty_cycle_ans_creator ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_dev_status_req_creator ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_dev_status_ans_creator ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_link_adr_req_creator_bad_data_rate ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_link_adr_req_creator_bad_tx_power ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_link_check_ans_creator ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_link_check_req_creator ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_new_channel_ans_creator ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_new_channel_req_creator ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_build_mac_commands ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_rx_param_setup_ans_creator ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_rx_param_setup_req_creator ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_rx_timing_setup_ans_creator ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_rx_timing_setup_req_creator ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_rx_timing_setup_req_creator_bad_delay ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_link_adr_req_creator ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_dev_status_ans_creator_too_small_margin ... ok
Dec 15 05:37:41.474 INFO [stdout] test test_dev_status_ans_creator_too_big_margin ... ok
Dec 15 05:37:41.474 INFO [stdout] 
Dec 15 05:37:41.474 INFO [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:37:41.474 INFO [stdout] 
Dec 15 05:37:41.475 INFO [stderr]      Running /target/debug/deps/maccommands-ec9457d6a73b3018
Dec 15 05:37:41.476 INFO [stdout] 
Dec 15 05:37:41.477 INFO [stdout] running 28 tests
Dec 15 05:37:41.478 INFO [stdout] test test_channel_mask ... ok
Dec 15 05:37:41.478 INFO [stdout] test test_dev_status_ans ... ok
Dec 15 05:37:41.478 INFO [stdout] test test_data_rate_range_max_equals_min ... ok
Dec 15 05:37:41.478 INFO [stdout] test test_data_rate_range_inversed_min_and_max ... ok
Dec 15 05:37:41.478 INFO [stdout] test test_data_rate_range ... ok
Dec 15 05:37:41.478 INFO [stdout] test test_dl_settings ... ok
Dec 15 05:37:41.478 INFO [stdout] test test_duty_cycle_ans_new ... ok
Dec 15 05:37:41.478 INFO [stdout] test test_dev_status_req ... ok
Dec 15 05:37:41.478 INFO [stdout] test test_link_adr_ans_new ... ok
Dec 15 05:37:41.478 INFO [stdout] test test_link_adr_req_new ... ok
Dec 15 05:37:41.478 INFO [stdout] test test_frequency_value ... ok
Dec 15 05:37:41.478 INFO [stdout] test test_frequency_new_bad_payload ... ok
Dec 15 05:37:41.479 INFO [stdout] test test_link_check_ans_new ... ok
Dec 15 05:37:41.479 INFO [stdout] test test_link_check_req_new ... ok
Dec 15 05:37:41.479 INFO [stdout] test test_mac_commands_len_with_creators ... ok
Dec 15 05:37:41.479 INFO [stdout] test test_mac_commands_len_with_mac_cmds ... ok
Dec 15 05:37:41.479 INFO [stdout] test test_new_channel_ans ... ok
Dec 15 05:37:41.481 INFO [stdout] test test_redundancy_channel_mask_control ... ok
Dec 15 05:37:41.481 INFO [stdout] test test_parse_mac_commands_empty_uplink ... ok
Dec 15 05:37:41.481 INFO [stdout] test test_redundancy_number_of_transmissions ... ok
Dec 15 05:37:41.481 INFO [stdout] test test_parse_mac_commands_with_multiple_cmds ... ok
Dec 15 05:37:41.481 INFO [stdout] test test_parse_mac_commands_empty_downlink ... ok
Dec 15 05:37:41.481 INFO [stdout] test test_duty_cycle_req_new ... ok
Dec 15 05:37:41.481 INFO [stdout] test test_new_channel_req ... ok
Dec 15 05:37:41.481 INFO [stdout] test test_rx_param_setup_req_new ... ok
Dec 15 05:37:41.481 INFO [stdout] test test_rx_timing_setup_ans ... ok
Dec 15 05:37:41.482 INFO [stdout] test test_rx_timing_setup_req ... ok
Dec 15 05:37:41.482 INFO [stdout] test test_rx_param_setup_ans_new ... ok
Dec 15 05:37:41.482 INFO [stdout] 
Dec 15 05:37:41.482 INFO [stdout] test result: ok. 28 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:37:41.482 INFO [stdout] 
Dec 15 05:37:41.482 INFO [stderr]    Doc-tests lorawan
Dec 15 05:37:43.015 INFO [stdout] 
Dec 15 05:37:43.015 INFO [stdout] running 22 tests
Dec 15 05:37:51.347 INFO [stdout] test src/creator.rs - creator::JoinAcceptCreator::new (line 32) ... ok
Dec 15 05:37:52.655 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::DutyCycleAnsCreator (line 291) ... ok
Dec 15 05:37:56.935 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::DutyCycleReqCreator (line 263) ... ok
Dec 15 05:37:57.238 INFO [stdout] test src/creator.rs - creator::DataPayloadCreator::new (line 293) ... ok
Dec 15 05:37:57.457 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::DevStatusAnsCreator (line 422) ... ok
Dec 15 05:37:57.525 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::DevStatusReqCreator (line 410) ... ok
Dec 15 05:37:57.741 INFO [stdout] test src/creator.rs - creator::JoinRequestCreator::new (line 202) ... ok
Dec 15 05:37:58.215 INFO [stdout] test src/creator.rs - creator::DataPayloadCreator::set_mac_commands (line 416) ... ok
Dec 15 05:38:04.623 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::LinkADRAnsCreator (line 207) ... ok
Dec 15 05:38:05.956 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::LinkADRReqCreator (line 123) ... ok
Dec 15 05:38:07.095 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::LinkCheckReqCreator (line 72) ... ok
Dec 15 05:38:07.575 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::RXParamSetupAnsCreator (line 354) ... ok
Dec 15 05:38:08.183 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::LinkCheckAnsCreator (line 84) ... ok
Dec 15 05:38:09.079 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::NewChannelReqCreator (line 465) ... ok
Dec 15 05:38:10.197 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::NewChannelAnsCreator (line 527) ... ok
Dec 15 05:38:10.979 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::RXParamSetupReqCreator (line 303) ... ok
Dec 15 05:38:13.208 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::RXTimingSetupAnsCreator (line 601) ... ok
Dec 15 05:38:13.898 INFO [stdout] test src/parser.rs - parser::PhyPayload<'a>::new_decrypted_join_accept (line 79) ... ok
Dec 15 05:38:14.498 INFO [stdout] test src/parser.rs - parser::DataPayload<'a>::new (line 316) ... ok
Dec 15 05:38:14.879 INFO [stdout] test src/parser.rs - parser::PhyPayload<'a>::new (line 31) ... ok
Dec 15 05:38:14.927 INFO [stdout] test src/maccommandcreator.rs - maccommandcreator::RXTimingSetupReqCreator (line 570) ... ok
Dec 15 05:38:15.015 INFO [stdout] test src/maccommands.rs - maccommands::parse_mac_commands (line 195) ... ok
Dec 15 05:38:15.015 INFO [stdout] 
Dec 15 05:38:15.015 INFO [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:38:15.015 INFO [stdout] 
Dec 15 05:38:15.036 INFO [stderr] su: No module specific data is present
Dec 15 05:38:15.799 INFO running `"docker" "inspect" "bbdbd9d1f36eaf2d5d13bb021c738a85b74c8d746573c4fa6faca38b41795ed1"`
Dec 15 05:38:16.053 INFO running `"docker" "rm" "-f" "bbdbd9d1f36eaf2d5d13bb021c738a85b74c8d746573c4fa6faca38b41795ed1"`
Dec 15 05:38:16.348 INFO [stdout] bbdbd9d1f36eaf2d5d13bb021c738a85b74c8d746573c4fa6faca38b41795ed1