[
https://issues.apache.org/jira/browse/MYNEWT-756?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]
Jacob updated MYNEWT-756:
-------------------------
switched to nrf51dk pca10031 which i guess in an nrf51422 qfac using
nrf51dk bsp
core Commit a6c5103e6b709423cf9380e9d2e57004bafb2ca9
i can strip sysfg all the way down to here and it always just hangs
Jacobs-MacBook-Air:chippd3 jacobrosenthal$ newt target show bleprph-nrf51dk
targets/bleprph-nrf51dk
app=@apache-mynewt-core/apps/bleprph
bsp=@apache-mynewt-core/hw/bsp/nrf51dk
build_profile=optimized
syscfg=BLE_LL_CFG_FEAT_LE_ENCRYPTION=0:BLE_SM_LEGACY=0:BLE_SM_SC=0
Jacobs-MacBook-Air:chippd3 jacobrosenthal$
and it just hangs like ive seen on nrf51dk-16kbram bsps
if i turn logs back on
Jacobs-MacBook-Air:chippd3 jacobrosenthal$ newt target show bleprph-nrf51dk
targets/bleprph-nrf51dk
app=@apache-mynewt-core/apps/bleprph
bsp=@apache-mynewt-core/hw/bsp/nrf51dk
build_profile=optimized
syscfg=BLE_LL_CFG_FEAT_LE_ENCRYPTION=0:BLE_SM_LEGACY=0:BLE_SM_SC=0:CONSOLE_COMPAT=1:CONSOLE_ECHO=0:CONSOLE_INPUT=0:CONSOLE_MAX_INPUT_LEN=0:CONSOLE_RTT=1:CONSOLE_UART=0:LOG_LEVEL=0
Jacobs-MacBook-Air:chippd3 jacobrosenthal$
Jacobs-MacBook-Air:node-newtmgr jacobrosenthal$ GODEBUG=cgocheck=0 newtmgr
mpstats -cnimble_bleprph -ldebug -t
2017/06/06 21:01:19 [DEBUG] BLE Connection devaddr:[]
2017/06/06 21:01:19 [DEBUG] State:PoweredOn
2017/06/06 21:01:19 [DEBUG] scanning...
2017/06/06 21:01:19 [DEBUG] Peripheral Discovered: , Address:[0 0 0 0 0 0]
Address Type:0
2017/06/06 21:01:19 [DEBUG] Peripheral Discovered: , Address:[0 0 0 0 0 0]
Address Type:0
2017/06/06 21:01:20 Unhandled event: xpc.Dict{"kCBMsgId":53,
"kCBMsgArgs":xpc.Dict{"kCBMsgArgDeviceUUID":xpc.UUID{0x2f, 0xd, 0xcb, 0x60,
0xf, 0x3e, 0x47, 0x52, 0xb7, 0x74, 0x13, 0x29, 0x3a, 0x3, 0xd4, 0xd0},
"kCBMsgArgATTMTU":104}}
2017/06/06 21:01:20 [DEBUG] Peripheral Connected
2017/06/06 21:01:20 [DEBUG] Newtmgr Service Found
2017/06/06 21:01:20 [DEBUG] Newtmgr Characteristic Found
2017/06/06 21:01:20 [DEBUG] Writing newtmgr request &{Op:0 Flags:0 Len:0
Group:0 Seq:0 Id:3 Data:[]}
2017/06/06 21:01:20 [DEBUG] Serializing request &{Op:0 Flags:0 Len:0
Group:0 Seq:0 Id:3 Data:[]} into buffer [0 0 0 0 0 0 0 3]
2017/06/06 21:01:20 [DEBUG] Tx packet dump:
00000000 00 00 00 00 00 00 00 03 |........|
2017/06/06 21:01:20 [DEBUG] Write BLE Packet:buf:: len::8
2017/06/06 21:01:20 [DEBUG] Read BLE
Packet:buf::l?brcfmpools?fmsys_1?fblksiz$enblks
enfree cmi?wble_hci_ram_evt_hi_pool?fblksizHenblkse len::101
2017/06/06 21:01:20 [DEBUG] Rx packet dump:
00000000 01 00 02 6c 00 00 00 03 bf 62 72 63 00 66 6d 70
|...l.....brc.fmp|
00000010 6f 6f 6c 73 bf 66 6d 73 79 73 5f 31 bf 66 62 6c
|ools.fmsys_1.fbl|
00000020 6b 73 69 7a 19 01 24 65 6e 62 6c 6b 73 0c 65 6e
|ksiz..$enblks.en|
00000030 66 72 65 65 09 63 6d 69 6e 08 ff 77 62 6c 65 5f
|free.cmin..wble_|
00000040 68 63 69 5f 72 61 6d 5f 65 76 74 5f 68 69 5f 70
|hci_ram_evt_hi_p|
00000050 6f 6f 6c bf 66 62 6c 6b 73 69 7a 18 48 65 6e 62
|ool.fblksiz.Henb|
00000060 6c 6b 73 02 65 |lks.e|
2017/06/06 21:01:20 [DEBUG] Deserialized response &{Op:1 Flags:0 Len:620
Group:0 Seq:0 Id:3 Data:[191 98 114 99 0 102 109 112 111 111 108 115 191
102 109 115 121 115 95 49 191 102 98 108 107 115 105 122 25 1 36 101 110 98
108 107 115 12 101 110 102 114 101 101 9 99 109 105 110 8 255 119 98 108
101 95 104 99 105 95 114 97 109 95 101 118 116 95 104 105 95 112 111 111
108 191 102 98 108 107 115 105 122 24 72 101 110 98 108 107 115 2 101]}
2017/06/06 21:01:20 [DEBUG] Read BLE
Packet:buf::nfreecmin?wble_hci_ram_evt_lo_pool?fblksizHenblkenfrecmi?rble_hs_hci_ev_pool?fblksizenblks
len::101
2017/06/06 21:01:20 [DEBUG] Rx packet dump:
00000000 6e 66 72 65 65 02 63 6d 69 6e 00 ff 77 62 6c 65
|nfree.cmin..wble|
00000010 5f 68 63 69 5f 72 61 6d 5f 65 76 74 5f 6c 6f 5f
|_hci_ram_evt_lo_|
00000020 70 6f 6f 6c bf 66 62 6c 6b 73 69 7a 18 48 65 6e
|pool.fblksiz.Hen|
00000030 62 6c 6b 73 08 65 6e 66 72 65 65 08 63 6d 69 6e
|blks.enfree.cmin|
00000040 08 ff 72 62 6c 65 5f 68 73 5f 68 63 69 5f 65 76
|..rble_hs_hci_ev|
00000050 5f 70 6f 6f 6c bf 66 62 6c 6b 73 69 7a 10 65 6e
|_pool.fblksiz.en|
00000060 62 6c 6b 73 0a |blks.|
2017/06/06 21:01:20 [DEBUG] Read BLE Packet:buf::enfree
cmin
?pble_hs_conn_pool?fblksizTenblksenfreecmin?sble_l2cap_chan_pool?fblksizenblksenfr
len::101
2017/06/06 21:01:20 [DEBUG] Rx packet dump:
00000000 65 6e 66 72 65 65 0a 63 6d 69 6e 09 ff 70 62 6c
|enfree.cmin..pbl|
00000010 65 5f 68 73 5f 63 6f 6e 6e 5f 70 6f 6f 6c bf 66
|e_hs_conn_pool.f|
00000020 62 6c 6b 73 69 7a 18 54 65 6e 62 6c 6b 73 01 65
|blksiz.Tenblks.e|
00000030 6e 66 72 65 65 00 63 6d 69 6e 00 ff 73 62 6c 65
|nfree.cmin..sble|
00000040 5f 6c 32 63 61 70 5f 63 68 61 6e 5f 70 6f 6f 6c
|_l2cap_chan_pool|
00000050 bf 66 62 6c 6b 73 69 7a 18 1c 65 6e 62 6c 6b 73
|.fblksiz..enblks|
00000060 03 65 6e 66 72 |.enfr|
2017/06/06 21:01:20 [DEBUG] Read BLE
Packet:buf::eecmin?wble_l2cap_sig_proc_pool?fblksizenblksenfreecmin?xle_att_svr_prep_entry_pool?fblksiz
e len::101
2017/06/06 21:01:20 [DEBUG] Rx packet dump:
00000000 65 65 00 63 6d 69 6e 00 ff 77 62 6c 65 5f 6c 32
|ee.cmin..wble_l2|
00000010 63 61 70 5f 73 69 67 5f 70 72 6f 63 5f 70 6f 6f
|cap_sig_proc_poo|
00000020 6c bf 66 62 6c 6b 73 69 7a 14 65 6e 62 6c 6b 73
|l.fblksiz.enblks|
00000030 01 65 6e 66 72 65 65 01 63 6d 69 6e 01 ff 78 1b
|.enfree.cmin..x.|
00000040 62 6c 65 5f 61 74 74 5f 73 76 72 5f 70 72 65 70
|ble_att_svr_prep|
00000050 5f 65 6e 74 72 79 5f 70 6f 6f 6c bf 66 62 6c 6b
|_entry_pool.fblk|
00000060 73 69 7a 0c 65 |siz.e|
2017/06/06 21:01:20 [DEBUG] Read BLE
Packet:buf::ksenfreecmin?vble_att_svr_entry_pool?fblksizenblks%enfreecmin?vble_gatts_clt_cfg_pool?fblksiz
len::101
2017/06/06 21:01:20 [DEBUG] Rx packet dump:
00000000 6b 73 04 65 6e 66 72 65 65 04 63 6d 69 6e 04 ff
|ks.enfree.cmin..|
00000010 76 62 6c 65 5f 61 74 74 5f 73 76 72 5f 65 6e 74
|vble_att_svr_ent|
00000020 72 79 5f 70 6f 6f 6c bf 66 62 6c 6b 73 69 7a 14
|ry_pool.fblksiz.|
00000030 65 6e 62 6c 6b 73 18 25 65 6e 66 72 65 65 00 63
|enblks.%enfree.c|
00000040 6d 69 6e 00 ff 76 62 6c 65 5f 67 61 74 74 73 5f
|min..vble_gatts_|
00000050 63 6c 74 5f 63 66 67 5f 70 6f 6f 6c bf 66 62 6c
|clt_cfg_pool.fbl|
00000060 6b 73 69 7a 10 |ksiz.|
device logs:
000902 [ts=7046872ssb, mod=4 level=0] LE connection complete. handle=1
role=1 paddrtype=0 addr=b8.e8.56.3.d3.ed local_rpa=0.0.0.0.0.0
peer_rpa=0.0.0.0.0.0 itvl=12 latency=0 spvn_tmo=200 mca=5
000903 [ts=7054684ssb, mod=64 level=1] connection established; status=0
handle=1 our_ota_addr_type=0 our_ota_addr=0a:0a:0a:0a:0a:0a
our_id_addr_type=0 our_id_addr=0a:0a:0a:0a:0a:0a peer_ota_addr_type=0
peer_ota_addr=b8:e8:56:03:d3:ed peer_id_addr_type=0
peer_id_addr=b8:e8:56:03:d3:ed conn_itvl=12 conn_latency=0
supervision_timeout=200 encrypted=0 authenticated=0 bonded=0
000905 [ts=7070308ssb, mod=64 level=1]
000905 [ts=7070308ssb, mod=4 level=0] ble_hs_hci_evt_acl_process():
conn_handle=1 pb=2 len=7 data=0x03 0x00 0x04 0x00 0x02 0x68 0x00
000906 [ts=7078120ssb, mod=4 level=0] rxed att command: mtu req; conn=1
mtu=104
000906 [ts=7078120ssb, mod=4 level=0] txed att command: mtu rsp; conn=1
mtu=527
000907 [ts=7085932ssb, mod=4 level=0] host tx hci data; handle=1 length=7
000907 [ts=7085932ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x07
0x00 0x03 0x00 0x04 0x00 0x03 0x0f 0x02
000908 [ts=7093744ssb, mod=64 level=1] mtu update event; conn_handle=1
cid=4 mtu=104
000912 [ts=7124992ssb, mod=4 level=0] ble_hs_hci_evt_acl_process():
conn_handle=1 pb=2 len=11 data=0x07 0x00 0x04 0x00 0x08 0x01 0x00 0xff 0xff
0x00 0x2a
000913 [ts=7132804ssb, mod=4 level=0] rxed att command: read type req;
conn=1 start_handle=0x0001 end_handle=0xffff
000913 [ts=7132804ssb, mod=4 level=0] txed att command: read type rsp;
conn=1 length=16
000914 [ts=7140616ssb, mod=4 level=0] host tx hci data; handle=1 length=22
000914 [ts=7140616ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x16
0x00 0x12 0x00 0x04 0x00 0x09 0x10 0x10 0x00 0x6e 0x69 0x6d 0x62 0x6c 0x65
0x2d 0x62 0x6c 0x65 0x70 0x72 0x70 0x68
000916 [ts=7156240ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
000916 [ts=7156240ssb, mod=4 level=0] handle:1 pkts:1
000920 [ts=7187488ssb, mod=4 level=0] ble_hs_hci_evt_acl_process():
conn_handle=1 pb=2 len=11 data=0x07 0x00 0x04 0x00 0x10 0x01 0x00 0xff 0xff
0x00 0x28
000920 [ts=7187488ssb, mod=4 level=0] rxed att command: read group type
req; conn=1 start_handle=0x0001 end_handle=0xffff
000921 [ts=7195300ssb, mod=4 level=0] txed att command: read group type
rsp; conn=1 length=6
000921 [ts=7195300ssb, mod=4 level=0] host tx hci data; handle=1 length=24
000922 [ts=7203112ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x18
0x00 0x14 0x00 0x04 0x00 0x11 0x06 0x01 0x00 0x0d 0x00 0x11 0x18 0x0e 0x00
0x18 0x00 0x00 0x18 0x19 0x00 0x1c 0x00 0x01 0x18
000923 [ts=7210924ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
000924 [ts=7218736ssb, mod=4 level=0] handle:1 pkts:1
000927 [ts=7242172ssb, mod=4 level=0] ble_hs_hci_evt_acl_process():
conn_handle=1 pb=2 len=11 data=0x07 0x00 0x04 0x00 0x10 0x1d 0x00 0xff 0xff
0x00 0x28
000928 [ts=7249984ssb, mod=4 level=0] rxed att command: read group type
req; conn=1 start_handle=0x001d end_handle=0xffff
000929 [ts=7257796ssb, mod=4 level=0] txed att command: read group type
rsp; conn=1 length=20
000929 [ts=7257796ssb, mod=4 level=0] host tx hci data; handle=1 length=46
000930 [ts=7265608ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x2e
0x00 0x2a 0x00 0x04 0x00 0x11 0x14 0x1d 0x00 0x20 0x00 0x84 0xaa 0x60 0x74
0x52 0x8a 0x8b 0x86 0xd3 0x4c 0xb7 0x1d 0x1d 0xdc 0x53 0x8d 0x21 0x00 0xff
0xff 0x2d 0x71 0xa2 0x59 0xb4 0x58 0xc8 0x12 0x99 0x99 0x43 0x95 0x12 0x2f
0x46 0x59
000932 [ts=7281232ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
000933 [ts=7289044ssb, mod=4 level=0] handle:1 pkts:1
000937 [ts=7320292ssb, mod=4 level=0] ble_hs_hci_evt_acl_process():
conn_handle=1 pb=2 len=11 data=0x07 0x00 0x04 0x00 0x08 0x0e 0x00 0x18 0x00
0x03 0x28
000938 [ts=7328104ssb, mod=4 level=0] rxed att command: read type req;
conn=1 start_handle=0x000e end_handle=0x0018
000938 [ts=7328104ssb, mod=4 level=0] txed att command: read type rsp;
conn=1 length=7
000939 [ts=7335916ssb, mod=4 level=0] host tx hci data; handle=1 length=41
000939 [ts=7335916ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x29
0x00 0x25 0x00 0x04 0x00 0x09 0x07 0x0f 0x00 0x02 0x10 0x00 0x00 0x2a 0x11
0x00 0x02 0x12 0x00 0x01 0x2a 0x13 0x00 0x02 0x14 0x00 0x02 0x2a 0x15 0x00
0x08 0x16 0x00 0x03 0x2a 0x17 0x00 0x02 0x18 0x00 0x04 0x2a
000941 [ts=7351540ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
000941 [ts=7351540ssb, mod=4 level=0] handle:1 pkts:1
000945 [ts=7382788ssb, mod=4 level=0] ble_hs_hci_evt_acl_process():
conn_handle=1 pb=2 len=11 data=0x07 0x00 0x04 0x00 0x08 0x19 0x00 0x1c 0x00
0x03 0x28
000945 [ts=7382788ssb, mod=4 level=0] rxed att command: read type req;
conn=1 start_handle=0x0019 end_handle=0x001c
000946 [ts=7390600ssb, mod=4 level=0] txed att command: read type rsp;
conn=1 length=7
000946 [ts=7390600ssb, mod=4 level=0] host tx hci data; handle=1 length=13
000947 [ts=7398412ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x0d
0x00 0x09 0x00 0x04 0x00 0x09 0x07 0x1a 0x00 0x20 0x1b 0x00 0x05 0x2a
000948 [ts=7406224ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
000948 [ts=7406224ssb, mod=4 level=0] handle:1 pkts:1
000952 [ts=7437472ssb, mod=4 level=0] ble_hs_hci_evt_acl_process():
conn_handle=1 pb=2 len=11 data=0x07 0x00 0x04 0x00 0x08 0x1d 0x00 0x20 0x00
0x03 0x28
000953 [ts=7445284ssb, mod=4 level=0] rxed att command: read type req;
conn=1 start_handle=0x001d end_handle=0x0020
000954 [ts=7453096ssb, mod=4 level=0] txed att command: read type rsp;
conn=1 length=21
000954 [ts=7453096ssb, mod=4 level=0] host tx hci data; handle=1 length=27
000954 [ts=7453096ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x1b
0x00 0x17 0x00 0x04 0x00 0x09 0x15 0x1e 0x00 0x14 0x1f 0x00 0x48 0x7c 0x99
0x74 0x11 0x26 0x9e 0xae 0x01 0x4e 0xce 0xfb 0x28 0x78 0x2e 0xda
000956 [ts=7468720ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
000956 [ts=7468720ssb, mod=4 level=0] handle:1 pkts:1
000960 [ts=7499968ssb, mod=4 level=0] ble_hs_hci_evt_acl_process():
conn_handle=1 pb=2 len=7 data=0x03 0x00 0x04 0x00 0x0a 0x18 0x00
000961 [ts=7507780ssb, mod=4 level=0] rxed att command: read req; conn=1
handle=0x0018
000961 [ts=7507780ssb, mod=4 level=0] host tx hci data; handle=1 length=13
000961 [ts=7507780ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x0d
0x00 0x09 0x00 0x04 0x00 0x0b 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00
000962 [ts=7515592ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
000963 [ts=7523404ssb, mod=4 level=0] handle:1 pkts:1
000965 [ts=7539028ssb, mod=4 level=0] ble_hs_hci_evt_acl_process():
conn_handle=1 pb=2 len=9 data=0x05 0x00 0x04 0x00 0x04 0x1c 0x00 0x1c 0x00
000965 [ts=7539028ssb, mod=4 level=0] rxed att command: find info req;
conn=1 start_handle=0x001c end_handle=0x001c
000967 [ts=7554652ssb, mod=4 level=0] txed att command: find info rsp;
conn=1 format=1
000967 [ts=7554652ssb, mod=4 level=0] host tx hci data; handle=1 length=10
000968 [ts=7562464ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x0a
0x00 0x06 0x00 0x04 0x00 0x05 0x01 0x1c 0x00 0x02 0x29
000969 [ts=7570276ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
000969 [ts=7570276ssb, mod=4 level=0] handle:1 pkts:1
000971 [ts=7585900ssb, mod=4 level=0] ble_hs_hci_evt_acl_process():
conn_handle=1 pb=2 len=9 data=0x05 0x00 0x04 0x00 0x04 0x20 0x00 0x20 0x00
000972 [ts=7593712ssb, mod=4 level=0] rxed att command: find info req;
conn=1 start_handle=0x0020 end_handle=0x0020
000973 [ts=7601524ssb, mod=4 level=0] txed att command: find info rsp;
conn=1 format=1
000973 [ts=7601524ssb, mod=4 level=0] host tx hci data; handle=1 length=10
000973 [ts=7601524ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x0a
0x00 0x06 0x00 0x04 0x00 0x05 0x01 0x20 0x00 0x02 0x29
000974 [ts=7609336ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
000975 [ts=7617148ssb, mod=4 level=0] handle:1 pkts:1
000977 [ts=7632772ssb, mod=4 level=0] ble_hs_hci_evt_acl_process():
conn_handle=1 pb=2 len=9 data=0x05 0x00 0x04 0x00 0x12 0x1c 0x00 0x02 0x00
000978 [ts=7640584ssb, mod=4 level=0] rxed att command: write req; conn=1
handle=0x001c
000978 [ts=7640584ssb, mod=64 level=1] subscribe event; conn_handle=1
attr_handle=27 reason=1 prevn=0 curn=0 previ=0 curi=1
000979 [ts=7648396ssb, mod=4 level=0] txed att command: write rsp; conn=1
000979 [ts=7648396ssb, mod=4 level=0] host tx hci data; handle=1 length=5
000980 [ts=7656208ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x05
0x00 0x01 0x00 0x04 0x00 0x13
000980 [ts=7656208ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
000981 [ts=7664020ssb, mod=4 level=0] handle:1 pkts:1
000985 [ts=7695268ssb, mod=4 level=0] ble_hs_hci_evt_acl_process():
conn_handle=1 pb=2 len=9 data=0x05 0x00 0x04 0x00 0x12 0x20 0x00 0x01 0x00
000986 [ts=7703080ssb, mod=4 level=0] rxed att command: write req; conn=1
handle=0x0020
000986 [ts=7703080ssb, mod=64 level=1] subscribe event; conn_handle=1
attr_handle=31 reason=1 prevn=0 curn=1 previ=0 curi=0
000987 [ts=7710892ssb, mod=4 level=0] txed att command: write rsp; conn=1
000987 [ts=7710892ssb, mod=4 level=0] host tx hci data; handle=1 length=5
000987 [ts=7710892ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x05
0x00 0x01 0x00 0x04 0x00 0x13
000988 [ts=7718704ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
000988 [ts=7718704ssb, mod=4 level=0] handle:1 pkts:1
000993 [ts=7757764ssb, mod=4 level=0] ble_hs_hci_evt_acl_process():
conn_handle=1 pb=2 len=15 data=0x0b 0x00 0x04 0x00 0x52 0x1f 0x00 0x00 0x00
0x00 0x00 0x00 0x00 0x00 0x03
000993 [ts=7757764ssb, mod=4 level=0] rxed att command: write cmd; conn=1
handle=0x001f
000994 [ts=7765576ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
000994 [ts=7765576ssb, mod=4 level=0] handle:1 pkts:1
000995 [ts=7773388ssb, mod=4 level=1] GATT procedure initiated: notify;
att_handle=31
000996 [ts=7781200ssb, mod=4 level=0] txed att command: notify req; conn=1
handle=0x001f
000996 [ts=7781200ssb, mod=4 level=0] host tx hci data; handle=1 length=108
000997 [ts=7789012ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x6c
0x00 0x68 0x00 0x04 0x00 0x1b 0x1f 0x00 0x01 0x00 0x02 0x6c 0x00 0x00 0x00
0x03 0xbf 0x62 0x72 0x63 0x00 0x66 0x6d 0x70 0x6f 0x6f 0x6c 0x73 0xbf 0x66
0x6d 0x73 0x79 0x73 0x5f 0x31 0xbf 0x66 0x62 0x6c 0x6b 0x73 0x69 0x7a 0x19
0x01 0x24 0x65 0x6e 0x62 0x6c 0x6b 0x73 0x0c 0x65 0x6e 0x66 0x72 0x65 0x65
0x09 0x63 0x6d 0x69 0x6e 0x08 0xff 0x77 0x62 0x6c 0x65 0x5f 0x68 0x63 0x69
0x5f 0x72 0x61 0x6d 0x5f 0x65 0x76 0x74 0x5f 0x68 0x69 0x5f 0x70 0x6f 0x6f
0x6c 0xbf 0x66 0x62 0x6c 0x6b 0x73 0x69 0x7a 0x18 0x48 0x65 0x6e 0x62 0x6c
0x6b 0x73 0x02 0x65
001002 [ts=7828072ssb, mod=4 level=1] GATT procedure initiated: notify;
att_handle=31
001003 [ts=7835884ssb, mod=4 level=0] txed att command: notify req; conn=1
handle=0x001f
001003 [ts=7835884ssb, mod=4 level=0] host tx hci data; handle=1 length=108
001003 [ts=7835884ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x6c
0x00 0x68 0x00 0x04 0x00 0x1b 0x1f 0x00 0x6e 0x66 0x72 0x65 0x65 0x02 0x63
0x6d 0x69 0x6e 0x00 0xff 0x77 0x62 0x6c 0x65 0x5f 0x68 0x63 0x69 0x5f 0x72
0x61 0x6d 0x5f 0x65 0x76 0x74 0x5f 0x6c 0x6f 0x5f 0x70 0x6f 0x6f 0x6c 0xbf
0x66 0x62 0x6c 0x6b 0x73 0x69 0x7a 0x18 0x48 0x65 0x6e 0x62 0x6c 0x6b 0x73
0x08 0x65 0x6e 0x66 0x72 0x65 0x65 0x08 0x63 0x6d 0x69 0x6e 0x08 0xff 0x72
0x62 0x6c 0x65 0x5f 0x68 0x73 0x5f 0x68 0x63 0x69 0x5f 0x65 0x76 0x5f 0x70
0x6f 0x6f 0x6c 0xbf 0x66 0x62 0x6c 0x6b 0x73 0x69 0x7a 0x10 0x65 0x6e 0x62
0x6c 0x6b 0x73 0x0a
001009 [ts=7882756ssb, mod=4 level=1] GATT procedure initiated: notify;
att_handle=31
001010 [ts=7890568ssb, mod=4 level=0] txed att command: notify req; conn=1
handle=0x001f
001010 [ts=7890568ssb, mod=4 level=0] host tx hci data; handle=1 length=108
001010 [ts=7890568ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x6c
0x00 0x68 0x00 0x04 0x00 0x1b 0x1f 0x00 0x65 0x6e 0x66 0x72 0x65 0x65 0x0a
0x63 0x6d 0x69 0x6e 0x09 0xff 0x70 0x62 0x6c 0x65 0x5f 0x68 0x73 0x5f 0x63
0x6f 0x6e 0x6e 0x5f 0x70 0x6f 0x6f 0x6c 0xbf 0x66 0x62 0x6c 0x6b 0x73 0x69
0x7a 0x18 0x54 0x65 0x6e 0x62 0x6c 0x6b 0x73 0x01 0x65 0x6e 0x66 0x72 0x65
0x65 0x00 0x63 0x6d 0x69 0x6e 0x00 0xff 0x73 0x62 0x6c 0x65 0x5f 0x6c 0x32
0x63 0x61 0x70 0x5f 0x63 0x68 0x61 0x6e 0x5f 0x70 0x6f 0x6f 0x6c 0xbf 0x66
0x62 0x6c 0x6b 0x73 0x69 0x7a 0x18 0x1c 0x65 0x6e 0x62 0x6c 0x6b 0x73 0x03
0x65 0x6e 0x66 0x72
001016 [ts=7937440ssb, mod=4 level=1] GATT procedure initiated: notify;
att_handle=31
001017 [ts=7945252ssb, mod=4 level=0] txed att command: notify req; conn=1
handle=0x001f
001017 [ts=7945252ssb, mod=4 level=0] host tx hci data; handle=1 length=108
001017 [ts=7945252ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x6c
0x00 0x68 0x00 0x04 0x00 0x1b 0x1f 0x00 0x65 0x65 0x00 0x63 0x6d 0x69 0x6e
0x00 0xff 0x77 0x62 0x6c 0x65 0x5f 0x6c 0x32 0x63 0x61 0x70 0x5f 0x73 0x69
0x67 0x5f 0x70 0x72 0x6f 0x63 0x5f 0x70 0x6f 0x6f 0x6c 0xbf 0x66 0x62 0x6c
0x6b 0x73 0x69 0x7a 0x14 0x65 0x6e 0x62 0x6c 0x6b 0x73 0x01 0x65 0x6e 0x66
0x72 0x65 0x65 0x01 0x63 0x6d 0x69 0x6e 0x01 0xff 0x78 0x1b 0x62 0x6c 0x65
0x5f 0x61 0x74 0x74 0x5f 0x73 0x76 0x72 0x5f 0x70 0x72 0x65 0x70 0x5f 0x65
0x6e 0x74 0x72 0x79 0x5f 0x70 0x6f 0x6f 0x6c 0xbf 0x66 0x62 0x6c 0x6b 0x73
0x69 0x7a 0x0c 0x65
001023 [ts=7992124ssb, mod=4 level=1] GATT procedure initiated: notify;
att_handle=31
001024 [ts=8000000ssb, mod=4 level=1] GATT procedure initiated: notify;
att_handle=31
001024 [ts=8000000ssb, mod=4 level=0] txed att command: notify req; conn=1
handle=0x001f
001024 [ts=8000000ssb, mod=4 level=0] host tx hci data; handle=1 length=108
001025 [ts=8007812ssb, mod=4 level=0] ble_hs_hci_acl_tx(): 0x01 0x00 0x6c
0x00 0x68 0x00 0x04 0x00 0x1b 0x1f 0x00 0x6b 0x73 0x04 0x65 0x6e 0x66 0x72
0x65 0x65 0x04 0x63 0x6d 0x69 0x6e 0x04 0xff 0x76 0x62 0x6c 0x65 0x5f 0x61
0x74 0x74 0x5f 0x73 0x76 0x72 0x5f 0x65 0x6e 0x74 0x72 0x79 0x5f 0x70 0x6f
0x6f 0x6c 0xbf 0x66 0x62 0x6c 0x6b 0x73 0x69 0x7a 0x14 0x65 0x6e 0x62 0x6c
0x6b 0x73 0x18 0x25 0x65 0x6e 0x66 0x72 0x65 0x65 0x00 0x63 0x6d 0x69 0x6e
0x00 0xff 0x76 0x62 0x6c 0x65 0x5f 0x67 0x61 0x74 0x74 0x73 0x5f 0x63 0x6c
0x74 0x5f 0x63 0x66 0x67 0x5f 0x70 0x6f 0x6f 0x6c 0xbf 0x66 0x62 0x6c 0x6b
0x73 0x69 0x7a 0x10
001030 [ts=8046872ssb, mod=4 level=1] GATT procedure initiated: notify;
att_handle=31
001037 [ts=8101556ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
001037 [ts=8101556ssb, mod=4 level=0] handle:1 pkts:1
001039 [ts=8117180ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
001039 [ts=8117180ssb, mod=4 level=0] handle:1 pkts:1
001043 [ts=8148428ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
001043 [ts=8148428ssb, mod=4 level=0] handle:1 pkts:1
001045 [ts=8164052ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
001045 [ts=8164052ssb, mod=4 level=0] handle:1 pkts:1
001048 [ts=8187488ssb, mod=4 level=0] Number of Completed Packets:
num_handles=1
001049 [ts=8195300ssb, mod=4 level=0] handle:1 pkts:1
On Tue, Jun 6, 2017 at 8:21 PM, Jacob Rosenthal <[email protected]>
> mpstats (on nrf51) hangs indefinately
> -------------------------------------
>
> Key: MYNEWT-756
> URL: https://issues.apache.org/jira/browse/MYNEWT-756
> Project: Mynewt
> Issue Type: Bug
> Security Level: Public(Viewable by anyone)
> Components: Newt
> Reporter: Jacob
> Assignee: Christopher Collins
> Fix For: v1_1_0_rel
>
>
> I believe core is failing before sending the last packet, as neither newtmgr
> or node-newtmgr receives that packet.
> Jacobs-MacBook-Air:newtmgr jacobrosenthal$ GODEBUG=cgocheck=0 newtmgr mpstats
> -cnimble_bleprph -t -ldebug
> 2017/05/11 22:28:46 [DEBUG] BLE Connection devaddr:[]
> 2017/05/11 22:28:46 [DEBUG] State:PoweredOn
> 2017/05/11 22:28:46 [DEBUG] scanning...
> 2017/05/11 22:28:46 [DEBUG] Peripheral Discovered: , Address:[0 0 0 0 0 0]
> Address Type:0
> 2017/05/11 22:28:47 Unhandled event: xpc.Dict{"kCBMsgId":53,
> "kCBMsgArgs":xpc.Dict{"kCBMsgArgDeviceUUID":xpc.UUID{0x2f, 0xd, 0xcb, 0x60,
> 0xf, 0x3e, 0x47, 0x52, 0xb7, 0x74, 0x13, 0x29, 0x3a, 0x3, 0xd4, 0xd0},
> "kCBMsgArgATTMTU":104}}
> 2017/05/11 22:28:47 [DEBUG] Peripheral Connected
> 2017/05/11 22:28:47 [DEBUG] Newtmgr Service Found
> 2017/05/11 22:28:47 [DEBUG] Newtmgr Characteristic Found
> 2017/05/11 22:28:47 [DEBUG] Writing newtmgr request &{Op:0 Flags:0 Len:0
> Group:0 Seq:0 Id:3 Data:[]}
> 2017/05/11 22:28:47 [DEBUG] Serializing request &{Op:0 Flags:0 Len:0 Group:0
> Seq:0 Id:3 Data:[]} into buffer [0 0 0 0 0 0 0 3]
> 2017/05/11 22:28:47 [DEBUG] Tx packet dump:
> 00000000 00 00 00 00 00 00 00 03 |........|
> 2017/05/11 22:28:47 [DEBUG] Write BLE Packet:buf:: len::8
> 2017/05/11 22:28:47 [DEBUG] Read BLE
> Packet:buf::l?brcfmpools?fmsys_1?fblksiz$enblks
>
> enfree cmin?wble_hci_ram_evt_hi_pool?fblksizHenblkse len::101
> 2017/05/11 22:28:47 [DEBUG] Rx packet dump:
> 00000000 01 00 02 6c 00 00 00 03 bf 62 72 63 00 66 6d 70 |...l.....brc.fmp|
> 00000010 6f 6f 6c 73 bf 66 6d 73 79 73 5f 31 bf 66 62 6c |ools.fmsys_1.fbl|
> 00000020 6b 73 69 7a 19 01 24 65 6e 62 6c 6b 73 0c 65 6e |ksiz..$enblks.en|
> 00000030 66 72 65 65 09 63 6d 69 6e 00 ff 77 62 6c 65 5f |free.cmin..wble_|
> 00000040 68 63 69 5f 72 61 6d 5f 65 76 74 5f 68 69 5f 70 |hci_ram_evt_hi_p|
> 00000050 6f 6f 6c bf 66 62 6c 6b 73 69 7a 18 48 65 6e 62 |ool.fblksiz.Henb|
> 00000060 6c 6b 73 02 65 |lks.e|
> 2017/05/11 22:28:47 [DEBUG] Deserialized response &{Op:1 Flags:0 Len:620
> Group:0 Seq:0 Id:3 Data:[191 98 114 99 0 102 109 112 111 111 108 115 191 102
> 109 115 121 115 95 49 191 102 98 108 107 115 105 122 25 1 36 101 110 98 108
> 107 115 12 101 110 102 114 101 101 9 99 109 105 110 0 255 119 98 108 101 95
> 104 99 105 95 114 97 109 95 101 118 116 95 104 105 95 112 111 111 108 191 102
> 98 108 107 115 105 122 24 72 101 110 98 108 107 115 2 101]}
> 2017/05/11 22:28:47 [DEBUG] Read BLE
> Packet:buf::nfreecmin?wble_hci_ram_evt_lo_pool?fblksizHenblkenfrecmi?rble_hs_hci_ev_pool?fblksizenblks
> len::101
> 2017/05/11 22:28:47 [DEBUG] Rx packet dump:
> 00000000 6e 66 72 65 65 02 63 6d 69 6e 00 ff 77 62 6c 65 |nfree.cmin..wble|
> 00000010 5f 68 63 69 5f 72 61 6d 5f 65 76 74 5f 6c 6f 5f |_hci_ram_evt_lo_|
> 00000020 70 6f 6f 6c bf 66 62 6c 6b 73 69 7a 18 48 65 6e |pool.fblksiz.Hen|
> 00000030 62 6c 6b 73 08 65 6e 66 72 65 65 08 63 6d 69 6e |blks.enfree.cmin|
> 00000040 08 ff 72 62 6c 65 5f 68 73 5f 68 63 69 5f 65 76 |..rble_hs_hci_ev|
> 00000050 5f 70 6f 6f 6c bf 66 62 6c 6b 73 69 7a 10 65 6e |_pool.fblksiz.en|
> 00000060 62 6c 6b 73 0a |blks.|
> 2017/05/11 22:28:47 [DEBUG] Read BLE Packet:buf::enfree
> cmin
> ?pble_hs_conn_pool?fblksizTenblksenfreecmin?sble_l2cap_chan_pool?fblksizenblksenfr
> len::101
> 2017/05/11 22:28:47 [DEBUG] Rx packet dump:
> 00000000 65 6e 66 72 65 65 0a 63 6d 69 6e 09 ff 70 62 6c |enfree.cmin..pbl|
> 00000010 65 5f 68 73 5f 63 6f 6e 6e 5f 70 6f 6f 6c bf 66 |e_hs_conn_pool.f|
> 00000020 62 6c 6b 73 69 7a 18 54 65 6e 62 6c 6b 73 01 65 |blksiz.Tenblks.e|
> 00000030 6e 66 72 65 65 00 63 6d 69 6e 00 ff 73 62 6c 65 |nfree.cmin..sble|
> 00000040 5f 6c 32 63 61 70 5f 63 68 61 6e 5f 70 6f 6f 6c |_l2cap_chan_pool|
> 00000050 bf 66 62 6c 6b 73 69 7a 18 1c 65 6e 62 6c 6b 73 |.fblksiz..enblks|
> 00000060 03 65 6e 66 72 |.enfr|
> 2017/05/11 22:28:47 [DEBUG] Read BLE
> Packet:buf::eecmin?wble_l2cap_sig_proc_pool?fblksizenblksenfreecmin?xle_att_svr_prep_entry_pool?fblksiz
>
> e len::101
> 2017/05/11 22:28:47 [DEBUG] Rx packet dump:
> 00000000 65 65 00 63 6d 69 6e 00 ff 77 62 6c 65 5f 6c 32 |ee.cmin..wble_l2|
> 00000010 63 61 70 5f 73 69 67 5f 70 72 6f 63 5f 70 6f 6f |cap_sig_proc_poo|
> 00000020 6c bf 66 62 6c 6b 73 69 7a 14 65 6e 62 6c 6b 73 |l.fblksiz.enblks|
> 00000030 01 65 6e 66 72 65 65 01 63 6d 69 6e 01 ff 78 1b |.enfree.cmin..x.|
> 00000040 62 6c 65 5f 61 74 74 5f 73 76 72 5f 70 72 65 70 |ble_att_svr_prep|
> 00000050 5f 65 6e 74 72 79 5f 70 6f 6f 6c bf 66 62 6c 6b |_entry_pool.fblk|
> 00000060 73 69 7a 0c 65 |siz.e|
> 2017/05/11 22:28:47 [DEBUG] Read BLE
> Packet:buf::ksenfreecmin?vble_att_svr_entry_pool?fblksizenblks%enfreecmin?vble_gatts_clt_cfg_pool?fblksiz
> len::101
> 2017/05/11 22:28:47 [DEBUG] Rx packet dump:
> 00000000 6b 73 04 65 6e 66 72 65 65 04 63 6d 69 6e 04 ff |ks.enfree.cmin..|
> 00000010 76 62 6c 65 5f 61 74 74 5f 73 76 72 5f 65 6e 74 |vble_att_svr_ent|
> 00000020 72 79 5f 70 6f 6f 6c bf 66 62 6c 6b 73 69 7a 14 |ry_pool.fblksiz.|
> 00000030 65 6e 62 6c 6b 73 18 25 65 6e 66 72 65 65 00 63 |enblks.%enfree.c|
> 00000040 6d 69 6e 00 ff 76 62 6c 65 5f 67 61 74 74 73 5f |min..vble_gatts_|
> 00000050 63 6c 74 5f 63 66 67 5f 70 6f 6f 6c bf 66 62 6c |clt_cfg_pool.fbl|
> 00000060 6b 73 69 7a 10
--
This message was sent by Atlassian JIRA
(v6.3.15#6346)
