────────────────────────────────────────────────────────────────────────────────
(HOST) INFO  device halted without error

Output from: cargo test -p pka-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling pka-testsuite v0.1.0 (/tmp/tmp6jx3szg1/pka-testsuite)
    Finished test [optimized + debuginfo] target(s) in 0.46s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-0ed53d16ac96f8de)
(HOST) INFO  flashing program (17.20 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000008 INFO  (1/10) running `ecdsa_sign`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
0.108633 INFO  (2/10) running `ecdsa_sign_nb`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
0.217258 INFO  (3/10) running `ecdsa_sign_ram_error`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
0.436387 INFO  (4/10) running `ecdsa_sign_mode_error`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
0.655516 INFO  (5/10) running `ecdsa_verify`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
0.874645 INFO  (6/10) running `ecdsa_verify_nb`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
1.093774 INFO  (7/10) running `ecdsa_verify_ram_err`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
1.202398 INFO  (8/10) running `ecdsa_verify_mode_err`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
1.311020 INFO  (9/10) running `ecdsa_verify_invalid_err`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
1.527158 INFO  (10/10) running `ecdsa_doc_keypair`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
1.845844 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

Output from: cargo test -p spi-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling either v1.6.1
   Compiling itertools v0.10.1
   Compiling spi-testsuite v0.1.0 (/tmp/tmp6jx3szg1/spi-testsuite)
    Finished test [optimized + debuginfo] target(s) in 1.58s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-1c11d8c7d4a850fc)
(HOST) INFO  flashing program (21.25 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000011 WARN  SPI tests require (SCK, MISO, MOSI) pins SPI1 (A5, A6, A7) connected to SPI2 (A9, C2, C3)
└─ test::tests::init @ tests/test.rs:90
0.000024 INFO  (1/6) running `full_duplex_loopback`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:75
0.000049 DEBUG ÷256 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.002288 DEBUG ÷256 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.004696 DEBUG ÷256 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.006954 DEBUG ÷256 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.009363 DEBUG ÷128 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.010655 DEBUG ÷128 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.012038 DEBUG ÷128 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.013330 DEBUG ÷128 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.014713 DEBUG ÷64 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.015527 DEBUG ÷64 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.016382 DEBUG ÷64 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.017196 DEBUG ÷64 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.018051 DEBUG ÷32 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.018638 DEBUG ÷32 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.019226 DEBUG ÷32 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.019813 DEBUG ÷32 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.020402 DEBUG ÷16 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.020876 DEBUG ÷16 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.021351 DEBUG ÷16 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.021825 DEBUG ÷16 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.022301 DEBUG ÷8 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.022720 DEBUG ÷8 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.023140 DEBUG ÷8 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.023559 DEBUG ÷8 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.023979 DEBUG ÷4 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.024349 DEBUG ÷4 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.024720 DEBUG ÷4 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.025090 DEBUG ÷4 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.025459 INFO  (2/6) running `full_duplex_loopback_dma`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:75
0.025484 DEBUG ÷256 MODE_0
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.027729 DEBUG ÷256 MODE_1
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.030018 DEBUG ÷256 MODE_2
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.032262 DEBUG ÷256 MODE_3
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.034552 DEBUG ÷128 MODE_0
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.035789 DEBUG ÷128 MODE_1
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.037050 DEBUG ÷128 MODE_2
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.038288 DEBUG ÷128 MODE_3
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.039549 DEBUG ÷64 MODE_0
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.040290 DEBUG ÷64 MODE_1
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.041042 DEBUG ÷64 MODE_2
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.041783 DEBUG ÷64 MODE_3
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.042535 DEBUG ÷32 MODE_0
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.043028 DEBUG ÷32 MODE_1
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.043520 DEBUG ÷32 MODE_2
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.044014 DEBUG ÷32 MODE_3
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.044506 DEBUG ÷16 MODE_0
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.044882 DEBUG ÷16 MODE_1
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.045254 DEBUG ÷16 MODE_2
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.045630 DEBUG ÷16 MODE_3
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.046003 DEBUG ÷8 MODE_0
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.046306 DEBUG ÷8 MODE_1
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.046609 DEBUG ÷8 MODE_2
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.046912 DEBUG ÷8 MODE_3
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.047215 DEBUG ÷4 MODE_0
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.047494 DEBUG ÷4 MODE_1
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.047771 DEBUG ÷4 MODE_2
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.048049 DEBUG ÷4 MODE_3
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.048327 INFO  (3/6) running `mosi_simplex_loopback`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:75
0.048351 DEBUG ÷256 MODE_0
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.049427 DEBUG ÷256 MODE_1
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.050528 DEBUG ÷256 MODE_2
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.051604 DEBUG ÷256 MODE_3
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.052705 DEBUG ÷128 MODE_0
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.053285 DEBUG ÷128 MODE_1
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.053874 DEBUG ÷128 MODE_2
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.054454 DEBUG ÷128 MODE_3
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.055043 DEBUG ÷64 MODE_0
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.055372 DEBUG ÷64 MODE_1
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.055707 DEBUG ÷64 MODE_2
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.056036 DEBUG ÷64 MODE_3
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.056371 DEBUG ÷32 MODE_0
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.056573 DEBUG ÷32 MODE_1
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.056776 DEBUG ÷32 MODE_2
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.056978 DEBUG ÷32 MODE_3
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.057182 DEBUG ÷16 MODE_0
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.057322 DEBUG ÷16 MODE_1
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.057462 DEBUG ÷16 MODE_2
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.057602 DEBUG ÷16 MODE_3
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.057742 DEBUG ÷8 MODE_0
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.057852 DEBUG ÷8 MODE_1
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.057961 DEBUG ÷8 MODE_2
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.058071 DEBUG ÷8 MODE_3
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.058181 DEBUG ÷4 MODE_0
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.058290 DEBUG ÷4 MODE_1
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.058400 DEBUG ÷4 MODE_2
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.058509 DEBUG ÷4 MODE_3
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.058619 INFO  (4/6) running `mosi_simplex_loopback_dma`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:75
0.058643 DEBUG ÷256 MODE_0
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.059725 DEBUG ÷256 MODE_1
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.060829 DEBUG ÷256 MODE_2
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.061911 DEBUG ÷256 MODE_3
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.063015 DEBUG ÷128 MODE_0
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.063603 DEBUG ÷128 MODE_1
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.064193 DEBUG ÷128 MODE_2
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.064781 DEBUG ÷128 MODE_3
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.065371 DEBUG ÷64 MODE_0
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.065710 DEBUG ÷64 MODE_1
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.066046 DEBUG ÷64 MODE_2
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.066385 DEBUG ÷64 MODE_3
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.066721 DEBUG ÷32 MODE_0
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.066926 DEBUG ÷32 MODE_1
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.067133 DEBUG ÷32 MODE_2
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.067338 DEBUG ÷32 MODE_3
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.067544 DEBUG ÷16 MODE_0
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.067684 DEBUG ÷16 MODE_1
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.067831 DEBUG ÷16 MODE_2
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.067971 DEBUG ÷16 MODE_3
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068119 DEBUG ÷8 MODE_0
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068231 DEBUG ÷8 MODE_1
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068342 DEBUG ÷8 MODE_2
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068454 DEBUG ÷8 MODE_3
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068566 DEBUG ÷4 MODE_0
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068671 DEBUG ÷4 MODE_1
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068777 DEBUG ÷4 MODE_2
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068883 DEBUG ÷4 MODE_3
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068989 INFO  (5/6) running `miso_simplex_loopback`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:75
0.069013 DEBUG ÷256 MODE_0
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.070136 DEBUG ÷256 MODE_1
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.071333 DEBUG ÷256 MODE_2
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.072458 DEBUG ÷256 MODE_3
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.073655 DEBUG ÷128 MODE_0
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.074297 DEBUG ÷128 MODE_1
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.074980 DEBUG ÷128 MODE_2
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.075623 DEBUG ÷128 MODE_3
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.076306 DEBUG ÷64 MODE_0
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.076710 DEBUG ÷64 MODE_1
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.077135 DEBUG ÷64 MODE_2
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.077539 DEBUG ÷64 MODE_3
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.077963 DEBUG ÷32 MODE_0
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.078251 DEBUG ÷32 MODE_1
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.078542 DEBUG ÷32 MODE_2
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.078829 DEBUG ÷32 MODE_3
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.079121 DEBUG ÷16 MODE_0
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.079351 DEBUG ÷16 MODE_1
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.079581 DEBUG ÷16 MODE_2
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.079810 DEBUG ÷16 MODE_3
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.080040 DEBUG ÷8 MODE_0
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.080244 DEBUG ÷8 MODE_1
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.080447 DEBUG ÷8 MODE_2
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.080650 DEBUG ÷8 MODE_3
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.080853 DEBUG ÷4 MODE_0
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.081033 DEBUG ÷4 MODE_1
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.081212 DEBUG ÷4 MODE_2
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.081391 DEBUG ÷4 MODE_3
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.081570 INFO  (6/6) running `miso_simplex_loopback_dma`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:75
0.081594 DEBUG ÷256 MODE_0
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.082702 DEBUG ÷256 MODE_1
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.083885 DEBUG ÷256 MODE_2
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.084993 DEBUG ÷256 MODE_3
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.086176 DEBUG ÷128 MODE_0
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.086803 DEBUG ÷128 MODE_1
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.087471 DEBUG ÷128 MODE_2
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.088098 DEBUG ÷128 MODE_3
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.102210 DEBUG ÷64 MODE_0
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.102598 DEBUG ÷64 MODE_1
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.103008 DEBUG ÷64 MODE_2
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.103395 DEBUG ÷64 MODE_3
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.103805 DEBUG ÷32 MODE_0
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.104076 DEBUG ÷32 MODE_1
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.104354 DEBUG ÷32 MODE_2
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.104624 DEBUG ÷32 MODE_3
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.104902 DEBUG ÷16 MODE_0
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.105116 DEBUG ÷16 MODE_1
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.105330 DEBUG ÷16 MODE_2
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.105544 DEBUG ÷16 MODE_3
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.105758 DEBUG ÷8 MODE_0
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.105945 DEBUG ÷8 MODE_1
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.106133 DEBUG ÷8 MODE_2
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.106320 DEBUG ÷8 MODE_3
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.106507 DEBUG ÷4 MODE_0
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.106671 DEBUG ÷4 MODE_1
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.106834 DEBUG ÷4 MODE_2
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.106997 DEBUG ÷4 MODE_3
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.107161 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:75
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

Output from: cargo test -p i2c-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling i2c-testsuite v0.1.0 (/tmp/tmp6jx3szg1/i2c-testsuite)
    Finished test [optimized + debuginfo] target(s) in 0.47s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-4a58f6b85b8c68fd)
(HOST) INFO  flashing program (21.38 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
 INFO  (1/2) running `sht31_measurement`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:22
 WARN  A SHT31 sensor must be connected to the board on pins B8 (SCL) & B7 (SDA) for this test to work
└─ test::tests::sht31_measurement @ tests/test.rs:81
 ERROR I2C error: Nack
└─ test::tests::sht31_measurement @ tests/test.rs:88
 INFO  (2/2) running `loopback`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:22
 WARN  I2C1 pins B8 (SCL) and B7 (SDA) must be connected to I2C pins A12 (SCL) and A11 (SDA) for this test to pass
└─ test::tests::loopback @ tests/test.rs:94
 DEBUG I2C2 ISR=0xEE8009
└─ test::__cortex_m_rt_I2C2_EV @ tests/test.rs:114
 DEBUG I2C2 ISR=0xEF800C
└─ test::__cortex_m_rt_I2C2_EV @ tests/test.rs:114
 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:22
────────────────────────────────────────────────────────────────────────────────
(HOST) INFO  device halted without error

Output from: cargo test -p lptim-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling lptim-testsuite v0.1.0 (/tmp/tmp6jx3szg1/lptim-testsuite)
    Finished test [optimized + debuginfo] target(s) in 0.43s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-7e3059787ba94315)
(HOST) INFO  flashing program (12.37 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000009 INFO  (1/2) running `oneshot`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:25
0.000105 DEBUG 1317404 < 1317504 < 1317604
└─ test::tests::oneshot @ tests/test.rs:96
0.000141 INFO  (2/2) running `oneshot_external_trigger`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:25
0.000164 WARN  Pin B7 must be connected to A11 for this test to pass
└─ test::tests::oneshot_external_trigger @ tests/test.rs:102
0.000237 DEBUG 7466 < 7566 < 7666
└─ test::tests::oneshot_external_trigger @ tests/test.rs:137
0.000273 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:25
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

Output from: cargo test -p aes-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling hex-literal v0.3.3
   Compiling aes-testsuite v0.1.0 (/tmp/tmp6jx3szg1/aes-testsuite)
    Finished test [optimized + debuginfo] target(s) in 1.24s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-63f23314b915b7e6)
(HOST) INFO  flashing program (49.91 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000007 INFO  (1/13) running `encrypt_ecb_128`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.000278 INFO  Approximate cycles per 128-bit encrypt: 205
└─ test::tests::encrypt_ecb_128 @ tests/test.rs:1529
0.000300 INFO  (2/13) running `encrypt_ecb_256`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.000535 INFO  Approximate cycles per 256-bit encrypt: 264
└─ test::tests::encrypt_ecb_256 @ tests/test.rs:1554
0.000557 INFO  (3/13) running `encrypt_ecb_inplace_128`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.000828 INFO  Approximate cycles per 128-bit encrypt: 209
└─ test::tests::encrypt_ecb_inplace_128 @ tests/test.rs:1580
0.000850 INFO  (4/13) running `encrypt_ecb_inplace_256`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.001084 INFO  Approximate cycles per 256-bit encrypt: 262
└─ test::tests::encrypt_ecb_inplace_256 @ tests/test.rs:1604
0.001106 INFO  (5/13) running `encrypt_gcm_inplace_128`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.002516 INFO  Approximate cycles per 128-bit encrypt: 685
└─ test::tests::encrypt_gcm_inplace_128 @ tests/test.rs:1637
0.002538 INFO  (6/13) running `encrypt_gcm_inplace_256`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.004100 INFO  Approximate cycles per 256-bit encrypt: 802
└─ test::tests::encrypt_gcm_inplace_256 @ tests/test.rs:1670
0.004122 INFO  (7/13) running `decrypt_ecb_128`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.004431 INFO  Average cycles per 128-bit decrypt: 278
└─ test::tests::decrypt_ecb_128 @ tests/test.rs:1695
0.004453 INFO  (8/13) running `decrypt_ecb_inplace_128`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.004763 INFO  Average cycles per 128-bit decrypt: 267
└─ test::tests::decrypt_ecb_inplace_128 @ tests/test.rs:1719
0.004785 INFO  (9/13) running `decrypt_ecb_256`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.005047 INFO  Average cycles per 256-bit decrypt: 330
└─ test::tests::decrypt_ecb_256 @ tests/test.rs:1744
0.005068 INFO  (10/13) running `decrypt_ecb_inplace_256`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.005329 INFO  Average cycles per 256-bit decrypt: 316
└─ test::tests::decrypt_ecb_inplace_256 @ tests/test.rs:1768
0.005351 INFO  (11/13) running `decrypt_gcm_inplace_128`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.006767 INFO  Approximate cycles per 128-bit decrypt: 678
└─ test::tests::decrypt_gcm_inplace_128 @ tests/test.rs:1801
0.006788 INFO  (12/13) running `decrypt_gcm_inplace_256`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.008339 INFO  Approximate cycles per 256-bit decrypt: 787
└─ test::tests::decrypt_gcm_inplace_256 @ tests/test.rs:1834
0.008361 INFO  (13/13) running `gcm_non_native_size`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.008886 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

Output from: cargo test -p rng-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling ppv-lite86 v0.2.10
   Compiling rand_chacha v0.3.1
   Compiling rng-testsuite v0.1.0 (/tmp/tmp6jx3szg1/rng-testsuite)
    Finished test [optimized + debuginfo] target(s) in 2.49s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-c767ac65602b86db)
(HOST) INFO  flashing program (36.82 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
 INFO  (1/2) running `cha_cha`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:31
 WARN  Test results are only valid for release mode
└─ test::tests::cha_cha @ tests/test.rs:47
 INFO  ChaCha20: 2817.395
└─ test::tests::cha_cha @ tests/test.rs:91
 INFO  ChaCha12: 1737.99
└─ test::tests::cha_cha @ tests/test.rs:92
 INFO  ChaCha8: 1199.65
└─ test::tests::cha_cha @ tests/test.rs:93
 INFO  HW: 409.915
└─ test::tests::cha_cha @ tests/test.rs:94
 INFO  (2/2) running `random_enough_for_me`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:31
 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:31
────────────────────────────────────────────────────────────────────────────────
(HOST) INFO  device halted without error

Output from: cargo test -p rtc-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling rtc-testsuite v0.1.0 (/tmp/tmp6jx3szg1/rtc-testsuite)
    Finished test [optimized + debuginfo] target(s) in 0.39s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-bfb705fa412c01af)
(HOST) INFO  flashing program (17.86 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000010 INFO  (1/3) running `test_set_date_time_lse`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:93
0.160707 TRACE four_rtc_clk_cycles=5856
└─ test::test_set_date_time_with_clk @ tests/test.rs:39
0.170996 DEBUG Timestamp before<PHONE_NUMBER>000 after<PHONE_NUMBER>007 Δ 7
└─ test::test_set_date_time_with_clk @ tests/test.rs:84
0.171033 INFO  (2/3) running `test_set_date_time_lsi`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:93
0.171381 TRACE four_rtc_clk_cycles=6000
└─ test::test_set_date_time_with_clk @ tests/test.rs:39
0.181678 DEBUG Timestamp before<PHONE_NUMBER>000 after<PHONE_NUMBER>009 Δ 9
└─ test::test_set_date_time_with_clk @ tests/test.rs:84
0.181714 INFO  (3/3) running `test_set_date_time_hse`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:93
0.181939 TRACE four_rtc_clk_cycles=192
└─ test::test_set_date_time_with_clk @ tests/test.rs:39
0.192018 DEBUG Timestamp before<PHONE_NUMBER>000 after<PHONE_NUMBER>010 Δ 10
└─ test::test_set_date_time_with_clk @ tests/test.rs:84
0.192055 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:93
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

Output from: cargo test -p rcc-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling rcc-testsuite v0.1.0 (/tmp/tmp6jx3szg1/rcc-testsuite)
    Finished test [optimized + debuginfo] target(s) in 0.40s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-b944c20e483c3ba4)
(HOST) INFO  flashing program (13.90 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
 INFO  (1/3) running `sysclk_switching`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:92
 INFO  from Hsi to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  (2/3) running `enter_exit_lprun`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:92
 INFO  Range200k
└─ test::tests::enter_exit_lprun @ tests/test.rs:136
 INFO  Range400k
└─ test::tests::enter_exit_lprun @ tests/test.rs:136
 INFO  Range800k
└─ test::tests::enter_exit_lprun @ tests/test.rs:136
 INFO  Range1M
└─ test::tests::enter_exit_lprun @ tests/test.rs:136
 INFO  (3/3) running `lsi_to_from`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:92
 INFO  LSI disabled from Div1 to Div1
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:179
 INFO  LSI disabled from Div1 to Div128
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:179
 INFO  LSI disabled from Div128 to Div1
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:179
 INFO  LSI disabled from Div128 to Div128
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:179
 INFO  LSI enabled from Div1 to Div1
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:191
 INFO  LSI enabled from Div1 to Div128
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:191
 INFO  LSI enabled from Div128 to Div1
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:191
 INFO  LSI enabled from Div128 to Div128
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:191
 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:92
────────────────────────────────────────────────────────────────────────────────
(HOST) INFO  device halted without error

Output from: cargo test -p adc-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling adc-testsuite v0.1.0 (/tmp/tmp6jx3szg1/adc-testsuite)
    Finished test [optimized + debuginfo] target(s) in 0.58s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-25ac4abb6638d544)
(HOST) INFO  flashing program (20.37 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000007 INFO  (1/10) running `enable`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.000034 INFO  Enable cycles: 137 CPU 34 ADC
└─ test::tests::enable @ tests/test.rs:80
0.000067 INFO  Disable cycles: 105 CPU 26 ADC
└─ test::tests::enable @ tests/test.rs:99
0.000099 INFO  (2/10) running `tsen_enable`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.000375 INFO  (3/10) running `vbat_enable`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.000402 INFO  (4/10) running `vref_enable`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.000428 INFO  (5/10) running `vref`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.000536 INFO  vref_cal: 1508
└─ test::tests::vref @ tests/test.rs:187
0.000557 INFO  vref pre-calibration: 1529 Δ 21
└─ test::tests::vref @ tests/test.rs:190
0.000585 INFO  vref post-calibration: 1499 Δ 9
└─ test::tests::vref @ tests/test.rs:191
0.000613 INFO  (6/10) running `test_hsi16`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.000703 INFO  vref: 1499 Δ 9
└─ test::tests::test_hsi16 @ tests/test.rs:216
0.000737 INFO  (7/10) running `temperature`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.000948 INFO  Temperature: 32 °C
└─ test::tests::temperature @ tests/test.rs:235
0.000970 INFO  (8/10) running `vbat`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.001056 INFO  VBAT=1373 Δ 8
└─ test::validate_vbat @ tests/test.rs:31
0.001085 INFO  (9/10) running `vbat_advanced`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.001147 INFO  Calibration cycles: CPU 470 ADC 117
└─ test::tests::vbat_advanced @ tests/test.rs:269
0.001178 INFO  Enable cycles: CPU 120 ADC 30
└─ test::tests::vbat_advanced @ tests/test.rs:280
0.001207 INFO  Channel configuration cycles: CPU 15 ADC 3
└─ test::tests::vbat_advanced @ tests/test.rs:292
0.001252 INFO  Sample cycles: CPU 717 ADC 179
└─ test::tests::vbat_advanced @ tests/test.rs:305
0.001281 INFO  VBAT=1371 Δ 6
└─ test::validate_vbat @ tests/test.rs:31
0.001309 INFO  VBAT=1371 Δ 6
└─ test::validate_vbat @ tests/test.rs:31
0.001338 INFO  (10/10) running `stop_conversion`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.001367 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

Output from: cargo test -p subghz-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
    Blocking waiting for file lock on package cache
    Blocking waiting for file lock on package cache
    Blocking waiting for file lock on package cache
   Compiling static_assertions v1.1.0
   Compiling nucleo-wl55jc-bsp v0.1.0-alpha.0 (/tmp/tmp6jx3szg1/nucleo-wl55jc-bsp)
   Compiling subghz-testsuite v0.1.0 (/tmp/tmp6jx3szg1/subghz-testsuite)
    Finished test [optimized + debuginfo] target(s) in 1.05s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-fbb389608b5f5d95)
(HOST) INFO  flashing program (26.26 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000007 INFO  (1/5) running `buffer_io`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.000405 INFO  Cycles 255B: 17933
└─ test::tests::buffer_io @ tests/test.rs:337
0.000514 INFO  Cycles 0B: 1186
└─ test::tests::buffer_io @ tests/test.rs:346
0.000536 INFO  (2/5) running `buffer_io_no_dma`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.001931 INFO  Cycles 255B: 65826
└─ test::tests::buffer_io_no_dma @ tests/test.rs:359
0.002044 INFO  Cycles 0B: 1347
└─ test::tests::buffer_io_no_dma @ tests/test.rs:368
0.002066 INFO  (3/5) running `sleep_enter_exit`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.004166 INFO  74959 cycles to wake radio
└─ test::tests::sleep_enter_exit @ tests/test.rs:383
0.004204 INFO  (4/5) running `fsk_ping_pong`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.017183 INFO  Attempt: 0/100
└─ test::ping_pong @ tests/test.rs:185
0.017213 DEBUG RX with timeout 238 ms
└─ test::ping_pong @ tests/test.rs:194
0.270375 INFO  RX done
└─ test::ping_pong @ tests/test.rs:217
0.270416 INFO  Ok(FskPacketStatus {
    status: Status { mode: Ok(StandbyHse), cmd: Ok(Avaliable) },
    preamble_err: false,
    sync_err: false,
    addr_err: false,
    crc_err: false,
    length_err: false,
    abort_err: false,
    pkt_received: true,
    pkt_sent: false,
    rssi_sync: -44,
    rssi_avg: -44,
})
└─ test::ping_pong @ tests/test.rs:222
0.270565 INFO  received PING
└─ test::ping_pong @ tests/test.rs:237
0.278834 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.287087 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.295343 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.303601 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.311859 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.320116 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.328372 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.336628 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.344884 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.353141 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.353156 INFO  (5/5) running `lora_ping_pong`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.366266 INFO  Attempt: 0/100
└─ test::ping_pong @ tests/test.rs:185
0.366378 DEBUG RX with timeout 88 ms
└─ test::ping_pong @ tests/test.rs:194
0.474197 INFO  RX timeout 107 ms Δ 19 ms
└─ test::ping_pong @ tests/test.rs:205
0.549217 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.549231 INFO  Attempt: 1/100
└─ test::ping_pong @ tests/test.rs:185
0.549342 DEBUG RX with timeout 116 ms
└─ test::ping_pong @ tests/test.rs:194
0.614663 INFO  RX done
└─ test::ping_pong @ tests/test.rs:217
0.614704 INFO  Ok(LoRaPacketStatus {
    status: Status { mode: Ok(StandbyHse), cmd: Ok(Avaliable) },
    rssi_pkt: -39,
    snr_pkt: 14,
    signal_rssi_pkt: -40,
})
└─ test::ping_pong @ tests/test.rs:223
0.614829 INFO  received PONG
└─ test::ping_pong @ tests/test.rs:248
0.614844 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

Output from: cargo test -p subghz-testsuite --target thumbv7em-none-eabi -- --probe 0034001A5553500B20393256
    Blocking waiting for file lock on package cache
    Blocking waiting for file lock on package cache
    Blocking waiting for file lock on package cache
    Blocking waiting for file lock on build directory
    Finished test [optimized + debuginfo] target(s) in 1.05s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-fbb389608b5f5d95)
(HOST) INFO  flashing program (26.26 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000007 INFO  (1/5) running `buffer_io`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.000405 INFO  Cycles 255B: 17933
└─ test::tests::buffer_io @ tests/test.rs:337
0.000514 INFO  Cycles 0B: 1186
└─ test::tests::buffer_io @ tests/test.rs:346
0.000536 INFO  (2/5) running `buffer_io_no_dma`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.001931 INFO  Cycles 255B: 65826
└─ test::tests::buffer_io_no_dma @ tests/test.rs:359
0.002044 INFO  Cycles 0B: 1347
└─ test::tests::buffer_io_no_dma @ tests/test.rs:368
0.002066 INFO  (3/5) running `sleep_enter_exit`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.004147 INFO  74059 cycles to wake radio
└─ test::tests::sleep_enter_exit @ tests/test.rs:383
0.004185 INFO  (4/5) running `fsk_ping_pong`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.017516 INFO  Attempt: 0/100
└─ test::ping_pong @ tests/test.rs:185
0.017547 DEBUG RX with timeout 195 ms
└─ test::ping_pong @ tests/test.rs:194
0.249467 INFO  RX timeout 231 ms Δ 36 ms
└─ test::ping_pong @ tests/test.rs:205
0.269173 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.269187 INFO  Attempt: 1/100
└─ test::ping_pong @ tests/test.rs:185
0.269299 DEBUG RX with timeout 161 ms
└─ test::ping_pong @ tests/test.rs:194
0.278019 INFO  RX done
└─ test::ping_pong @ tests/test.rs:217
0.278060 INFO  Ok(FskPacketStatus {
    status: Status { mode: Ok(StandbyHse), cmd: Ok(Avaliable) },
    preamble_err: false,
    sync_err: false,
    addr_err: false,
    crc_err: false,
    length_err: false,
    abort_err: false,
    pkt_received: true,
    pkt_sent: false,
    rssi_sync: -41,
    rssi_avg: -41,
})
└─ test::ping_pong @ tests/test.rs:222
0.278210 INFO  received PONG
└─ test::ping_pong @ tests/test.rs:248
0.278225 INFO  (5/5) running `lora_ping_pong`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.291673 INFO  Attempt: 0/100
└─ test::ping_pong @ tests/test.rs:185
0.291702 DEBUG RX with timeout 289 ms
└─ test::ping_pong @ tests/test.rs:194
0.549450 INFO  RX done
└─ test::ping_pong @ tests/test.rs:217
0.549491 INFO  Ok(LoRaPacketStatus {
    status: Status { mode: Ok(StandbyHse), cmd: Ok(Avaliable) },
    rssi_pkt: -41,
    snr_pkt: 13,
    signal_rssi_pkt: -44,
})
└─ test::ping_pong @ tests/test.rs:223
0.549616 INFO  received PING
└─ test::ping_pong @ tests/test.rs:237
0.613705 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.677793 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.741882 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.805974 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.870062 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.934161 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.998263 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
1.062357 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
1.126452 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
1.190556 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
1.190572 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

on-target CI success
This is an automated message.

Click to expand...
Output from: git clone git@github.com:newAM/stm32wl-hal.git /tmp/tmpsp_7vlis
Cloning into '/tmp/tmpsp_7vlis'...

Output from: git checkout f2d8ba91b70ab913de476fa2e0d17b8e32dfba4c
HEAD is now at f2d8ba9 aes: fix formatting

Output from: cargo test -p uart-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling autocfg v1.0.1
   Compiling proc-macro2 v1.0.29
   Compiling unicode-xid v0.2.2
   Compiling semver-parser v0.7.0
   Compiling syn v1.0.76
   Compiling semver v1.0.4
   Compiling typenum v1.14.0
   Compiling cortex-m v0.7.3
   Compiling nb v1.0.0
   Compiling void v1.0.2
   Compiling cortex-m-rt v0.6.15
   Compiling vcell v0.1.3
   Compiling version_check v0.9.3
   Compiling bitfield v0.13.2
   Compiling defmt-parser v0.2.2
   Compiling stable_deref_trait v1.2.0
   Compiling r0 v0.2.2
   Compiling cortex-m v0.6.7
   Compiling stm32wl v0.13.0 (https://github.com/newAM/stm32wl-rs.git?rev=a1aa8eaf9a3d771ccc1752ffff0fa69bf063f009#a1aa8eaf)
   Compiling panic-probe v0.2.0
   Compiling bare-metal v1.0.0
   Compiling paste v1.0.5
   Compiling cfg-if v1.0.0
   Compiling rand_core v0.6.3
   Compiling volatile-register v0.2.1
   Compiling nb v0.1.3
   Compiling semver v0.9.0
   Compiling num-traits v0.2.14
   Compiling num-integer v0.1.44
   Compiling num-rational v0.3.2
   Compiling num-iter v0.1.42
   Compiling embedded-hal v0.2.6
   Compiling generic-array v0.14.4
   Compiling rustc_version v0.2.3
   Compiling defmt v0.2.3
   Compiling bare-metal v0.2.5
   Compiling quote v1.0.9
   Compiling generic-array v0.12.4
   Compiling generic-array v0.13.3
   Compiling num-complex v0.3.1
   Compiling as-slice v0.1.5
   Compiling chrono v0.4.19
   Compiling aligned v0.3.5
   Compiling num v0.3.1
   Compiling embedded-time v0.12.0
   Compiling defmt-macros v0.2.3
   Compiling cortex-m-rt-macros v0.6.15
   Compiling defmt-test-macros v0.2.1
   Compiling defmt-rtt v0.2.0
   Compiling defmt-test v0.2.3
   Compiling stm32wl-hal v0.1.0-alpha.0 (/tmp/tmpsp_7vlis/hal)
   Compiling uart-testsuite v0.1.0 (/tmp/tmpsp_7vlis/uart-testsuite)
    Finished test [optimized + debuginfo] target(s) in 24.46s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-6a2f77b8d302b33b)
(HOST) INFO  flashing program (13.43 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
 WARN  UART tests require C1 (LPUART TX) connected to A10 (UART1 RX) and C0 (LPUART RX) connected to A9 (UART1 TX)
└─ test::tests::init @ tests/test.rs:46
 INFO  (1/3) running `single_byte_loopback_no_dma`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:16
 INFO  (2/3) running `single_byte_loopback_with_dma`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:16
 INFO  (3/3) running `core_fmt`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:16
 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:16
────────────────────────────────────────────────────────────────────────────────
(HOST) INFO  device halted without error

Output from: cargo test -p dac-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling dac-testsuite v0.1.0 (/tmp/tmpsp_7vlis/dac-testsuite)
    Finished test [optimized + debuginfo] target(s) in 0.34s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-58fba609f98de559)
(HOST) INFO  flashing program (12.70 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
 INFO  (1/2) running `pin_output`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:15
 INFO  (2/2) running `loopback`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:15
 INFO  DAC out: 1024
└─ test::tests::loopback @ tests/test.rs:75
 INFO  ADC in: 1024
└─ test::tests::loopback @ tests/test.rs:76
 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:15
────────────────────────────────────────────────────────────────────────────────
(HOST) INFO  device halted without error

Output from: cargo test -p pka-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling pka-testsuite v0.1.0 (/tmp/tmpsp_7vlis/pka-testsuite)
    Finished test [optimized + debuginfo] target(s) in 0.47s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-0ed53d16ac96f8de)
(HOST) INFO  flashing program (17.20 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000008 INFO  (1/10) running `ecdsa_sign`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
0.108633 INFO  (2/10) running `ecdsa_sign_nb`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
0.217258 INFO  (3/10) running `ecdsa_sign_ram_error`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
0.436387 INFO  (4/10) running `ecdsa_sign_mode_error`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
0.655516 INFO  (5/10) running `ecdsa_verify`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
0.874645 INFO  (6/10) running `ecdsa_verify_nb`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
1.093774 INFO  (7/10) running `ecdsa_verify_ram_err`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
1.202398 INFO  (8/10) running `ecdsa_verify_mode_err`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
1.311020 INFO  (9/10) running `ecdsa_verify_invalid_err`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
1.527158 INFO  (10/10) running `ecdsa_doc_keypair`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
1.845842 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

Output from: cargo test -p spi-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling either v1.6.1
   Compiling itertools v0.10.1
   Compiling spi-testsuite v0.1.0 (/tmp/tmpsp_7vlis/spi-testsuite)
    Finished test [optimized + debuginfo] target(s) in 1.61s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-1c11d8c7d4a850fc)
(HOST) INFO  flashing program (21.25 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000011 WARN  SPI tests require (SCK, MISO, MOSI) pins SPI1 (A5, A6, A7) connected to SPI2 (A9, C2, C3)
└─ test::tests::init @ tests/test.rs:90
0.000024 INFO  (1/6) running `full_duplex_loopback`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:75
0.000049 DEBUG ÷256 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.002288 DEBUG ÷256 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.004696 DEBUG ÷256 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.006954 DEBUG ÷256 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.009363 DEBUG ÷128 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.010655 DEBUG ÷128 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.012038 DEBUG ÷128 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.013330 DEBUG ÷128 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.014713 DEBUG ÷64 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.015527 DEBUG ÷64 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.016382 DEBUG ÷64 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.017196 DEBUG ÷64 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.018051 DEBUG ÷32 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.018638 DEBUG ÷32 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.019226 DEBUG ÷32 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.019813 DEBUG ÷32 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.020402 DEBUG ÷16 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.020876 DEBUG ÷16 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.021351 DEBUG ÷16 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.021825 DEBUG ÷16 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.022301 DEBUG ÷8 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.022720 DEBUG ÷8 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.023140 DEBUG ÷8 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.023559 DEBUG ÷8 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.023979 DEBUG ÷4 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.024349 DEBUG ÷4 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.024719 DEBUG ÷4 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.025089 DEBUG ÷4 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.025459 INFO  (2/6) running `full_duplex_loopback_dma`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:75
0.025483 DEBUG ÷256 MODE_0
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.027728 DEBUG ÷256 MODE_1
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.030017 DEBUG ÷256 MODE_2
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.032262 DEBUG ÷256 MODE_3
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.034551 DEBUG ÷128 MODE_0
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.035788 DEBUG ÷128 MODE_1
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.037049 DEBUG ÷128 MODE_2
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.038287 DEBUG ÷128 MODE_3
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.039548 DEBUG ÷64 MODE_0
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.040289 DEBUG ÷64 MODE_1
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.041041 DEBUG ÷64 MODE_2
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.041782 DEBUG ÷64 MODE_3
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.042534 DEBUG ÷32 MODE_0
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.043028 DEBUG ÷32 MODE_1
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.043520 DEBUG ÷32 MODE_2
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.044013 DEBUG ÷32 MODE_3
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.044505 DEBUG ÷16 MODE_0
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.044881 DEBUG ÷16 MODE_1
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.045254 DEBUG ÷16 MODE_2
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.045629 DEBUG ÷16 MODE_3
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.046002 DEBUG ÷8 MODE_0
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.046305 DEBUG ÷8 MODE_1
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.046608 DEBUG ÷8 MODE_2
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.046911 DEBUG ÷8 MODE_3
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.047215 DEBUG ÷4 MODE_0
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.047493 DEBUG ÷4 MODE_1
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.047770 DEBUG ÷4 MODE_2
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.048049 DEBUG ÷4 MODE_3
└─ test::tests::full_duplex_loopback_dma @ tests/test.rs:143
0.048326 INFO  (3/6) running `mosi_simplex_loopback`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:75
0.048350 DEBUG ÷256 MODE_0
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.049426 DEBUG ÷256 MODE_1
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.050527 DEBUG ÷256 MODE_2
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.051604 DEBUG ÷256 MODE_3
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.052705 DEBUG ÷128 MODE_0
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.053285 DEBUG ÷128 MODE_1
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.053874 DEBUG ÷128 MODE_2
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.054454 DEBUG ÷128 MODE_3
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.055043 DEBUG ÷64 MODE_0
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.055371 DEBUG ÷64 MODE_1
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.055707 DEBUG ÷64 MODE_2
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.056035 DEBUG ÷64 MODE_3
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.056371 DEBUG ÷32 MODE_0
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.056573 DEBUG ÷32 MODE_1
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.056776 DEBUG ÷32 MODE_2
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.056978 DEBUG ÷32 MODE_3
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.057181 DEBUG ÷16 MODE_0
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.057321 DEBUG ÷16 MODE_1
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.057461 DEBUG ÷16 MODE_2
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.057601 DEBUG ÷16 MODE_3
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.057741 DEBUG ÷8 MODE_0
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.057851 DEBUG ÷8 MODE_1
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.057960 DEBUG ÷8 MODE_2
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.058070 DEBUG ÷8 MODE_3
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.058180 DEBUG ÷4 MODE_0
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.058290 DEBUG ÷4 MODE_1
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.058399 DEBUG ÷4 MODE_2
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.058509 DEBUG ÷4 MODE_3
└─ test::tests::mosi_simplex_loopback @ tests/test.rs:190
0.058618 INFO  (4/6) running `mosi_simplex_loopback_dma`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:75
0.058642 DEBUG ÷256 MODE_0
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.059724 DEBUG ÷256 MODE_1
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.060828 DEBUG ÷256 MODE_2
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.061910 DEBUG ÷256 MODE_3
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.063014 DEBUG ÷128 MODE_0
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.063603 DEBUG ÷128 MODE_1
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.064192 DEBUG ÷128 MODE_2
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.064781 DEBUG ÷128 MODE_3
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.065370 DEBUG ÷64 MODE_0
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.065709 DEBUG ÷64 MODE_1
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.066045 DEBUG ÷64 MODE_2
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.066384 DEBUG ÷64 MODE_3
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.066721 DEBUG ÷32 MODE_0
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.066926 DEBUG ÷32 MODE_1
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.067132 DEBUG ÷32 MODE_2
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.067337 DEBUG ÷32 MODE_3
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.067543 DEBUG ÷16 MODE_0
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.067683 DEBUG ÷16 MODE_1
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.067831 DEBUG ÷16 MODE_2
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.067970 DEBUG ÷16 MODE_3
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068118 DEBUG ÷8 MODE_0
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068230 DEBUG ÷8 MODE_1
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068342 DEBUG ÷8 MODE_2
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068453 DEBUG ÷8 MODE_3
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068565 DEBUG ÷4 MODE_0
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068671 DEBUG ÷4 MODE_1
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068776 DEBUG ÷4 MODE_2
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068882 DEBUG ÷4 MODE_3
└─ test::tests::mosi_simplex_loopback_dma @ tests/test.rs:213
0.068988 INFO  (5/6) running `miso_simplex_loopback`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:75
0.069012 DEBUG ÷256 MODE_0
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.070136 DEBUG ÷256 MODE_1
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.071333 DEBUG ÷256 MODE_2
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.072457 DEBUG ÷256 MODE_3
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.073654 DEBUG ÷128 MODE_0
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.074297 DEBUG ÷128 MODE_1
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.074980 DEBUG ÷128 MODE_2
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.075622 DEBUG ÷128 MODE_3
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.076306 DEBUG ÷64 MODE_0
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.076710 DEBUG ÷64 MODE_1
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.077134 DEBUG ÷64 MODE_2
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.077538 DEBUG ÷64 MODE_3
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.077963 DEBUG ÷32 MODE_0
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.078250 DEBUG ÷32 MODE_1
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.078542 DEBUG ÷32 MODE_2
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.078829 DEBUG ÷32 MODE_3
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.079120 DEBUG ÷16 MODE_0
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.079350 DEBUG ÷16 MODE_1
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.079580 DEBUG ÷16 MODE_2
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.079810 DEBUG ÷16 MODE_3
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.080039 DEBUG ÷8 MODE_0
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.080243 DEBUG ÷8 MODE_1
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.080446 DEBUG ÷8 MODE_2
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.080649 DEBUG ÷8 MODE_3
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.080853 DEBUG ÷4 MODE_0
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.081032 DEBUG ÷4 MODE_1
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.081211 DEBUG ÷4 MODE_2
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.081390 DEBUG ÷4 MODE_3
└─ test::tests::miso_simplex_loopback @ tests/test.rs:247
0.081569 INFO  (6/6) running `miso_simplex_loopback_dma`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:75
0.081593 DEBUG ÷256 MODE_0
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.082702 DEBUG ÷256 MODE_1
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.083884 DEBUG ÷256 MODE_2
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.084993 DEBUG ÷256 MODE_3
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.086175 DEBUG ÷128 MODE_0
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.086802 DEBUG ÷128 MODE_1
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.087471 DEBUG ÷128 MODE_2
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.088098 DEBUG ÷128 MODE_3
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.088766 DEBUG ÷64 MODE_0
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.089153 DEBUG ÷64 MODE_1
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.089563 DEBUG ÷64 MODE_2
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.089951 DEBUG ÷64 MODE_3
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.090361 DEBUG ÷32 MODE_0
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.090632 DEBUG ÷32 MODE_1
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.090909 DEBUG ÷32 MODE_2
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.091180 DEBUG ÷32 MODE_3
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.091458 DEBUG ÷16 MODE_0
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.091672 DEBUG ÷16 MODE_1
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.091886 DEBUG ÷16 MODE_2
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.092099 DEBUG ÷16 MODE_3
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.092313 DEBUG ÷8 MODE_0
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.092501 DEBUG ÷8 MODE_1
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.092688 DEBUG ÷8 MODE_2
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.092875 DEBUG ÷8 MODE_3
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.093063 DEBUG ÷4 MODE_0
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.093226 DEBUG ÷4 MODE_1
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.093390 DEBUG ÷4 MODE_2
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.131673 DEBUG ÷4 MODE_3
└─ test::tests::miso_simplex_loopback_dma @ tests/test.rs:275
0.131836 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:75
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

Output from: cargo test -p i2c-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling i2c-testsuite v0.1.0 (/tmp/tmpsp_7vlis/i2c-testsuite)
    Finished test [optimized + debuginfo] target(s) in 0.48s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-4a58f6b85b8c68fd)
(HOST) INFO  flashing program (21.38 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
 INFO  (1/2) running `sht31_measurement`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:22
 WARN  A SHT31 sensor must be connected to the board on pins B8 (SCL) & B7 (SDA) for this test to work
└─ test::tests::sht31_measurement @ tests/test.rs:81
 ERROR I2C error: Nack
└─ test::tests::sht31_measurement @ tests/test.rs:88
 INFO  (2/2) running `loopback`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:22
 WARN  I2C1 pins B8 (SCL) and B7 (SDA) must be connected to I2C pins A12 (SCL) and A11 (SDA) for this test to pass
└─ test::tests::loopback @ tests/test.rs:94
 DEBUG I2C2 ISR=0xEE8009
└─ test::__cortex_m_rt_I2C2_EV @ tests/test.rs:114
 DEBUG I2C2 ISR=0xEF800C
└─ test::__cortex_m_rt_I2C2_EV @ tests/test.rs:114
 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:22
────────────────────────────────────────────────────────────────────────────────
(HOST) INFO  device halted without error

Output from: cargo test -p lptim-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling lptim-testsuite v0.1.0 (/tmp/tmpsp_7vlis/lptim-testsuite)
    Finished test [optimized + debuginfo] target(s) in 0.43s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-7e3059787ba94315)
(HOST) INFO  flashing program (12.37 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000009 INFO  (1/2) running `oneshot`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:25
0.000105 DEBUG 1317404 < 1317504 < 1317604
└─ test::tests::oneshot @ tests/test.rs:96
0.000141 INFO  (2/2) running `oneshot_external_trigger`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:25
0.000164 WARN  Pin B7 must be connected to A11 for this test to pass
└─ test::tests::oneshot_external_trigger @ tests/test.rs:102
0.000237 DEBUG 7466 < 7566 < 7666
└─ test::tests::oneshot_external_trigger @ tests/test.rs:137
0.000273 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:25
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

Output from: cargo test -p aes-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling hex-literal v0.3.3
   Compiling aes-testsuite v0.1.0 (/tmp/tmpsp_7vlis/aes-testsuite)
    Finished test [optimized + debuginfo] target(s) in 1.28s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-63f23314b915b7e6)
(HOST) INFO  flashing program (49.91 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000007 INFO  (1/13) running `encrypt_ecb_128`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.000278 INFO  Approximate cycles per 128-bit encrypt: 205
└─ test::tests::encrypt_ecb_128 @ tests/test.rs:1529
0.000300 INFO  (2/13) running `encrypt_ecb_256`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.000535 INFO  Approximate cycles per 256-bit encrypt: 264
└─ test::tests::encrypt_ecb_256 @ tests/test.rs:1554
0.000557 INFO  (3/13) running `encrypt_ecb_inplace_128`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.000828 INFO  Approximate cycles per 128-bit encrypt: 209
└─ test::tests::encrypt_ecb_inplace_128 @ tests/test.rs:1580
0.000850 INFO  (4/13) running `encrypt_ecb_inplace_256`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.001084 INFO  Approximate cycles per 256-bit encrypt: 262
└─ test::tests::encrypt_ecb_inplace_256 @ tests/test.rs:1604
0.001106 INFO  (5/13) running `encrypt_gcm_inplace_128`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.002516 INFO  Approximate cycles per 128-bit encrypt: 685
└─ test::tests::encrypt_gcm_inplace_128 @ tests/test.rs:1637
0.002538 INFO  (6/13) running `encrypt_gcm_inplace_256`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.004100 INFO  Approximate cycles per 256-bit encrypt: 802
└─ test::tests::encrypt_gcm_inplace_256 @ tests/test.rs:1670
0.004122 INFO  (7/13) running `decrypt_ecb_128`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.004431 INFO  Average cycles per 128-bit decrypt: 278
└─ test::tests::decrypt_ecb_128 @ tests/test.rs:1695
0.004453 INFO  (8/13) running `decrypt_ecb_inplace_128`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.004763 INFO  Average cycles per 128-bit decrypt: 267
└─ test::tests::decrypt_ecb_inplace_128 @ tests/test.rs:1719
0.004785 INFO  (9/13) running `decrypt_ecb_256`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.005047 INFO  Average cycles per 256-bit decrypt: 330
└─ test::tests::decrypt_ecb_256 @ tests/test.rs:1744
0.005069 INFO  (10/13) running `decrypt_ecb_inplace_256`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.005329 INFO  Average cycles per 256-bit decrypt: 316
└─ test::tests::decrypt_ecb_inplace_256 @ tests/test.rs:1768
0.005351 INFO  (11/13) running `decrypt_gcm_inplace_128`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.006767 INFO  Approximate cycles per 128-bit decrypt: 679
└─ test::tests::decrypt_gcm_inplace_128 @ tests/test.rs:1801
0.006788 INFO  (12/13) running `decrypt_gcm_inplace_256`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.008340 INFO  Approximate cycles per 256-bit decrypt: 787
└─ test::tests::decrypt_gcm_inplace_256 @ tests/test.rs:1834
0.008361 INFO  (13/13) running `gcm_non_native_size`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
0.008887 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:1491
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

Output from: cargo test -p rng-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling ppv-lite86 v0.2.10
   Compiling rand_chacha v0.3.1
   Compiling rng-testsuite v0.1.0 (/tmp/tmpsp_7vlis/rng-testsuite)
    Finished test [optimized + debuginfo] target(s) in 2.47s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-c767ac65602b86db)
(HOST) INFO  flashing program (36.82 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
 INFO  (1/2) running `cha_cha`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:31
 WARN  Test results are only valid for release mode
└─ test::tests::cha_cha @ tests/test.rs:47
 INFO  ChaCha20: 2817.42
└─ test::tests::cha_cha @ tests/test.rs:91
 INFO  ChaCha12: 1737.975
└─ test::tests::cha_cha @ tests/test.rs:92
 INFO  ChaCha8: 1199.65
└─ test::tests::cha_cha @ tests/test.rs:93
 INFO  HW: 409.915
└─ test::tests::cha_cha @ tests/test.rs:94
 INFO  (2/2) running `random_enough_for_me`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:31
 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:31
────────────────────────────────────────────────────────────────────────────────
(HOST) INFO  device halted without error

Output from: cargo test -p rtc-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling rtc-testsuite v0.1.0 (/tmp/tmpsp_7vlis/rtc-testsuite)
    Finished test [optimized + debuginfo] target(s) in 0.39s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-bfb705fa412c01af)
(HOST) INFO  flashing program (17.86 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000010 INFO  (1/3) running `test_set_date_time_lse`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:93
0.164613 TRACE four_rtc_clk_cycles=5856
└─ test::test_set_date_time_with_clk @ tests/test.rs:39
0.174902 DEBUG Timestamp before<PHONE_NUMBER>000 after<PHONE_NUMBER>007 Δ 7
└─ test::test_set_date_time_with_clk @ tests/test.rs:84
0.174938 INFO  (2/3) running `test_set_date_time_lsi`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:93
0.175287 TRACE four_rtc_clk_cycles=6000
└─ test::test_set_date_time_with_clk @ tests/test.rs:39
0.185584 DEBUG Timestamp before<PHONE_NUMBER>000 after<PHONE_NUMBER>009 Δ 9
└─ test::test_set_date_time_with_clk @ tests/test.rs:84
0.185620 INFO  (3/3) running `test_set_date_time_hse`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:93
0.185849 TRACE four_rtc_clk_cycles=192
└─ test::test_set_date_time_with_clk @ tests/test.rs:39
0.195929 DEBUG Timestamp before<PHONE_NUMBER>000 after<PHONE_NUMBER>010 Δ 10
└─ test::test_set_date_time_with_clk @ tests/test.rs:84
0.195965 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:93
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

Output from: cargo test -p rcc-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling rcc-testsuite v0.1.0 (/tmp/tmpsp_7vlis/rcc-testsuite)
    Finished test [optimized + debuginfo] target(s) in 0.40s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-b944c20e483c3ba4)
(HOST) INFO  flashing program (13.90 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
 INFO  (1/3) running `sysclk_switching`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:92
 INFO  from Hsi to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hsi to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_0) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Hse(V1_2) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range200k) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range400k) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range800k) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range1M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range2M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range4M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range8M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range16M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range24M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range32M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Hsi
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Hse(V1_0)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Hse(V1_2)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range200k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range400k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range800k)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range1M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range2M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range4M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range8M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range16M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range24M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range32M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  from Msi(Range48M) to Msi(Range48M)
└─ test::tests::sysclk_switching @ tests/test.rs:117
 INFO  (2/3) running `enter_exit_lprun`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:92
 INFO  Range200k
└─ test::tests::enter_exit_lprun @ tests/test.rs:136
 INFO  Range400k
└─ test::tests::enter_exit_lprun @ tests/test.rs:136
 INFO  Range800k
└─ test::tests::enter_exit_lprun @ tests/test.rs:136
 INFO  Range1M
└─ test::tests::enter_exit_lprun @ tests/test.rs:136
 INFO  (3/3) running `lsi_to_from`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:92
 INFO  LSI disabled from Div1 to Div1
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:179
 INFO  LSI disabled from Div1 to Div128
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:179
 INFO  LSI disabled from Div128 to Div1
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:179
 INFO  LSI disabled from Div128 to Div128
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:179
 INFO  LSI enabled from Div1 to Div1
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:191
 INFO  LSI enabled from Div1 to Div128
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:191
 INFO  LSI enabled from Div128 to Div1
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:191
 INFO  LSI enabled from Div128 to Div128
└─ test::tests::lsi_to_from::{{impl}}::format @ tests/test.rs:191
 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:92
────────────────────────────────────────────────────────────────────────────────
(HOST) INFO  device halted without error

Output from: cargo test -p adc-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling adc-testsuite v0.1.0 (/tmp/tmpsp_7vlis/adc-testsuite)
    Finished test [optimized + debuginfo] target(s) in 0.58s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-25ac4abb6638d544)
(HOST) INFO  flashing program (20.37 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000007 INFO  (1/10) running `enable`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.000034 INFO  Enable cycles: 137 CPU 34 ADC
└─ test::tests::enable @ tests/test.rs:80
0.000067 INFO  Disable cycles: 105 CPU 26 ADC
└─ test::tests::enable @ tests/test.rs:99
0.000099 INFO  (2/10) running `tsen_enable`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.000375 INFO  (3/10) running `vbat_enable`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.000402 INFO  (4/10) running `vref_enable`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.000428 INFO  (5/10) running `vref`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.000536 INFO  vref_cal: 1508
└─ test::tests::vref @ tests/test.rs:187
0.000557 INFO  vref pre-calibration: 1530 Δ 22
└─ test::tests::vref @ tests/test.rs:190
0.000585 INFO  vref post-calibration: 1499 Δ 9
└─ test::tests::vref @ tests/test.rs:191
0.000613 INFO  (6/10) running `test_hsi16`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.000703 INFO  vref: 1498 Δ 10
└─ test::tests::test_hsi16 @ tests/test.rs:216
0.000737 INFO  (7/10) running `temperature`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.000948 INFO  Temperature: 32 °C
└─ test::tests::temperature @ tests/test.rs:235
0.000970 INFO  (8/10) running `vbat`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.001056 INFO  VBAT=1371 Δ 6
└─ test::validate_vbat @ tests/test.rs:31
0.001085 INFO  (9/10) running `vbat_advanced`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.001147 INFO  Calibration cycles: CPU 470 ADC 117
└─ test::tests::vbat_advanced @ tests/test.rs:269
0.001178 INFO  Enable cycles: CPU 120 ADC 30
└─ test::tests::vbat_advanced @ tests/test.rs:280
0.001207 INFO  Channel configuration cycles: CPU 15 ADC 3
└─ test::tests::vbat_advanced @ tests/test.rs:292
0.001252 INFO  Sample cycles: CPU 717 ADC 179
└─ test::tests::vbat_advanced @ tests/test.rs:305
0.001281 INFO  VBAT=1373 Δ 8
└─ test::validate_vbat @ tests/test.rs:31
0.001309 INFO  VBAT=1373 Δ 8
└─ test::validate_vbat @ tests/test.rs:31
0.001338 INFO  (10/10) running `stop_conversion`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
0.001367 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:35
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

Output from: cargo test -p subghz-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
    Blocking waiting for file lock on package cache
    Blocking waiting for file lock on package cache
    Blocking waiting for file lock on package cache
   Compiling static_assertions v1.1.0
   Compiling nucleo-wl55jc-bsp v0.1.0-alpha.0 (/tmp/tmpsp_7vlis/nucleo-wl55jc-bsp)
   Compiling subghz-testsuite v0.1.0 (/tmp/tmpsp_7vlis/subghz-testsuite)
    Finished test [optimized + debuginfo] target(s) in 1.05s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-fbb389608b5f5d95)
(HOST) INFO  flashing program (26.26 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000007 INFO  (1/5) running `buffer_io`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.000405 INFO  Cycles 255B: 17933
└─ test::tests::buffer_io @ tests/test.rs:337
0.000514 INFO  Cycles 0B: 1186
└─ test::tests::buffer_io @ tests/test.rs:346
0.000536 INFO  (2/5) running `buffer_io_no_dma`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.001931 INFO  Cycles 255B: 65826
└─ test::tests::buffer_io_no_dma @ tests/test.rs:359
0.002044 INFO  Cycles 0B: 1347
└─ test::tests::buffer_io_no_dma @ tests/test.rs:368
0.002066 INFO  (3/5) running `sleep_enter_exit`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.004166 INFO  74945 cycles to wake radio
└─ test::tests::sleep_enter_exit @ tests/test.rs:383
0.004204 INFO  (4/5) running `fsk_ping_pong`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.017178 INFO  Attempt: 0/100
└─ test::ping_pong @ tests/test.rs:185
0.017208 DEBUG RX with timeout 275 ms
└─ test::ping_pong @ tests/test.rs:194
0.135664 INFO  RX done
└─ test::ping_pong @ tests/test.rs:217
0.135705 INFO  Ok(FskPacketStatus {
    status: Status { mode: Ok(StandbyHse), cmd: Ok(Avaliable) },
    preamble_err: false,
    sync_err: false,
    addr_err: false,
    crc_err: false,
    length_err: false,
    abort_err: false,
    pkt_received: true,
    pkt_sent: false,
    rssi_sync: -44,
    rssi_avg: -44,
})
└─ test::ping_pong @ tests/test.rs:222
0.135855 INFO  received PING
└─ test::ping_pong @ tests/test.rs:237
0.144122 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.152373 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.160625 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.168879 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.177131 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.185383 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.193634 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.201886 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.210138 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.218390 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.218406 INFO  (5/5) running `lora_ping_pong`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.231492 INFO  Attempt: 0/100
└─ test::ping_pong @ tests/test.rs:185
0.231604 DEBUG RX with timeout 72 ms
└─ test::ping_pong @ tests/test.rs:194
0.321746 INFO  RX timeout 90 ms Δ 18 ms
└─ test::ping_pong @ tests/test.rs:205
0.396707 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.396721 INFO  Attempt: 1/100
└─ test::ping_pong @ tests/test.rs:185
0.396750 DEBUG RX with timeout 132 ms
└─ test::ping_pong @ tests/test.rs:194
0.462095 INFO  RX done
└─ test::ping_pong @ tests/test.rs:217
0.462137 INFO  Ok(LoRaPacketStatus {
    status: Status { mode: Ok(StandbyHse), cmd: Ok(Avaliable) },
    rssi_pkt: -43,
    snr_pkt: 14,
    signal_rssi_pkt: -47,
})
└─ test::ping_pong @ tests/test.rs:223
0.462261 INFO  received PONG
└─ test::ping_pong @ tests/test.rs:248
0.462276 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

Output from: cargo test -p subghz-testsuite --target thumbv7em-none-eabi -- --probe 0034001A5553500B20393256
    Blocking waiting for file lock on package cache
    Blocking waiting for file lock on package cache
    Blocking waiting for file lock on package cache
    Blocking waiting for file lock on build directory
    Finished test [optimized + debuginfo] target(s) in 1.05s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-fbb389608b5f5d95)
(HOST) INFO  flashing program (26.26 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000007 INFO  (1/5) running `buffer_io`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.000405 INFO  Cycles 255B: 17933
└─ test::tests::buffer_io @ tests/test.rs:337
0.000514 INFO  Cycles 0B: 1186
└─ test::tests::buffer_io @ tests/test.rs:346
0.000536 INFO  (2/5) running `buffer_io_no_dma`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.001931 INFO  Cycles 255B: 65826
└─ test::tests::buffer_io_no_dma @ tests/test.rs:359
0.002044 INFO  Cycles 0B: 1347
└─ test::tests::buffer_io_no_dma @ tests/test.rs:368
0.002066 INFO  (3/5) running `sleep_enter_exit`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.004147 INFO  74059 cycles to wake radio
└─ test::tests::sleep_enter_exit @ tests/test.rs:383
0.004185 INFO  (4/5) running `fsk_ping_pong`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.017513 INFO  Attempt: 0/100
└─ test::ping_pong @ tests/test.rs:185
0.017543 DEBUG RX with timeout 75 ms
└─ test::ping_pong @ tests/test.rs:194
0.113816 INFO  RX timeout 96 ms Δ 21 ms
└─ test::ping_pong @ tests/test.rs:205
0.133512 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.133526 INFO  Attempt: 1/100
└─ test::ping_pong @ tests/test.rs:185
0.133638 DEBUG RX with timeout 270 ms
└─ test::ping_pong @ tests/test.rs:194
0.142348 INFO  RX done
└─ test::ping_pong @ tests/test.rs:217
0.142389 INFO  Ok(FskPacketStatus {
    status: Status { mode: Ok(StandbyHse), cmd: Ok(Avaliable) },
    preamble_err: false,
    sync_err: false,
    addr_err: false,
    crc_err: false,
    length_err: false,
    abort_err: false,
    pkt_received: true,
    pkt_sent: false,
    rssi_sync: -41,
    rssi_avg: -42,
})
└─ test::ping_pong @ tests/test.rs:222
0.142538 INFO  received PONG
└─ test::ping_pong @ tests/test.rs:248
0.142553 INFO  (5/5) running `lora_ping_pong`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
0.155994 INFO  Attempt: 0/100
└─ test::ping_pong @ tests/test.rs:185
0.156024 DEBUG RX with timeout 285 ms
└─ test::ping_pong @ tests/test.rs:194
0.396025 INFO  RX done
└─ test::ping_pong @ tests/test.rs:217
0.396066 INFO  Ok(LoRaPacketStatus {
    status: Status { mode: Ok(StandbyHse), cmd: Ok(Avaliable) },
    rssi_pkt: -41,
    snr_pkt: 13,
    signal_rssi_pkt: -45,
})
└─ test::ping_pong @ tests/test.rs:223
0.396191 INFO  received PING
└─ test::ping_pong @ tests/test.rs:237
0.460254 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.524315 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.588382 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.652453 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.716527 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.780615 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.844695 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.908780 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
0.972868 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
1.036960 INFO  TX done
└─ test::tx_or_panic @ tests/test.rs:116
1.036975 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:279
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

on-target CI success
This is an automated message.

Click to expand...
Output from: git clone git@github.com:newAM/stm32wl-hal.git /tmp/tmpm9gw0p0w
Cloning into '/tmp/tmpm9gw0p0w'...

Output from: git checkout f0c6d1860752eab6c8af77d6bf218b529c7990f8
HEAD is now at f0c6d18 aes: fix test

Output from: cargo test -p uart-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling autocfg v1.0.1
   Compiling proc-macro2 v1.0.29
   Compiling unicode-xid v0.2.2
   Compiling syn v1.0.76
   Compiling semver-parser v0.7.0
   Compiling typenum v1.14.0
   Compiling cortex-m v0.7.3
   Compiling semver v1.0.4
   Compiling nb v1.0.0
   Compiling version_check v0.9.3
   Compiling void v1.0.2
   Compiling cortex-m-rt v0.6.15
   Compiling vcell v0.1.3
   Compiling bitfield v0.13.2
   Compiling defmt-parser v0.2.2
   Compiling r0 v0.2.2
   Compiling stable_deref_trait v1.2.0
   Compiling cortex-m v0.6.7
   Compiling stm32wl v0.13.0 (https://github.com/newAM/stm32wl-rs.git?rev=a1aa8eaf9a3d771ccc1752ffff0fa69bf063f009#a1aa8eaf)
   Compiling panic-probe v0.2.0
   Compiling bare-metal v1.0.0
   Compiling rand_core v0.6.3
   Compiling cfg-if v1.0.0
   Compiling paste v1.0.5
   Compiling nb v0.1.3
   Compiling semver v0.9.0
   Compiling volatile-register v0.2.1
   Compiling generic-array v0.14.4
   Compiling num-traits v0.2.14
   Compiling num-integer v0.1.44
   Compiling num-rational v0.3.2
   Compiling num-iter v0.1.42
   Compiling embedded-hal v0.2.6
   Compiling rustc_version v0.2.3
   Compiling bare-metal v0.2.5
   Compiling defmt v0.2.3
   Compiling quote v1.0.9
   Compiling generic-array v0.13.3
   Compiling generic-array v0.12.4
   Compiling num-complex v0.3.1
   Compiling as-slice v0.1.5
   Compiling chrono v0.4.19
   Compiling num v0.3.1
   Compiling aligned v0.3.5
   Compiling embedded-time v0.12.0
   Compiling defmt-macros v0.2.3
   Compiling cortex-m-rt-macros v0.6.15
   Compiling defmt-test-macros v0.2.1
   Compiling defmt-test v0.2.3
   Compiling defmt-rtt v0.2.0
   Compiling stm32wl-hal v0.1.0-alpha.0 (/tmp/tmpm9gw0p0w/hal)
   Compiling uart-testsuite v0.1.0 (/tmp/tmpm9gw0p0w/uart-testsuite)
    Finished test [optimized + debuginfo] target(s) in 24.72s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-6a2f77b8d302b33b)
(HOST) INFO  flashing program (13.43 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
 WARN  UART tests require C1 (LPUART TX) connected to A10 (UART1 RX) and C0 (LPUART RX) connected to A9 (UART1 TX)
└─ test::tests::init @ tests/test.rs:46
 INFO  (1/3) running `single_byte_loopback_no_dma`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:16
 INFO  (2/3) running `single_byte_loopback_with_dma`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:16
 INFO  (3/3) running `core_fmt`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:16
 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:16
────────────────────────────────────────────────────────────────────────────────
(HOST) INFO  device halted without error

Output from: cargo test -p dac-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling dac-testsuite v0.1.0 (/tmp/tmpm9gw0p0w/dac-testsuite)
    Finished test [optimized + debuginfo] target(s) in 0.34s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-58fba609f98de559)
(HOST) INFO  flashing program (12.70 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
 INFO  (1/2) running `pin_output`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:15
 INFO  (2/2) running `loopback`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:15
 INFO  DAC out: 1024
└─ test::tests::loopback @ tests/test.rs:75
 INFO  ADC in: 1024
└─ test::tests::loopback @ tests/test.rs:76
 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:15
────────────────────────────────────────────────────────────────────────────────
(HOST) INFO  device halted without error

Output from: cargo test -p pka-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling pka-testsuite v0.1.0 (/tmp/tmpm9gw0p0w/pka-testsuite)
    Finished test [optimized + debuginfo] target(s) in 0.47s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-0ed53d16ac96f8de)
(HOST) INFO  flashing program (17.20 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000008 INFO  (1/10) running `ecdsa_sign`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
0.108633 INFO  (2/10) running `ecdsa_sign_nb`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
0.217258 INFO  (3/10) running `ecdsa_sign_ram_error`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
0.436387 INFO  (4/10) running `ecdsa_sign_mode_error`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
0.655516 INFO  (5/10) running `ecdsa_verify`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
0.874645 INFO  (6/10) running `ecdsa_verify_nb`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
1.093774 INFO  (7/10) running `ecdsa_verify_ram_err`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
1.202398 INFO  (8/10) running `ecdsa_verify_mode_err`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
1.311020 INFO  (9/10) running `ecdsa_verify_invalid_err`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
1.527158 INFO  (10/10) running `ecdsa_doc_keypair`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
1.845844 INFO  all tests passed!
└─ test::tests::__defmt_test_entry @ tests/test.rs:60
────────────────────────────────────────────────────────────────────────────────
  (HOST) INFO  device halted without error

Output from: cargo test -p spi-testsuite --target thumbv7em-none-eabi -- --probe<PHONE_NUMBER>53500A20393256
   Compiling either v1.6.1
   Compiling itertools v0.10.1
   Compiling spi-testsuite v0.1.0 (/tmp/tmpm9gw0p0w/spi-testsuite)
    Finished test [optimized + debuginfo] target(s) in 1.58s
     Running tests/test.rs (target/thumbv7em-none-eabi/debug/deps/test-1c11d8c7d4a850fc)
(HOST) INFO  flashing program (21.25 KiB)
(HOST) INFO  success!
────────────────────────────────────────────────────────────────────────────────
0.000011 WARN  SPI tests require (SCK, MISO, MOSI) pins SPI1 (A5, A6, A7) connected to SPI2 (A9, C2, C3)
└─ test::tests::init @ tests/test.rs:90
0.000024 INFO  (1/6) running `full_duplex_loopback`...
└─ test::tests::__defmt_test_entry @ tests/test.rs:75
0.000049 DEBUG ÷256 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.002288 DEBUG ÷256 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.004696 DEBUG ÷256 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.006954 DEBUG ÷256 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.009361 DEBUG ÷128 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.010654 DEBUG ÷128 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.012037 DEBUG ÷128 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.013329 DEBUG ÷128 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.014712 DEBUG ÷64 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.015526 DEBUG ÷64 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.016381 DEBUG ÷64 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.017195 DEBUG ÷64 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.018050 DEBUG ÷32 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.018637 DEBUG ÷32 MODE_1
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.019225 DEBUG ÷32 MODE_2
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.019812 DEBUG ÷32 MODE_3
└─ test::tests::full_duplex_loopback @ tests/test.rs:98
0.020401 DEBUG ÷16 MODE_0
└─ test::tests::full_duplex_loopback @ tests/test.rs:98