On Wed, Aug 25, 2010 at 8:38 AM, Laurent Gauch
<laurent.ga...@amontec.com> wrote:
>>
>> Hello David,
>> I am not so sure about this. Still smells like reset problem to me.
>>
>> It should be noted that when I let small bootloader execute from the
>> SPI flash and do the reset (and some other config), I can attach  with
>> OpenOCD, i.e. chain is well scanned. I was able after attachment to
>> set-up SDRAM and launch eCos application (which would further
>> configure SoC). Now I erased the flash and tried without bootloader. I
>> do not exactly know what bootloader is doing (have not insight in the
>> code yet), but obviously nothing expect reset is needed for a proper
>> chain scanning.
>>
>> It should be also noted that Lauterbach jtag attaches without any
>> problems. I do not think that it does anything special for this step.
>> All what is needed after is few lines of SDRAM set-up and application
>> can be uploaded and run. But that comes after attachment (as for
>> OpenOCD).
>>
>> All this confirms that hardware is working properly. I am almost
>> convinced that bug is either on OpenOCD side (I tried with both ftd
>> libs) or I should configure reset in some special way...
>>
>> Would anybody have some hints after these additional explanations ?
>>
>> Best regards,
>> Drasko
>>
>
> It is not coming from your JTAGkey-2 since you can scan and detect the chain
> after configuration of your system.
>
> It is really somewhere in the OpenOCD .

I am almost sure. As I mentioned, Lautebach works fine. So is Amontec
JTAG2 when bootloder passed before (probably doing reset correctly).

>
> But you could try to disable the use of RTCK feature from the Amontec
> JTAGkey-2 and run at a super low frequency before doing your scan chain
> detection.

How to do this ? In configuration file ?


> Also, could you please try to disconnect the JTAGkey from USB port before
> doing this. OpenOCD is still not really clean regarding the finish using the
> Amontec JTAGey as other FT2232 USB JTAG dongle before closing its handle in
> mpsse mode.

I noted this before. When reset (USB disconnected and re-connected)
Amontec Jtag2 have only 2 green leds on.
After running one session of OpenOCD all leds stay on (mentioned two
gree + one yellow + one red).

> Let us know the debug output in this case.

OK, here is my procedure :

1) Disconnect/re-connect Amontec JtagKey2. Only two green leds are on.
2) Commented out #jtag_rclk 1 line in config. Now config has only 3 lines :

source [find ../tcl/interface/jtagkey2.cfg]
adapter_khz 1
scan_chain

That's all. I do not think that we can get slower than 1KHz
(adapter_khz 1). If yes, please tell me how.

3) launched openocd. It keeps getting all zeros :


r...@konj:~/openocd/openocd/src# ./openocd -f my_openocd.cfg
Open On-Chip Debugger 0.5.0-dev-00494-g5c98e06-dirty (2010-08-24-20:22)
Licensed under GNU GPL v2
For bug reports, read
        http://openocd.berlios.de/doc/doxygen/bugs.html
Info : only one transport option; autoselect 'jtag'
1 kHz
   TapName             Enabled  IdCode     Expected   IrLen IrCap IrMask
-- ------------------- -------- ---------- ---------- ----- ----- ------
Info : max TCK change to: 30000 kHz
Info : clock speed 1 kHz
Warn : There are no enabled taps.  AUTO PROBING MIGHT NOT WORK!!
Info : inter: 0.000079, inter2: 0.000079 end: 0.653373
Warn : AUTO auto0.tap - use "jtag newtap auto0 tap -expected-id 0x01273043 ..."
Warn : AUTO auto1.tap - use "jtag newtap auto1 tap -expected-id 0x01273043 ..."
Warn : AUTO auto2.tap - use "jtag newtap auto2 tap -expected-id 0x01273043 ..."
Warn : AUTO auto3.tap - use "jtag newtap auto3 tap -expected-id 0x01273043 ..."
Warn : AUTO auto4.tap - use "jtag newtap auto4 tap -expected-id 0x01273043 ..."
Warn : AUTO auto5.tap - use "jtag newtap auto5 tap -expected-id 0x00000000 ..."
Warn : AUTO auto6.tap - use "jtag newtap auto6 tap -expected-id 0x00000000 ..."
Warn : AUTO auto7.tap - use "jtag newtap auto7 tap -expected-id 0x00000000 ..."
Warn : AUTO auto8.tap - use "jtag newtap auto8 tap -expected-id 0x00000000 ..."
Warn : AUTO auto9.tap - use "jtag newtap auto9 tap -expected-id 0x00000000 ..."
Warn : AUTO auto10.tap - use "jtag newtap auto10 tap -expected-id
0x00000000 ..."
Warn : AUTO auto11.tap - use "jtag newtap auto11 tap -expected-id
0x00000000 ..."
Warn : AUTO auto12.tap - use "jtag newtap auto12 tap -expected-id
0x00000000 ..."
Warn : AUTO auto13.tap - use "jtag newtap auto13 tap -expected-id
0x00000000 ..."

...

Warn : AUTO auto450.tap - use "jtag newtap auto450 tap -expected-id
0x00000000 ..."
Warn : AUTO auto451.tap - use "jtag newtap auto451 tap -expected-id
0x00000000 ..."
Warn : AUTO auto452.tap - use "jtag newtap auto452 tap -expected-id
0x00000000 ..."
Warn : AUTO auto453.tap - use "jtag newtap auto453 tap -expected-id
0x00000000 ..."
Error: couldn't read enough bytes from FT2232 device (664 < 3407)
Error: couldn't read from FT2232
Error: couldn't read enough bytes from FT2232 device (667 < 3407)
Error: couldn't read from FT2232
Info : inter: 0.000156, inter2: 0.000157 end: 0.645141
Error: JTAG scan chain interrogation failed: all zeroes
Error: Check JTAG interface, timings, target power, etc.
Command handler execution failed
in procedure 'transport'
Command handler execution failed
in procedure 'init'


4) Here is debug version :

Open On-Chip Debugger 0.5.0-dev-00494-g5c98e06-dirty (2010-08-24-20:22)
Licensed under GNU GPL v2
For bug reports, read
        http://openocd.berlios.de/doc/doxygen/bugs.html
User : 11 1 command.c:543 command_print() 71184: debug_level: 3
Debug: 12 1 configuration.c:45 add_script_search_dir() 72424: adding
/home/ddraskovic/.openocd
Debug: 13 1 configuration.c:45 add_script_search_dir() 72408: adding
/usr/local/share/openocd/site
Debug: 14 1 configuration.c:45 add_script_search_dir() 72360: adding
/usr/local/share/openocd/scripts
Debug: 15 1 configuration.c:87 find_file() 69944: found my_openocd.cfg
Debug: 16 1 configuration.c:87 find_file() 67920: found
../tcl/interface/jtagkey2.cfg
Debug: 17 1 command.c:133 script_debug() 63432: command - ocd_command
ocd_command type ocd_interface ft2232
Debug: 18 1 command.c:133 script_debug() 63512: command - interface
ocd_interface ft2232
Debug: 20 1 command.c:350 register_command_handler() 63280:
registering 'ocd_ft2232_device_desc'...
Debug: 21 1 command.c:350 register_command_handler() 62600:
registering 'ocd_ft2232_serial'...
Debug: 22 1 command.c:350 register_command_handler() 62032:
registering 'ocd_ft2232_layout'...
Debug: 23 1 command.c:350 register_command_handler() 61488:
registering 'ocd_ft2232_vid_pid'...
Debug: 24 1 command.c:350 register_command_handler() 60976:
registering 'ocd_ft2232_latency'...
Info : 25 1 transport.c:123 allow_transports() 60616: only one
transport option; autoselect 'jtag'
Debug: 26 1 command.c:350 register_command_handler() 60256:
registering 'ocd_jtag_flush_queue_sleep'...
Debug: 27 1 command.c:350 register_command_handler() 59624:
registering 'ocd_jtag_rclk'...
Debug: 28 1 command.c:350 register_command_handler() 59112:
registering 'ocd_jtag_ntrst_delay'...
Debug: 29 1 command.c:350 register_command_handler() 58568:
registering 'ocd_jtag_ntrst_assert_width'...
Debug: 30 1 command.c:350 register_command_handler() 58088:
registering 'ocd_scan_chain'...
Debug: 31 1 command.c:350 register_command_handler() 57560:
registering 'ocd_jtag_reset'...
Debug: 32 1 command.c:350 register_command_handler() 57056:
registering 'ocd_runtest'...
Debug: 33 2 command.c:350 register_command_handler() 56456:
registering 'ocd_irscan'...
Debug: 34 2 command.c:350 register_command_handler() 55880:
registering 'ocd_verify_ircapture'...
Debug: 35 2 command.c:350 register_command_handler() 55312:
registering 'ocd_verify_jtag'...
Debug: 36 2 command.c:350 register_command_handler() 54712:
registering 'ocd_tms_sequence'...
Debug: 37 2 command.c:350 register_command_handler() 54168:
registering 'ocd_jtag'...
Debug: 38 2 command.c:350 register_command_handler() 53648:
registering 'ocd_jtag'...
Debug: 39 2 command.c:350 register_command_handler() 53344:
registering 'ocd_jtag'...
Debug: 40 2 command.c:350 register_command_handler() 53032:
registering 'ocd_jtag'...
Debug: 41 2 command.c:350 register_command_handler() 52856:
registering 'ocd_jtag'...
Debug: 42 2 command.c:350 register_command_handler() 52704:
registering 'ocd_jtag'...
Debug: 43 2 command.c:350 register_command_handler() 52552:
registering 'ocd_jtag'...
Debug: 44 2 command.c:350 register_command_handler() 52376:
registering 'ocd_jtag'...
Debug: 45 2 command.c:350 register_command_handler() 52216:
registering 'ocd_jtag'...
Debug: 46 2 command.c:350 register_command_handler() 52112:
registering 'ocd_jtag'...
Debug: 47 2 command.c:350 register_command_handler() 51904:
registering 'ocd_jtag'...
Debug: 48 2 command.c:350 register_command_handler() 51768:
registering 'ocd_jtag'...
Debug: 49 2 command.c:350 register_command_handler() 51552:
registering 'ocd_jtag'...
Debug: 50 2 command.c:350 register_command_handler() 50656:
registering 'ocd_svf'...
Debug: 51 2 command.c:350 register_command_handler() 50112:
registering 'ocd_xsvf'...
Debug: 52 2 command.c:133 script_debug() 49184: command - ocd_command
ocd_command type ocd_ft2232_device_desc Amontec JTAGkey-2
Debug: 53 2 command.c:133 script_debug() 49232: command -
ft2232_device_desc ocd_ft2232_device_desc Amontec JTAGkey-2
Debug: 55 2 command.c:133 script_debug() 48576: command - ocd_command
ocd_command type ocd_ft2232_layout jtagkey
Debug: 56 2 command.c:133 script_debug() 48664: command -
ft2232_layout ocd_ft2232_layout jtagkey
Debug: 58 2 command.c:133 script_debug() 47616: command - ocd_command
ocd_command type ocd_ft2232_vid_pid 0x0403 0xCFF8
Debug: 59 2 command.c:133 script_debug() 47688: command -
ft2232_vid_pid ocd_ft2232_vid_pid 0x0403 0xCFF8
Debug: 61 2 configuration.c:87 find_file() 50584: found ./my3010.cfg
Debug: 62 2 command.c:133 script_debug() 47816: command - ocd_command
ocd_command type ocd_adapter_khz 1
Debug: 63 2 command.c:133 script_debug() 47928: command - adapter_khz
ocd_adapter_khz 1
Debug: 65 2 core.c:1628 jtag_config_khz() 47912: handle jtag khz
Debug: 66 2 core.c:1591 adapter_khz_to_speed() 47880: convert khz to
interface specific speed value
User : 67 2 command.c:543 command_print() 47904: 1 kHz
Debug: 68 2 command.c:133 script_debug() 47664: command - ocd_command
ocd_command type ocd_scan_chain
Debug: 69 2 command.c:133 script_debug() 47776: command - scan_chain
ocd_scan_chain
User : 71 2 command.c:543 command_print() 47640:    TapName
 Enabled  IdCode     Expected   IrLen IrCap IrMask
User : 72 2 command.c:543 command_print() 47488: --
------------------- -------- ---------- ---------- ----- ----- ------
Debug: 73 2 httpd_stubs.c:28 httpd_start() 52304: libocdserver was
built without HTTPD support
Debug: 74 2 command.c:133 script_debug() 50704: command - ocd_command
ocd_command type ocd_init
Debug: 75 2 command.c:133 script_debug() 50848: command - init ocd_init
Debug: 77 2 command.c:133 script_debug() 48696: command - ocd_command
ocd_command type ocd_target init
Debug: 78 2 command.c:133 script_debug() 48760: command - ocd_target
ocd_target init
Debug: 80 2 target.c:888 handle_target_init_command() 48728:
Initializing targets...
Debug: 81 2 ft2232.c:2336 ft2232_init() 49984: ft2232 interface using
shortest path jtag state transitions
Debug: 82 2 ft2232.c:2249 ft2232_init_libftdi() 49984: 'ft2232'
interface using libftdi with 'jtagkey' layout (0403:cff8)
Debug: 83 285 ft2232.c:2296 ft2232_init_libftdi() 92200: current
latency timer: 2
Debug: 84 286 ft2232.c:2307 ft2232_init_libftdi() 92200: FTDI chip
type: 4 "2232H"
Debug: 85 286 ft2232.c:2701 jtagkey_init() 92216: 80 08 1b
Debug: 86 286 ft2232.c:2760 jtagkey_init() 92216: 82 09 0f
Info : 87 286 ft2232.c:622 ft2232h_ft4232h_clk_divide_by_5() 92192:
max TCK change to: 30000 kHz
Debug: 88 286 core.c:1591 adapter_khz_to_speed() 92128: convert khz to
interface specific speed value
Debug: 89 286 core.c:1595 adapter_khz_to_speed() 92152: have interface set up
Debug: 90 286 ft2232.c:590 ft2232h_ft4232h_adaptive_clocking() 92168: 97
Debug: 91 286 ft2232.c:651 ft2232_speed() 92168: 86 2f 75
Debug: 92 287 core.c:1591 adapter_khz_to_speed() 92128: convert khz to
interface specific speed value
Debug: 93 287 core.c:1595 adapter_khz_to_speed() 92152: have interface set up
Info : 94 287 core.c:1418 adapter_init() 92160: clock speed 1 kHz
Debug: 95 287 openocd.c:124 handle_init_command() 92144: Debug Adapter
init complete
Debug: 96 287 command.c:133 script_debug() 90192: command -
ocd_command ocd_command type ocd_transport init
Debug: 97 287 command.c:133 script_debug() 90256: command -
ocd_transport ocd_transport init
Debug: 99 287 transport.c:253 handle_transport_init() 90256:
handle_transport_init
Debug: 100 287 ft2232.c:1937 ft2232_execute_reset() 90240: reset trst: 0 srst 0
Debug: 101 287 ft2232.c:1455 jtagkey_reset() 90208: trst: 0, srst: 0,
high_output: 0x09, high_direction: 0x0f
Debug: 102 287 ft2232.c:1958 ft2232_execute_reset() 90248: trst: 0, srst: 0
Debug: 103 287 ft2232.c:790 ft2232_send_and_recv() 90240: write buffer (size 3):
Debug: 104 287 ft2232.c:771 ft2232_debug_dump_buffer() 90256: 82 09 0f
Debug: 105 287 core.c:714 jtag_add_reset() 90264: SRST line released
Debug: 106 287 core.c:738 jtag_add_reset() 90264: TRST line released
Debug: 107 287 core.c:330 jtag_call_event_callbacks() 90256: jtag
event: TAP reset
Debug: 108 287 command.c:133 script_debug() 85632: command -
ocd_command ocd_command type ocd_jtag arp_init
Debug: 109 287 command.c:133 script_debug() 84976: command - ocd_jtag
ocd_jtag arp_init
Debug: 110 287 core.c:1432 jtag_init_inner() 85048: Init JTAG chain
Warn : 111 287 core.c:1448 jtag_init_inner() 85008: There are no
enabled taps.  AUTO PROBING MIGHT NOT WORK!!
Debug: 112 287 core.c:330 jtag_call_event_callbacks() 84744: jtag
event: TAP reset
Debug: 113 287 ft2232.c:1749 ft2232_execute_statemove() 84744:
statemove end in RESET
Debug: 114 287 ft2232.c:419 clock_tms() 84712: mpsse cmd=4b, tms_bits
= 0x000000ff, bit_count=5
Debug: 115 287 ft2232.c:429 clock_tms() 84744: tap_set_state(RESET)
Debug: 116 287 ft2232.c:429 clock_tms() 84744: tap_set_state(RESET)
Debug: 117 287 ft2232.c:429 clock_tms() 84744: tap_set_state(RESET)
Debug: 118 287 ft2232.c:429 clock_tms() 84744: tap_set_state(RESET)
Debug: 119 287 ft2232.c:429 clock_tms() 84744: tap_set_state(RESET)
Debug: 120 287 ft2232.c:790 ft2232_send_and_recv() 84744: write buffer (size 3):
Debug: 121 287 ft2232.c:771 ft2232_debug_dump_buffer() 84752: 4b 04 1f
Debug: 122 288 core.c:1049 jtag_examine_chain() 84744: DR scan
interrogation for IDCODE/BYPASS
Debug: 123 288 core.c:330 jtag_call_event_callbacks() 84744: jtag
event: TAP reset
Debug: 124 288 ft2232.c:1884 ft2232_execute_scan() 84752: DRSCAN type:3
Debug: 125 288 commands.c:189 jtag_build_buffer() 84656: DRSCAN num_fields: 1
Debug: 126 288 commands.c:202 jtag_build_buffer() 84600:
fields[0].out_value[640]: 0x000000FF000000FF
Debug: 127 288 ft2232.c:480 move_to_state() 84656: start=RESET goal=DRSHIFT
Debug: 128 288 ft2232.c:419 clock_tms() 84624: mpsse cmd=4b, tms_bits
= 0x00000017, bit_count=7
Debug: 129 288 ft2232.c:429 clock_tms() 84656: tap_set_state(RESET)
Debug: 130 288 ft2232.c:429 clock_tms() 84656: tap_set_state(RESET)
Debug: 131 288 ft2232.c:429 clock_tms() 84656: tap_set_state(RESET)
Debug: 132 288 ft2232.c:429 clock_tms() 84656: tap_set_state(RUN/IDLE)
Debug: 133 288 ft2232.c:429 clock_tms() 84656: tap_set_state(DRSELECT)
Debug: 134 288 ft2232.c:429 clock_tms() 84656: tap_set_state(DRCAPTURE)
Debug: 135 288 ft2232.c:429 clock_tms() 84656: tap_set_state(DRSHIFT)
Debug: 136 288 ft2232.c:1103 ft2232_add_scan() 84664: finish via PAUSE
Debug: 137 288 ft2232.c:419 clock_tms() 84624: mpsse cmd=6b, tms_bits
= 0x00000001, bit_count=2
Debug: 138 288 ft2232.c:429 clock_tms() 84656: tap_set_state(DREXIT1)
Debug: 139 288 ft2232.c:429 clock_tms() 84656: tap_set_state(DRPAUSE)
Debug: 140 288 ft2232.c:1925 ft2232_execute_scan() 84736: DR scan, 640
bits, end in DRPAUSE
Debug: 141 288 ft2232.c:1749 ft2232_execute_statemove() 84744:
statemove end in RESET
Debug: 142 288 ft2232.c:419 clock_tms() 84720: mpsse cmd=4b, tms_bits
= 0x000000ff, bit_count=5
Debug: 143 288 ft2232.c:429 clock_tms() 84744: tap_set_state(DREXIT2)
Debug: 144 288 ft2232.c:429 clock_tms() 84744: tap_set_state(DRUPDATE)
Debug: 145 288 ft2232.c:429 clock_tms() 84744: tap_set_state(DRSELECT)
Debug: 146 288 ft2232.c:429 clock_tms() 84744: tap_set_state(IRSELECT)
Debug: 147 288 ft2232.c:429 clock_tms() 84744: tap_set_state(RESET)
Debug: 148 288 ft2232.c:790 ft2232_send_and_recv() 84744: write buffer
(size 94):
Debug: 149 288 ft2232.c:765 ft2232_debug_dump_buffer() 84720: 4b 06 17
39 4e 00 ff 00 00 00 ff 00 00 00 ff 00
Debug: 150 288 ft2232.c:765 ft2232_debug_dump_buffer() 84720: 00 00 ff
00 00 00 ff 00 00 00 ff 00 00 00 ff 00
Debug: 151 288 ft2232.c:765 ft2232_debug_dump_buffer() 84720: 00 00 ff
00 00 00 ff 00 00 00 ff 00 00 00 ff 00
Debug: 152 288 ft2232.c:765 ft2232_debug_dump_buffer() 84720: 00 00 ff
00 00 00 ff 00 00 00 ff 00 00 00 ff 00
Debug: 153 288 ft2232.c:765 ft2232_debug_dump_buffer() 84720: 00 00 ff
00 00 00 ff 00 00 00 ff 00 00 00 ff 00
Debug: 154 288 ft2232.c:771 ft2232_debug_dump_buffer() 84728: 00 00 ff
00 00 3b 06 00 6b 01 01 4b 04 1f
Info : 155 942 ft2232.c:834 ft2232_send_and_recv() 84720: inter:
0.000056, inter2: 0.000057 end: 0.654478
Debug: 156 942 ft2232.c:855 ft2232_send_and_recv() 84736: read buffer
(0 retries): 81 bytes
Debug: 157 942 ft2232.c:765 ft2232_debug_dump_buffer() 84720: 43 30 27
01 43 30 27 01 43 30 27 01 43 30 27 01
Debug: 158 942 ft2232.c:765 ft2232_debug_dump_buffer() 84720: 43 30 27
01 00 00 00 00 00 00 00 00 00 00 00 00
Debug: 159 942 ft2232.c:765 ft2232_debug_dump_buffer() 84720: 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00
Debug: 160 942 ft2232.c:765 ft2232_debug_dump_buffer() 84720: 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00
Debug: 161 942 ft2232.c:765 ft2232_debug_dump_buffer() 84720: 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00
Debug: 162 942 ft2232.c:771 ft2232_debug_dump_buffer() 84760: 00
Debug: 163 942 commands.c:248 jtag_read_buffer() 84520:
fields[0].in_value[640]: 0x0127304301273043
Warn : 164 942 core.c:1150 jtag_examine_chain() 84552: AUTO auto0.tap
- use "jtag newtap auto0 tap -expected-id 0x01273043 ..."
Debug: 165 942 core.c:1349 jtag_tap_init() 84000: Created Tap:
auto0.tap @ abs position 0, irlen 0, capture: 0x1 mask: 0x3
Warn : 166 942 core.c:1150 jtag_examine_chain() 83856: AUTO auto1.tap
- use "jtag newtap auto1 tap -expected-id 0x01273043 ..."
Debug: 167 942 core.c:1349 jtag_tap_init() 83792: Created Tap:
auto1.tap @ abs position 0, irlen 0, capture: 0x1 mask: 0x3
Warn : 168 942 core.c:1150 jtag_examine_chain() 83648: AUTO auto2.tap
- use "jtag newtap auto2 tap -expected-id 0x01273043 ..."
Debug: 169 942 core.c:1349 jtag_tap_init() 83584: Created Tap:
auto2.tap @ abs position 0, irlen 0, capture: 0x1 mask: 0x3
Warn : 170 942 core.c:1150 jtag_examine_chain() 83440: AUTO auto3.tap
- use "jtag newtap auto3 tap -expected-id 0x01273043 ..."
Debug: 171 942 core.c:1349 jtag_tap_init() 82928: Created Tap:
auto3.tap @ abs position 0, irlen 0, capture: 0x1 mask: 0x3
Warn : 172 942 core.c:1150 jtag_examine_chain() 82784: AUTO auto4.tap
- use "jtag newtap auto4 tap -expected-id 0x01273043 ..."
Debug: 173 942 core.c:1349 jtag_tap_init() 82136: Created Tap:
auto4.tap @ abs position 0, irlen 0, capture: 0x1 mask: 0x3
Warn : 174 942 core.c:1150 jtag_examine_chain() 82008: AUTO auto5.tap
- use "jtag newtap auto5 tap -expected-id 0x00000000 ..."
Debug: 175 942 core.c:1349 jtag_tap_init() 81944: Created Tap:
auto5.tap @ abs position 0, irlen 0, capture: 0x1 mask: 0x3
Warn : 176 942 core.c:1150 jtag_examine_chain() 81816: AUTO auto6.tap
- use "jtag newtap auto6 tap -expected-id 0x00000000 ..."
Debug: 177 942 core.c:1349 jtag_tap_init() 81752: Created Tap:
auto6.tap @ abs position 0, irlen 0, capture: 0x1 mask: 0x3
Warn : 178 942 core.c:1150 jtag_examine_chain() 81624: AUTO auto7.tap
- use "jtag newtap auto7 tap -expected-id 0x00000000 ..."
Debug: 179 942 core.c:1349 jtag_tap_init() 81560: Created Tap:
auto7.tap @ abs position 0, irlen 0, capture: 0x1 mask: 0x3
Warn : 180 942 core.c:1150 jtag_examine_chain() 81432: AUTO auto8.tap
- use "jtag newtap auto8 tap -expected-id 0x00000000 ..."
Debug: 181 943 core.c:1349 jtag_tap_init() 81368: Created Tap:
auto8.tap @ abs position 0, irlen 0, capture: 0x1 mask: 0x3
Warn : 182 943 core.c:1150 jtag_examine_chain() 81240: AUTO auto9.tap
- use "jtag newtap auto9 tap -expected-id 0x00000000 ..."

...
Debug: 1067 949 core.c:1349 jtag_tap_init() 48056: Created Tap:
auto451.tap @ abs position 0, irlen 0, capture: 0x1 mask: 0x3
Warn : 1068 949 core.c:1150 jtag_examine_chain() 47920: AUTO
auto452.tap - use "jtag newtap auto452 tap -expected-id 0x00000000
..."
Debug: 1069 949 core.c:1349 jtag_tap_init() 47864: Created Tap:
auto452.tap @ abs position 0, irlen 0, capture: 0x1 mask: 0x3
Warn : 1070 949 core.c:1150 jtag_examine_chain() 47728: AUTO
auto453.tap - use "jtag newtap auto453 tap -expected-id 0x00000000
..."
Debug: 1071 949 core.c:1349 jtag_tap_init() 47672: Created Tap:
auto453.tap @ abs position 0, irlen 0, capture: 0x1 mask: 0x3
Debug: 1072 949 core.c:1213 jtag_validate_ircapture() 44288: IR
capture validation scan
Debug: 1073 949 ft2232.c:1884 ft2232_execute_scan() 44296: IRSCAN type:3
Debug: 1074 949 commands.c:189 jtag_build_buffer() 40872: IRSCAN num_fields: 1
Debug: 1075 949 commands.c:202 jtag_build_buffer() 40824:
fields[0].out_value[27242]: 0xFFFFFFFFFFFFFFFF
Debug: 1076 950 ft2232.c:480 move_to_state() 40872: start=RESET goal=IRSHIFT
Debug: 1077 950 ft2232.c:419 clock_tms() 40848: mpsse cmd=4b, tms_bits
= 0x0000001b, bit_count=7
Debug: 1078 950 ft2232.c:429 clock_tms() 40872: tap_set_state(RESET)
Debug: 1079 950 ft2232.c:429 clock_tms() 40872: tap_set_state(RESET)
Debug: 1080 950 ft2232.c:429 clock_tms() 40872: tap_set_state(RUN/IDLE)
Debug: 1081 950 ft2232.c:429 clock_tms() 40872: tap_set_state(DRSELECT)
Debug: 1082 950 ft2232.c:429 clock_tms() 40872: tap_set_state(IRSELECT)
Debug: 1083 950 ft2232.c:429 clock_tms() 40872: tap_set_state(IRCAPTURE)
Debug: 1084 950 ft2232.c:429 clock_tms() 40872: tap_set_state(IRSHIFT)
Debug: 1085 950 ft2232.c:1103 ft2232_add_scan() 40880: finish via PAUSE
Debug: 1086 950 ft2232.c:419 clock_tms() 40848: mpsse cmd=6b, tms_bits
= 0x00000001, bit_count=2
Debug: 1087 950 ft2232.c:429 clock_tms() 40872: tap_set_state(IREXIT1)
Debug: 1088 950 ft2232.c:429 clock_tms() 40872: tap_set_state(IRPAUSE)
Debug: 1089 950 ft2232.c:480 move_to_state() 40864: start=IRPAUSE goal=RUN/IDLE
Debug: 1090 950 ft2232.c:419 clock_tms() 40848: mpsse cmd=4b, tms_bits
= 0x00000003, bit_count=3
Debug: 1091 950 ft2232.c:429 clock_tms() 40872: tap_set_state(IREXIT2)
Debug: 1092 950 ft2232.c:429 clock_tms() 40872: tap_set_state(IRUPDATE)
Debug: 1093 950 ft2232.c:429 clock_tms() 40872: tap_set_state(RUN/IDLE)
Debug: 1094 950 ft2232.c:1925 ft2232_execute_scan() 44272: IR scan,
27242 bits, end in RUN/IDLE
Debug: 1095 950 ft2232.c:790 ft2232_send_and_recv() 44288: write
buffer (size 3420):
Debug: 1096 950 ft2232.c:765 ft2232_debug_dump_buffer() 44264: 4b 06
1b 39 4c 0d ff ff ff ff ff ff ff ff ff ff
Debug: 1097 950 ft2232.c:765 ft2232_debug_dump_buffer() 44264: ff ff
ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Debug: 1098 950 ft2232.c:765 ft2232_debug_dump_buffer() 44264: ff ff
ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Debug: 1099 950 ft2232.c:765 ft2232_debug_dump_buffer() 44264: ff ff
ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Debug: 1100 950 ft2232.c:765 ft2232_debug_dump_buffer() 44264: ff ff
ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Debug: 1101 950 ft2232.c:765 ft2232_debug_dump_buffer() 44264: ff ff
ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Debug: 1102 950 ft2232.c:765 ft2232_debug_dump_buffer() 44264: ff ff
ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Debug: 1103 950 ft2232.c:765 ft2232_debug_dump_buffer() 44264: ff ff
ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Debug: 1104 950 ft2232.c:765 ft2232_debug_dump_buffer() 44264: ff ff
ff ff ff ff ff ff ff ff ff ff ff ff ff ff

...

Debug: 1304 951 ft2232.c:765 ft2232_debug_dump_buffer() 44264: ff ff
ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Debug: 1305 951 ft2232.c:765 ft2232_debug_dump_buffer() 44264: ff ff
ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Debug: 1306 951 ft2232.c:765 ft2232_debug_dump_buffer() 44264: ff ff
ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Debug: 1307 951 ft2232.c:765 ft2232_debug_dump_buffer() 44264: ff ff
ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Debug: 1308 951 ft2232.c:765 ft2232_debug_dump_buffer() 44264: ff ff
ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Debug: 1309 951 ft2232.c:771 ft2232_debug_dump_buffer() 44272: ff ff
ff 3b 00 03 6b 01 81 4b 02 03
Error: 1310 6283 ft2232.c:565 ft2232_read() 44256: couldn't read
enough bytes from FT2232 device (665 < 3407)
Error: 1311 6283 ft2232.c:820 ft2232_send_and_recv() 44288: couldn't
read from FT2232
Debug: 1312 6283 ft2232.c:790 ft2232_send_and_recv() 44288: write
buffer (size 0):
Error: 1313 11617 ft2232.c:565 ft2232_read() 44256: couldn't read
enough bytes from FT2232 device (667 < 3407)
Error: 1314 11617 ft2232.c:820 ft2232_send_and_recv() 44288: couldn't
read from FT2232
Debug: 1315 11617 core.c:330 jtag_call_event_callbacks() 47704: jtag
event: TAP reset
Debug: 1316 11617 ft2232.c:1749 ft2232_execute_statemove() 47704:
statemove end in RESET
Debug: 1317 11617 ft2232.c:419 clock_tms() 47680: mpsse cmd=4b,
tms_bits = 0x000000ff, bit_count=5
Debug: 1318 11617 ft2232.c:429 clock_tms() 47704: tap_set_state(DRSELECT)
Debug: 1319 11617 ft2232.c:429 clock_tms() 47704: tap_set_state(IRSELECT)
Debug: 1320 11617 ft2232.c:429 clock_tms() 47704: tap_set_state(RESET)
Debug: 1321 11617 ft2232.c:429 clock_tms() 47704: tap_set_state(RESET)
Debug: 1322 11617 ft2232.c:429 clock_tms() 47704: tap_set_state(RESET)
Debug: 1323 11617 ft2232.c:790 ft2232_send_and_recv() 47704: write
buffer (size 3):
Debug: 1324 11617 ft2232.c:771 ft2232_debug_dump_buffer() 47720: 4b 04 1f
Debug: 1325 11617 command.c:133 script_debug() 45496: command -
ocd_command ocd_command type ocd_jtag arp_init-reset
Debug: 1326 11617 command.c:133 script_debug() 45576: command -
ocd_jtag ocd_jtag arp_init-reset
Debug: 1327 11617 core.c:1519 jtag_init_reset() 45624: Initializing
with hard TRST+SRST reset
Debug: 1328 11617 core.c:727 jtag_add_reset() 45624: JTAG reset with
TLR instead of TRST
Debug: 1329 11617 core.c:330 jtag_call_event_callbacks() 45616: jtag
event: TAP reset
Debug: 1330 11617 ft2232.c:1749 ft2232_execute_statemove() 45616:
statemove end in RESET
Debug: 1331 11617 ft2232.c:419 clock_tms() 45584: mpsse cmd=4b,
tms_bits = 0x000000ff, bit_count=5
Debug: 1332 11617 ft2232.c:429 clock_tms() 45616: tap_set_state(RESET)
Debug: 1333 11617 ft2232.c:429 clock_tms() 45616: tap_set_state(RESET)
Debug: 1334 11617 ft2232.c:429 clock_tms() 45616: tap_set_state(RESET)
Debug: 1335 11617 ft2232.c:429 clock_tms() 45616: tap_set_state(RESET)
Debug: 1336 11617 ft2232.c:429 clock_tms() 45616: tap_set_state(RESET)
Debug: 1337 11617 ft2232.c:790 ft2232_send_and_recv() 45616: write
buffer (size 3):
Debug: 1338 11617 ft2232.c:771 ft2232_debug_dump_buffer() 45632: 4b 04 1f
Debug: 1339 11618 core.c:1432 jtag_init_inner() 45648: Init JTAG chain
Debug: 1340 11618 core.c:330 jtag_call_event_callbacks() 45624: jtag
event: TAP reset
Debug: 1341 11618 ft2232.c:1749 ft2232_execute_statemove() 45624:
statemove end in RESET
Debug: 1342 11618 ft2232.c:419 clock_tms() 45592: mpsse cmd=4b,
tms_bits = 0x000000ff, bit_count=5
Debug: 1343 11618 ft2232.c:429 clock_tms() 45624: tap_set_state(RESET)
Debug: 1344 11618 ft2232.c:429 clock_tms() 45624: tap_set_state(RESET)
Debug: 1345 11618 ft2232.c:429 clock_tms() 45624: tap_set_state(RESET)
Debug: 1346 11618 ft2232.c:429 clock_tms() 45624: tap_set_state(RESET)
Debug: 1347 11618 ft2232.c:429 clock_tms() 45624: tap_set_state(RESET)
Debug: 1348 11618 ft2232.c:790 ft2232_send_and_recv() 45624: write
buffer (size 3):
Debug: 1349 11618 ft2232.c:771 ft2232_debug_dump_buffer() 45632: 4b 04 1f
Debug: 1350 11618 core.c:1049 jtag_examine_chain() 45624: DR scan
interrogation for IDCODE/BYPASS
Debug: 1351 11618 core.c:330 jtag_call_event_callbacks() 45624: jtag
event: TAP reset
Debug: 1352 11618 ft2232.c:1884 ft2232_execute_scan() 45632: DRSCAN type:3
Debug: 1353 11618 commands.c:189 jtag_build_buffer() 45536: DRSCAN num_fields: 1
Debug: 1354 11618 commands.c:202 jtag_build_buffer() 45480:
fields[0].out_value[640]: 0x000000FF000000FF
Debug: 1355 11618 ft2232.c:480 move_to_state() 45536: start=RESET goal=DRSHIFT
Debug: 1356 11618 ft2232.c:419 clock_tms() 45512: mpsse cmd=4b,
tms_bits = 0x00000017, bit_count=7
Debug: 1357 11618 ft2232.c:429 clock_tms() 45536: tap_set_state(RESET)
Debug: 1358 11618 ft2232.c:429 clock_tms() 45536: tap_set_state(RESET)
Debug: 1359 11618 ft2232.c:429 clock_tms() 45536: tap_set_state(RESET)
Debug: 1360 11618 ft2232.c:429 clock_tms() 45536: tap_set_state(RUN/IDLE)
Debug: 1361 11618 ft2232.c:429 clock_tms() 45536: tap_set_state(DRSELECT)
Debug: 1362 11618 ft2232.c:429 clock_tms() 45536: tap_set_state(DRCAPTURE)
Debug: 1363 11618 ft2232.c:429 clock_tms() 45536: tap_set_state(DRSHIFT)
Debug: 1364 11618 ft2232.c:1103 ft2232_add_scan() 45544: finish via PAUSE
Debug: 1365 11618 ft2232.c:419 clock_tms() 45512: mpsse cmd=6b,
tms_bits = 0x00000001, bit_count=2
Debug: 1366 11618 ft2232.c:429 clock_tms() 45536: tap_set_state(DREXIT1)
Debug: 1367 11618 ft2232.c:429 clock_tms() 45536: tap_set_state(DRPAUSE)
Debug: 1368 11618 ft2232.c:1925 ft2232_execute_scan() 45616: DR scan,
640 bits, end in DRPAUSE
Debug: 1369 11618 ft2232.c:1749 ft2232_execute_statemove() 45624:
statemove end in RESET
Debug: 1370 11618 ft2232.c:419 clock_tms() 45600: mpsse cmd=4b,
tms_bits = 0x000000ff, bit_count=5
Debug: 1371 11618 ft2232.c:429 clock_tms() 45624: tap_set_state(DREXIT2)
Debug: 1372 11618 ft2232.c:429 clock_tms() 45624: tap_set_state(DRUPDATE)
Debug: 1373 11618 ft2232.c:429 clock_tms() 45624: tap_set_state(DRSELECT)
Debug: 1374 11618 ft2232.c:429 clock_tms() 45624: tap_set_state(IRSELECT)
Debug: 1375 11618 ft2232.c:429 clock_tms() 45624: tap_set_state(RESET)
Debug: 1376 11618 ft2232.c:790 ft2232_send_and_recv() 45624: write
buffer (size 94):
Debug: 1377 11618 ft2232.c:765 ft2232_debug_dump_buffer() 45600: 4b 06
17 39 4e 00 ff 00 00 00 ff 00 00 00 ff 00
Debug: 1378 11618 ft2232.c:765 ft2232_debug_dump_buffer() 45600: 00 00
ff 00 00 00 ff 00 00 00 ff 00 00 00 ff 00
Debug: 1379 11618 ft2232.c:765 ft2232_debug_dump_buffer() 45600: 00 00
ff 00 00 00 ff 00 00 00 ff 00 00 00 ff 00
Debug: 1380 11618 ft2232.c:765 ft2232_debug_dump_buffer() 45600: 00 00
ff 00 00 00 ff 00 00 00 ff 00 00 00 ff 00
Debug: 1381 11618 ft2232.c:765 ft2232_debug_dump_buffer() 45600: 00 00
ff 00 00 00 ff 00 00 00 ff 00 00 00 ff 00
Debug: 1382 11618 ft2232.c:771 ft2232_debug_dump_buffer() 45608: 00 00
ff 00 00 3b 06 00 6b 01 01 4b 04 1f
Info : 1383 12263 ft2232.c:834 ft2232_send_and_recv() 45600: inter:
0.000054, inter2: 0.000055 end: 0.644714
Debug: 1384 12263 ft2232.c:855 ft2232_send_and_recv() 45616: read
buffer (0 retries): 81 bytes
Debug: 1385 12263 ft2232.c:765 ft2232_debug_dump_buffer() 45600: 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00
Debug: 1386 12263 ft2232.c:765 ft2232_debug_dump_buffer() 45600: 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00
Debug: 1387 12263 ft2232.c:765 ft2232_debug_dump_buffer() 45600: 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00
Debug: 1388 12263 ft2232.c:765 ft2232_debug_dump_buffer() 45600: 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00
Debug: 1389 12263 ft2232.c:765 ft2232_debug_dump_buffer() 45600: 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00
Debug: 1390 12263 ft2232.c:771 ft2232_debug_dump_buffer() 45640: 00
Debug: 1391 12263 commands.c:248 jtag_read_buffer() 45400:
fields[0].in_value[640]: 0x0000000000000000
Error: 1392 12263 core.c:939 jtag_examine_chain_check() 45616: JTAG
scan chain interrogation failed: all zeroes
Error: 1393 12263 core.c:940 jtag_examine_chain_check() 45616: Check
JTAG interface, timings, target power, etc.
Debug: 1394 12263 command.c:624 run_command() 46640: Command failed
with error code -4
User : 1395 12263 command.c:828 openocd_jim_vfprintf() 105128: Command
handler execution failed
User : 1396 12263 command.c:828 openocd_jim_vfprintf() 105112: in
procedure 'transport' User : 1397 12263 command.c:828
openocd_jim_vfprintf() 105144:
Debug: 1398 12263 command.c:624 run_command() 105136: Command failed
with error code -4
User : 1399 12263 command.c:828 openocd_jim_vfprintf() 142264: Command
handler execution failed
User : 1400 12263 command.c:828 openocd_jim_vfprintf() 142248: in
procedure 'init' User : 1401 12263 command.c:828
openocd_jim_vfprintf() 142280:

I am lost, do not know where to start looking.

I can re-compile again with libftd2xx0.4.16, but that did not give
good results before.

I will also try to take a look at what Lauterbach is doing, but I am
pretty sure that it does nothing except chain scan...

Best regards,
Drasko
_______________________________________________
Openocd-development mailing list
Openocd-development@lists.berlios.de
https://lists.berlios.de/mailman/listinfo/openocd-development

Reply via email to