Uhk80 freeze

[kareltucek]

Connections:

• usb
• dongle

Firmware: 16.3.0 #a2856e65d

Behavior

• keyboard doesn't send reports
• it doesn't react to stuff (switch to the other host)
• reports freezes over usb -> main is blocked.
• after a while, message pool ran out.

Want:

• uhk connections to report active connection.
• disable the jump analysis spam.

uhk80:right$ log Printing trace buffer because: Looks like the firmware freezed. If that is the case
, please report bellow trace to the devs:

ID: 4, EV: 71565843, Tag: a2856e65d
Trace:
u7u8)(l6u1u2u3u6Ou7u8)(l6u1u2u3u6u7u8)(l6u1u2v5u3u6Ou7u8)(l6u1u2
u3u6Ou7u8)(l6u1u2u3u6u7u8)(l6u1u2v5u3u6Ou7u8)(l6u1u2u3u6bp8I2,1,
17,5932bp8I3,2,6,16816I4,2,6,164I5,2,6,68I6,2,6,30I7,2,6,83I8,2,
6,97I9,2,6,23I10,2,6,75I11,2,6,67I12,2,6,105I13,2,6,30I14,2,6,83

...

2usb
uhk80:right$ <inf> udc: ep 0x80 is not halted|disabled
<inf> udc: ep 0x80 is not halted|disabled
<inf> udc: ep 0x80 is not halted|disabled
<inf> c2usb: CTRL EP setup: 21 09 0204 2
<inf> udc: ep 0x80 is not halted|disabled
<inf> c2usb: CTRL EP setup: 21 09 0204 4
<inf> udc: ep 0x80 is not halted|disabled
<inf> c2usb: CTRL EP setup: 21 09 0204 2
<inf> udc: ep 0x80 is not halted|disabled
<inf> c2usb: CTRL EP setup: 21 09 0204 4
<inf> udc: ep 0x80 is not halted|disabled
<inf> c2usb: CTRL EP setup: 21 09 0204 2
<inf> udc: ep 0x80 is not halted|disabled
<inf> c2usb: CTRL EP setup: 21 09 0204 4
<inf> udc: ep 0x80 is not halted|disabled
<inf> c2usb: CTRL EP setup: 21 09 0204 2
<inf> udc: ep 0x80 is not halted|disabled
<inf> c2usb: CTRL EP setup: 21 09 0204 4
<inf> udc: ep 0x80 is not halted|disabled
<inf> c2usb: CTRL EP setup: 21 09 0204 2

...

<dbg> udc: udc_buf_destroy: destroy 0x2003dd18
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x00, size 8
<dbg> udc: udc_ctrl_update_stage: s->(out)
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x00, size 4
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x80, size 0
<inf> udc: ep 0x80 is not halted|disabled
<dbg> udc: udc_debug_ep_enqueue: ep 0x80 queue is empty
<inf> c2usb: CTRL EP setup: 21 09 0204 4
<dbg> udc: udc_buf_destroy: destroy 0x2003dd18
<dbg> udc: udc_buf_destroy: destroy 0x2003dd60
<dbg> udc: udc_ep_enqueue: Queue ep 0x83 0x2003ddcc len 64
<dbg> udc: udc_ep_enqueue: Queue ep 0x80 0x2003dd3c len 0
<dbg> udc: udc_ctrl_update_stage: s-out-status
<dbg> udc: udc_buf_destroy: destroy 0x2003dd3c
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x00, size 8
<dbg> udc: udc_ctrl_update_stage: s->(out)
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x00, size 4
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x80, size 0
<inf> udc: ep 0x80 is not halted|disabled
<dbg> udc: udc_debug_ep_enqueue: ep 0x80 queue is empty
<inf> c2usb: CTRL EP setup: 21 09 0204 4
<dbg> udc: udc_buf_destroy: destroy 0x2003dd3c
<dbg> udc: udc_buf_destroy: destroy 0x2003dd60
<dbg> udc: udc_ep_enqueue: Queue ep 0x83 0x2003ddcc len 64
<dbg> udc: udc_ep_enqueue: Queue ep 0x80 0x2003dd18 len 0
<dbg> udc: udc_ctrl_update_stage: s-out-status
<dbg> udc: udc_buf_destroy: destroy 0x2003dd18
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x00, size 8
<dbg> udc: udc_ctrl_update_stage: s->(out)
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x00, size 4
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x80, size 0
<inf> udc: ep 0x80 is not halted|disabled
<dbg> udc: udc_debug_ep_enqueue: ep 0x80 queue is empty
<inf> c2usb: CTRL EP setup: 21 09 0204 4
<dbg> udc: udc_buf_destroy: destroy 0x2003dd18
<dbg> udc: udc_buf_destroy: destroy 0x2003dd60
<dbg> udc: udc_ep_enqueue: Queue ep 0x83 0x2003ddcc len 64
<dbg> udc: udc_ep_enqueue: Queue ep 0x80 0x2003dd3c len 0
<dbg> udc: udc_ctrl_update_stage: s-out-status
<dbg> udc: udc_buf_destroy: destroy 0x2003dd3c
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x00, size 8
<dbg> udc: udc_ctrl_update_stage: s->(out)
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x00, size 4
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x80, size 0
<inf> udc: ep 0x80 is not halted|disabled
<dbg> udc: udc_debug_ep_enqueue: ep 0x80 queue is empty
<inf> c2usb: CTRL EP setup: 21 09 0204 4
<dbg> udc: udc_buf_destroy: destroy 0x2003dd3c
<dbg> udc: udc_buf_destroy: destroy 0x2003dd60
<dbg> udc: udc_ep_enqueue: Queue ep 0x83 0x2003ddcc len 64
<dbg> udc: udc_ep_enqueue: Queue ep 0x80 0x2003dd18 len 0
<dbg> udc: udc_ctrl_update_stage: s-out-status
<dbg> udc: udc_buf_destroy: destroy 0x2003dd18
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x00, size 8
<dbg> udc: udc_ctrl_update_stage: s->(out)
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x00, size 4
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x80, size 0
<inf> udc: ep 0x80 is not halted|disabled
<dbg> udc: udc_debug_ep_enqueue: ep 0x80 queue is empty
<inf> c2usb: CTRL EP setup: 21 09 0204 4
<dbg> udc: udc_buf_destroy: destroy 0x2003dd18
<dbg> udc: udc_buf_destroy: destroy 0x2003dd60
<dbg> udc: udc_ep_enqueue: Queue ep 0x83 0x2003ddcc len 64
<dbg> udc: udc_ep_enqueue: Queue ep 0x80 0x2003dd3c len 0
<dbg> udc: udc_ctrl_update_stage: s-out-status
<dbg> udc: udc_buf_destroy: destroy 0x2003dd3c
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x00, size 8
<dbg> udc: udc_ctrl_update_stage: s->(out)
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x00, size 4
<dbg> udc: udc_ep_buf_alloc: Allocate net_buf, ep 0x80, size 0
<inf> udc: ep 0x80 is not halted|disabled
<dbg> udc: udc_debug_ep_enqueue: ep 0x80 queue is empty
<inf> c2usb: CTRL EP setup: 21 09 0204 4
<dbg> udc: udc_buf_destroy: destroy 0x2003dd3c


uhk80:right$ Printing trace buffer because: Messenger pool space ran out!
ID: 4, EV: 71565843, Tag: a2856e65d
Trace:
7u8)(l6u1u2u3u6u7u8)(l6u1u2v5u3u6Ou7u8)(l6u1u2u3u6bp8I2,1,17,593
2bp8I3,2,6,16816I4,2,6,164I5,2,6,68I6,2,6,30I7,2,6,83I8,2,6,97I9
,2,6,23I10,2,6,75I11,2,6,67I12,2,6,105I13,2,6,30I14,2,6,83I15,1,
17,42862I16,1,17,60503bp8bp8bp8bp8bp8bp8bp8bp8E0I16,1,17,60507E0
Threads (20), interval 10 ms:
    - idle (id 550): 61
    - MPSL Work (id 537): 13
    - i2c_poller (id 478): 9
    - key_scanner (id 489): 8
    - udc_nrfx (id 148): 1
    - c2usb (id 601): 1
    - test_uart (id 524): 0
    - UhkShell (id 380): 0
    - logging (id 601): 0
    - BT RX WQ (id 974): 2
    - sysworkq (id 573): 1
    - shell_rtt (id 874): 0
    - oled_updater (id 512): 0
    - main (id 562): 0
    - state_sync_left_right (id 435): 0
    - led_updater (id 501): 0
    - state_sync_dongle_right (id 424): 0
    - flash (id 106): 0
    - BT GATT DM WQ (id 946): 0
    - BT LW WQ (id 960): 0
Messenger message pool space ran out!
Printing trace buffer because: Messenger pool space ran out!
ID: 4, EV: 71565843, Tag: a2856e65d
Trace:
7u8)(l6u1u2v5u3u6Ou7u8)(l6u1u2u3u6bp8I2,1,17,5932bp8I3,2,6,16816
I4,2,6,164I5,2,6,68I6,2,6,30I7,2,6,83I8,2,6,97I9,2,6,23I10,2,6,7
5I11,2,6,67I12,2,6,105I13,2,6,30I14,2,6,83I15,1,17,42862I16,1,17
,60503bp8bp8bp8bp8bp8bp8bp8bp8E0I16,1,17,60507E0I16,1,18,39629E0
Threads (20), interval 10 ms:
    - idle (id 550): 77
    - MPSL Work (id 537): 6
    - key_scanner (id 489): 6
    - i2c_poller (id 478): 5
    - test_uart (id 524): 0
    - udc_nrfx (id 148): 0
    - c2usb (id 601): 0
    - shell_rtt (id 874): 0
    - BT RX WQ (id 974): 1
    - sysworkq (id 573): 2
    - logging (id 601): 0
    - UhkShell (id 380): 0
    - oled_updater (id 512): 0
    - main (id 562): 0
    - state_sync_left_right (id 435): 0
    - led_updater (id 501): 0
    - state_sync_dongle_right (id 424): 0
    - flash (id 106): 0
    - BT GATT DM WQ (id 946): 0
    - BT LW WQ (id 960): 0
Messenger message pool space ran out!

[kareltucek]

Looks like main freezed somewhere near sending usb reports (handing them over to c2usb).

I am adding more tracing so that I can pinpoint specific transport and verify whether or not it is leading to c2usb.