From: Liviu I. <il...@li...> - 2024-06-20 07:57:50
|
> On 20 Jun 2024, at 10:13, Tommy Murphy <tom...@ho...> wrote: > > Might be worth posting a verbose `openocd -d3` log to see more detail about what's going on/wrong? sure: ``` 1: Test command: /Users/ilg/MyProjects/micro-os-plus.github/micro-os-plus-iii/micro-os-plus-iii.git/tests/build/nucleo-h743zi-cmake-debug/xpacks/.bin/openocd "-c" "gdb_port disabled" "-c" "tcl_port disabled" "-c" "telnet_port disabled" "-f" "interface/stlink-dap.cfg" "-f" "target/stm32h7x.cfg" "-d3" "-c" "program rtos-apis-test.elf verify" "-c" "arm semihosting enable" "-c" "arm semihosting_cmdline rtos-apis-test" "-c" "reset" 1: Working Directory: /Users/ilg/MyProjects/micro-os-plus.github/micro-os-plus-iii/micro-os-plus-iii.git/tests/build/nucleo-h743zi-cmake-debug/platform-bin 1: Test timeout computed to be: 10000000 1: xPack Open On-Chip Debugger 0.12.0+dev-01621-gd4607c225-dirty (2024-06-18-23:02) 1: Licensed under GNU GPL v2 1: For bug reports, read 1: http://openocd.org/doc/doxygen/bugs.html 1: User : 3 10 options.c:52 configuration_output_handler(): debug_level: 3User : 4 10 options.c:52 configuration_output_handler(): 1: Debug: 5 10 options.c:346 parse_cmdline_args(): ARGV[0] = "/Users/ilg/MyProjects/micro-os-plus.github/micro-os-plus-iii/micro-os-plus-iii.git/tests/build/nucleo-h743zi-cmake-debug/xpacks/.bin/openocd" 1: Debug: 6 10 options.c:346 parse_cmdline_args(): ARGV[1] = "-c" 1: Debug: 7 10 options.c:346 parse_cmdline_args(): ARGV[2] = "gdb_port disabled" 1: Debug: 8 10 options.c:346 parse_cmdline_args(): ARGV[3] = "-c" 1: Debug: 9 10 options.c:346 parse_cmdline_args(): ARGV[4] = "tcl_port disabled" 1: Debug: 10 10 options.c:346 parse_cmdline_args(): ARGV[5] = "-c" 1: Debug: 11 10 options.c:346 parse_cmdline_args(): ARGV[6] = "telnet_port disabled" 1: Debug: 12 10 options.c:346 parse_cmdline_args(): ARGV[7] = "-f" 1: Debug: 13 10 options.c:346 parse_cmdline_args(): ARGV[8] = "interface/stlink-dap.cfg" 1: Debug: 14 10 options.c:346 parse_cmdline_args(): ARGV[9] = "-f" 1: Debug: 15 10 options.c:346 parse_cmdline_args(): ARGV[10] = "target/stm32h7x.cfg" 1: Debug: 16 10 options.c:346 parse_cmdline_args(): ARGV[11] = "-d3" 1: Debug: 17 10 options.c:346 parse_cmdline_args(): ARGV[12] = "-c" 1: Debug: 18 10 options.c:346 parse_cmdline_args(): ARGV[13] = "program rtos-apis-test.elf verify" 1: Debug: 19 10 options.c:346 parse_cmdline_args(): ARGV[14] = "-c" 1: Debug: 20 10 options.c:346 parse_cmdline_args(): ARGV[15] = "arm semihosting enable" 1: Debug: 21 10 options.c:346 parse_cmdline_args(): ARGV[16] = "-c" 1: Debug: 22 10 options.c:346 parse_cmdline_args(): ARGV[17] = "arm semihosting_cmdline rtos-apis-test" 1: Debug: 23 10 options.c:346 parse_cmdline_args(): ARGV[18] = "-c" 1: Debug: 24 10 options.c:346 parse_cmdline_args(): ARGV[19] = "reset" 1: Debug: 25 10 options.c:233 add_default_dirs(): bindir=/Users/ilg/Work/xpack-dev-tools-build/openocd-0.12.0-4/darwin-x64/application/bin 1: Debug: 26 10 options.c:234 add_default_dirs(): pkgdatadir=/Users/ilg/Work/xpack-dev-tools-build/openocd-0.12.0-4/darwin-x64/application/openocd 1: Debug: 27 10 options.c:235 add_default_dirs(): exepath=/Users/ilg/Library/xPacks/@xpack-dev-tools/openocd/0.12.0-3.1/.content/bin 1: Debug: 28 10 options.c:236 add_default_dirs(): bin2data=../openocd 1: Debug: 29 10 configuration.c:33 add_script_search_dir(): adding /Users/ilg/Library/Preferences/org.openocd 1: Debug: 30 10 configuration.c:33 add_script_search_dir(): adding /Users/ilg/.config/openocd 1: Debug: 31 10 configuration.c:33 add_script_search_dir(): adding /Users/ilg/.openocd 1: Debug: 32 10 configuration.c:33 add_script_search_dir(): adding /Users/ilg/Library/xPacks/@xpack-dev-tools/openocd/0.12.0-3.1/.content/bin/../openocd/site 1: Debug: 33 10 configuration.c:33 add_script_search_dir(): adding /Users/ilg/Library/xPacks/@xpack-dev-tools/openocd/0.12.0-3.1/.content/bin/../openocd/scripts 1: Debug: 34 10 command.c:153 script_debug(): command - gdb_port disabled 1: Debug: 35 10 command.c:153 script_debug(): command - tcl_port disabled 1: Debug: 36 10 command.c:153 script_debug(): command - telnet_port disabled 1: Debug: 37 10 command.c:153 script_debug(): command - ocd_find interface/stlink-dap.cfg 1: Debug: 38 11 configuration.c:88 find_file(): found /Users/ilg/Library/xPacks/@xpack-dev-tools/openocd/0.12.0-3.1/.content/bin/../openocd/scripts/interface/stlink-dap.cfg 1: Debug: 39 11 command.c:153 script_debug(): command - adapter driver st-link 1: Debug: 40 11 command.c:153 script_debug(): command - st-link vid_pid 0x0483 0x3744 0x0483 0x3748 0x0483 0x374b 0x0483 0x374d 0x0483 0x374e 0x0483 0x374f 0x0483 0x3752 0x0483 0x3753 0x0483 0x3754 0x0483 0x3755 0x0483 0x3757 1: Debug: 41 12 command.c:153 script_debug(): command - ocd_find target/stm32h7x.cfg 1: Debug: 42 13 configuration.c:88 find_file(): found /Users/ilg/Library/xPacks/@xpack-dev-tools/openocd/0.12.0-3.1/.content/bin/../openocd/scripts/target/stm32h7x.cfg 1: Debug: 43 13 command.c:153 script_debug(): command - ocd_find target/swj-dp.tcl 1: Debug: 44 14 configuration.c:88 find_file(): found /Users/ilg/Library/xPacks/@xpack-dev-tools/openocd/0.12.0-3.1/.content/bin/../openocd/scripts/target/swj-dp.tcl 1: Debug: 45 14 command.c:153 script_debug(): command - transport select 1: Info : 46 14 transport.c:268 handle_transport_select(): auto-selecting first available session transport "dapdirect_swd". To override use 'transport select <transport>'. 1: Debug: 47 14 adi_v5_dapdirect.c:187 dapdirect_swd_select(): dapdirect_swd_select() 1: Debug: 48 14 command.c:153 script_debug(): command - ocd_find mem_helper.tcl 1: Debug: 49 14 configuration.c:88 find_file(): found /Users/ilg/Library/xPacks/@xpack-dev-tools/openocd/0.12.0-3.1/.content/bin/../openocd/scripts/mem_helper.tcl 1: Debug: 50 14 command.c:153 script_debug(): command - add_usage_text mrw address 1: Debug: 51 14 command.c:153 script_debug(): command - add_help_text mrw Returns value of word in memory. 1: Debug: 52 15 command.c:153 script_debug(): command - add_usage_text mrh address 1: Debug: 53 15 command.c:153 script_debug(): command - add_help_text mrh Returns value of halfword in memory. 1: Debug: 54 15 command.c:153 script_debug(): command - add_usage_text mrb address 1: Debug: 55 15 command.c:153 script_debug(): command - add_help_text mrb Returns value of byte in memory. 1: Debug: 56 15 command.c:153 script_debug(): command - add_usage_text mmw address setbits clearbits 1: Debug: 57 15 command.c:153 script_debug(): command - add_help_text mmw Modify word in memory. new_val = (old_val & ~clearbits) | setbits; 1: Debug: 58 15 command.c:153 script_debug(): command - transport select 1: Debug: 59 15 command.c:153 script_debug(): command - transport select 1: Debug: 60 15 command.c:153 script_debug(): command - transport select 1: Debug: 61 15 command.c:153 script_debug(): command - swd newdap stm32h7x cpu -irlen 4 -ircapture 0x1 -irmask 0xf -expected-id 0x6ba02477 1: Debug: 62 15 tcl.c:402 handle_jtag_newtap_args(): Creating New Tap, Chip: stm32h7x, Tap: cpu, Dotted: stm32h7x.cpu, 8 params 1: Debug: 63 15 core.c:1478 jtag_tap_init(): Created Tap: stm32h7x.cpu @ abs position 0, irlen 4, capture: 0x1 mask: 0xf 1: Debug: 64 15 command.c:153 script_debug(): command - dap create stm32h7x.dap -chain-position stm32h7x.cpu 1: Debug: 65 15 command.c:153 script_debug(): command - transport select 1: Debug: 66 15 command.c:153 script_debug(): command - transport select 1: Debug: 67 15 command.c:153 script_debug(): command - target create stm32h7x.ap2 mem_ap -dap stm32h7x.dap -ap-num 2 1: Debug: 68 15 command.c:153 script_debug(): command - swo create stm32h7x.swo -dap stm32h7x.dap -ap-num 2 -baseaddr 0xE00E3000 1: Debug: 69 15 command.c:153 script_debug(): command - tpiu create stm32h7x.tpiu -dap stm32h7x.dap -ap-num 2 -baseaddr 0xE00F5000 1: Debug: 70 16 command.c:153 script_debug(): command - target create stm32h7x.cpu0 cortex_m -endian little -dap stm32h7x.dap -ap-num 0 1: Debug: 71 16 command.c:259 register_command(): command 'tpiu' is already registered 1: Debug: 72 16 command.c:259 register_command(): command 'rtt' is already registered 1: Debug: 73 16 command.c:153 script_debug(): command - stm32h7x.cpu0 configure -work-area-phys 0x20000000 -work-area-size 0x10000 -work-area-backup 0 1: Debug: 74 16 target.c:2130 target_free_all_working_areas_restore(): freeing all working areas 1: Debug: 75 16 target.c:2130 target_free_all_working_areas_restore(): freeing all working areas 1: Debug: 76 16 target.c:2130 target_free_all_working_areas_restore(): freeing all working areas 1: Debug: 77 16 command.c:153 script_debug(): command - flash bank stm32h7x.bank1.cpu0 stm32h7x 0x08000000 0 0 0 stm32h7x.cpu0 1: Debug: 78 17 tcl.c:1307 handle_flash_bank_command(): 'stm32h7x' driver usage field missing 1: Debug: 79 17 command.c:153 script_debug(): command - targets stm32h7x.cpu0 1: Debug: 80 17 command.c:153 script_debug(): command - adapter speed 1800 1: Debug: 81 17 adapter.c:250 adapter_config_khz(): handle adapter khz 1: Debug: 82 17 adapter.c:214 adapter_khz_to_speed(): convert khz to adapter specific speed value 1: Debug: 83 17 adapter.c:214 adapter_khz_to_speed(): convert khz to adapter specific speed value 1: Debug: 84 17 command.c:153 script_debug(): command - adapter srst delay 100 1: Debug: 85 17 command.c:153 script_debug(): command - transport select 1: Debug: 86 17 command.c:153 script_debug(): command - reset_config srst_nogate 1: Debug: 87 17 command.c:153 script_debug(): command - transport select 1: Debug: 88 17 command.c:153 script_debug(): command - stm32h7x.cpu0 cortex_m reset_config sysresetreq 1: Debug: 89 17 command.c:153 script_debug(): command - stm32h7x.dap apcsw 0x08000000 0x08000000 1: Debug: 90 17 arm_adi_v5.c:1202 dap_get_config_ap(): refcount AP#0x0 get_config 1 1: Debug: 91 17 arm_adi_v5.c:1217 dap_put_ap(): refcount AP#0x0 put 0 1: Debug: 92 17 command.c:153 script_debug(): command - stm32h7x.cpu0 configure -event examine-end 1: # Enable D3 and D1 DBG clocks 1: # DBGMCU_CR |= D3DBGCKEN | D1DBGCKEN 1: stm32h7x_dbgmcu_mmw 0x004 0x00600000 0 1: 1: # Enable debug during low power modes (uses more power) 1: # DBGMCU_CR |= DBG_STANDBY | DBG_STOP | DBG_SLEEP D1 Domain 1: stm32h7x_dbgmcu_mmw 0x004 0x00000007 0 1: # DBGMCU_CR |= DBG_STANDBY | DBG_STOP | DBG_SLEEP D2 Domain 1: stm32h7x_dbgmcu_mmw 0x004 0x00000038 0 1: 1: # Stop watchdog counters during halt 1: # DBGMCU_APB3FZ1 |= WWDG1 1: stm32h7x_dbgmcu_mmw 0x034 0x00000040 0 1: # DBGMCU_APB1LFZ1 |= WWDG2 1: stm32h7x_dbgmcu_mmw 0x03C 0x00000800 0 1: # DBGMCU_APB4FZ1 |= WDGLSD1 | WDGLSD2 1: stm32h7x_dbgmcu_mmw 0x054 0x000C0000 0 1: 1: # Enable clock for tracing 1: # DBGMCU_CR |= TRACECLKEN 1: stm32h7x_dbgmcu_mmw 0x004 0x00100000 0 1: 1: # RM0399 (id 0x450) M7+M4 with SWO Funnel 1: # RM0433 (id 0x450) M7 with SWO Funnel 1: # RM0455 (id 0x480) M7 without SWO Funnel 1: # RM0468 (id 0x483) M7 without SWO Funnel 1: # Enable CM7 and CM4 slave ports in SWO trace Funnel 1: # Works ok also on devices single core and without SWO funnel 1: # Hack, use stm32h7x_dbgmcu_mmw with big offset to control SWTF 1: # SWTF_CTRL |= ENS0 | ENS1 1: stm32h7x_dbgmcu_mmw 0x3000 0x00000003 0 1: 1: Debug: 93 18 command.c:153 script_debug(): command - stm32h7x.cpu0 configure -event reset-init 1: # Clock after reset is HSI at 64 MHz, no need of PLL 1: adapter speed 4000 1: 1: Debug: 94 18 command.c:153 script_debug(): command - init 1: Debug: 95 18 command.c:153 script_debug(): command - target init 1: Debug: 96 18 command.c:153 script_debug(): command - target names 1: Debug: 97 18 command.c:153 script_debug(): command - stm32h7x.ap2 cget -event gdb-flash-erase-start 1: Debug: 98 18 command.c:153 script_debug(): command - stm32h7x.ap2 configure -event gdb-flash-erase-start reset init 1: Debug: 99 18 command.c:153 script_debug(): command - stm32h7x.ap2 cget -event gdb-flash-write-end 1: Debug: 100 18 command.c:153 script_debug(): command - stm32h7x.ap2 configure -event gdb-flash-write-end reset halt 1: Debug: 101 18 command.c:153 script_debug(): command - stm32h7x.ap2 cget -event gdb-attach 1: Debug: 102 18 command.c:153 script_debug(): command - stm32h7x.ap2 configure -event gdb-attach halt 1000 1: Debug: 103 18 command.c:153 script_debug(): command - stm32h7x.cpu0 cget -event gdb-flash-erase-start 1: Debug: 104 18 command.c:153 script_debug(): command - stm32h7x.cpu0 configure -event gdb-flash-erase-start reset init 1: Debug: 105 18 command.c:153 script_debug(): command - stm32h7x.cpu0 cget -event gdb-flash-write-end 1: Debug: 106 18 command.c:153 script_debug(): command - stm32h7x.cpu0 configure -event gdb-flash-write-end reset halt 1: Debug: 107 18 command.c:153 script_debug(): command - stm32h7x.cpu0 cget -event gdb-attach 1: Debug: 108 18 command.c:153 script_debug(): command - stm32h7x.cpu0 configure -event gdb-attach halt 1000 1: Debug: 109 18 target.c:1588 handle_target_init_command(): Initializing targets... 1: Debug: 110 18 mem_ap.c:61 mem_ap_init_target(): mem_ap_init_target 1: Debug: 111 18 semihosting_common.c:107 semihosting_common_init(): 1: Debug: 112 18 stlink_usb.c:5120 stlink_dap_init(): stlink_dap_init() 1: Debug: 113 18 stlink_usb.c:3732 stlink_open(): stlink_open 1: Debug: 114 18 stlink_usb.c:3746 stlink_open(): transport: 4 vid: 0x0483 pid: 0x3744 serial: 1: Debug: 115 18 stlink_usb.c:3746 stlink_open(): transport: 4 vid: 0x0483 pid: 0x3748 serial: 1: Debug: 116 18 stlink_usb.c:3746 stlink_open(): transport: 4 vid: 0x0483 pid: 0x374b serial: 1: Debug: 117 18 stlink_usb.c:3746 stlink_open(): transport: 4 vid: 0x0483 pid: 0x374d serial: 1: Debug: 118 18 stlink_usb.c:3746 stlink_open(): transport: 4 vid: 0x0483 pid: 0x374e serial: 1: Debug: 119 18 stlink_usb.c:3746 stlink_open(): transport: 4 vid: 0x0483 pid: 0x374f serial: 1: Debug: 120 18 stlink_usb.c:3746 stlink_open(): transport: 4 vid: 0x0483 pid: 0x3752 serial: 1: Debug: 121 18 stlink_usb.c:3746 stlink_open(): transport: 4 vid: 0x0483 pid: 0x3753 serial: 1: Debug: 122 18 stlink_usb.c:3746 stlink_open(): transport: 4 vid: 0x0483 pid: 0x3754 serial: 1: Debug: 123 18 stlink_usb.c:3746 stlink_open(): transport: 4 vid: 0x0483 pid: 0x3755 serial: 1: Debug: 124 18 stlink_usb.c:3746 stlink_open(): transport: 4 vid: 0x0483 pid: 0x3757 serial: 1: Debug: 125 44 stlink_usb.c:686 jtag_libusb_bulk_transfer_n(): ERROR, failed to submit transfer 0, error -5 1: Debug: 126 1362 stlink_usb.c:686 jtag_libusb_bulk_transfer_n(): ERROR, failed to submit transfer 0, error -5 1: Error: 127 1362 stlink_usb.c:3470 stlink_usb_usb_open(): read version failed 1: Debug: 128 1362 stlink_usb.c:686 jtag_libusb_bulk_transfer_n(): ERROR, failed to submit transfer 0, error -5 1: Debug: 129 1365 command.c:529 exec_command(): Command 'init' failed with error code -4 1: Debug: 130 1365 command.c:153 script_debug(): command - echo ** OpenOCD init failed ** 1: Debug: 131 1365 log.c:412 gdb_timeout_warning(): keep_alive() was not invoked in the 1000 ms timelimit (1365 ms). This may cause trouble with GDB connections. 1: User : 132 1365 command.c:678 handle_echo(): ** OpenOCD init failed ** 1: Debug: 133 1365 command.c:153 script_debug(): command - shutdown error 1: User : 134 1365 server.c:760 handle_shutdown_command(): shutdown command invoked 1: Debug: 135 1365 command.c:529 exec_command(): Command 'shutdown' failed with error code -4 1: User : 136 1365 command.c:601 command_run_line(): 1: Debug: 137 1366 breakpoints.c:328 breakpoint_remove_all_internal(): [stm32h7x.ap2] Delete all breakpoints 1: Debug: 138 1366 mem_ap.c:71 mem_ap_deinit_target(): mem_ap_deinit_target 1: Debug: 139 1366 target.c:2130 target_free_all_working_areas_restore(): freeing all working areas 1: Debug: 140 1366 breakpoints.c:328 breakpoint_remove_all_internal(): [stm32h7x.cpu0] Delete all breakpoints 1: Debug: 141 1366 target.c:2130 target_free_all_working_areas_restore(): freeing all working areas 1/3 Test #1: rtos-apis-test ...................***Failed 1.41 sec ``` |