[ https://issues.apache.org/jira/browse/MYNEWT-572?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15889428#comment-15889428 ]
Jacob commented on MYNEWT-572: ------------------------------ Im still getting this..Im only tested with the nmgr_shell. Blesplit and bleprph, config below. Actually also happens on newtmgr image list. It turns out it only happens after a newtmgr image test command I believe. ### Package: targets/split-nrf51dk pkg.name: "targets/split-nrf51dk" pkg.type: "target" pkg.description: pkg.author: pkg.homepage: pkg.deps: - "@apache-mynewt-core/mgmt/newtmgr/transport/nmgr_shell" ### Package: targets/split-nrf51dk syscfg.vals: SHELL_TASK: 1 #needed for nmgr_shell #space and ram savings BLE_LL_CFG_FEAT_LE_ENCRYPTION: 0 BLE_SM_LEGACY: 0 MSYS_1_BLOCK_COUNT: 8 #12 MSYS_1_BLOCK_SIZE: 76 #292 # 76 lowest, 80 for multi-adv BLE_LL_NUM_SCAN_DUP_ADVS: 0 #8 tested safe BLE_LL_NUM_SCAN_RSP_ADVS: 0 #8 tested safe BLE_LL_WHITELIST_SIZE: 0 #8 BLE_LL_RESOLV_LIST_SIZE: 0 #4 ### Target: targets/split-nrf51dk target.app: "@apache-mynewt-core/apps/blesplit" target.bsp: "@apache-mynewt-core/hw/bsp/nrf51dk-16kbram" target.build_profile: "optimized" target.loader: "@apache-mynewt-core/apps/bleprph" > newtmgr reset command succeeds under the hood, yet fails to recover > ------------------------------------------------------------------- > > Key: MYNEWT-572 > URL: https://issues.apache.org/jira/browse/MYNEWT-572 > Project: Mynewt > Issue Type: Bug > Components: Newtmgr > Environment: develop branch > macos > nrf51-16kbram target > Reporter: Jacob > Assignee: Christopher Collins > Fix For: v1_0_0_rel > > > The reset after image confirm is successful, but newtmgr is having trouble > recovering from the command: > Ive seen it error like this: > Jacobs-MacBook-Air:mynewt-hr-observer jacobrosenthal$ newtmgr reset -cserial1 > -t -ldebug > 2017/01/25 17:13:31 [DEBUG] Writing newtmgr request &{Op:2 Flags:0 Len:2 > Group:0 Seq:0 Id:5 Data:[123 125]} > 2017/01/25 17:13:31 [DEBUG] Serializing request &{Op:2 Flags:0 Len:2 Group:0 > Seq:0 Id:5 Data:[123 125]} into buffer [2 0 0 2 0 0 0 5 123 125] > 2017/01/25 17:13:31 [DEBUG] Tx packet dump: > 00000000 02 00 00 02 00 00 00 05 7b 7d |........{}| > 2017/01/25 17:13:31 [INFO] Outgoing: > 00000000 06 09 |..| > 2017/01/25 17:13:31 [DEBUG] Writing [6 9] to data channel > 2017/01/25 17:13:31 [INFO] Outgoing: > 00000000 41 41 77 43 41 41 41 43 41 41 41 41 42 58 74 39 |AAwCAAACAAAABXt9| > 00000010 4c 67 41 3d |LgA=| > 2017/01/25 17:13:31 [DEBUG] Writing [65 65 119 67 65 65 65 67 65 65 65 65 66 > 88 116 57 76 103 65 61] to data channel > 2017/01/25 17:13:31 [INFO] Outgoing: > 00000000 0a |.| > 2017/01/25 17:13:31 [DEBUG] Writing [10] to data channel > 2017/01/25 17:13:44 [INFO] Incoming: > 00000000 06 09 41 41 77 43 41 41 41 43 41 41 41 41 42 58 |..AAwCAAACAAAABX| > 00000010 74 39 4c 67 41 3d 31 3a |t9LgA=1:| > 2017/01/25 17:13:44 [DEBUG] Reading [6 9 65 65 119 67 65 65 65 67 65 65 65 65 > 66 88 116 57 76 103 65 61 49 58] from data channel > 2017/01/25 17:13:44 [INFO] Message: base64 decode error > 2017/01/25 17:13:44 [DEBUG] goroutine 1 [running]: > mynewt.apache.org/newt/newtmgr/vendor/mynewt.apache.org/newt/util.NewNewtError(0xc420160380, > 0xdd, 0xc42004bb50) > > /Users/jacobrosenthal/dev/go/src/mynewt.apache.org/newt/newtmgr/vendor/mynewt.apache.org/newt/util/util.go:75 > +0x111 > mynewt.apache.org/newt/newtmgr/transport.(*ConnSerial).ReadPacket(0xc420140870, > 0xc420146c00, 0x4080a8a, 0xc420140870) > > /Users/jacobrosenthal/dev/go/src/mynewt.apache.org/newt/newtmgr/transport/connserial.go:149 > +0x7b2 > mynewt.apache.org/newt/newtmgr/protocol.(*CmdRunner).ReadResp(0xc42015f210, > 0xc4201468c0, 0x0, 0x0) > > /Users/jacobrosenthal/dev/go/src/mynewt.apache.org/newt/newtmgr/protocol/cmdrunner.go:42 > +0x9c > mynewt.apache.org/newt/newtmgr/cli.resetRunCmd(0xc42016c240, 0xc420140630, > 0x0, 0x3) > > /Users/jacobrosenthal/dev/go/src/mynewt.apache.org/newt/newtmgr/cli/reset.go:50 > +0x1ab > mynewt.apache.org/newt/newtmgr/vendor/github.com/spf13/cobra.(*Command).execute(0xc42016c240, > 0xc420140480, 0x3, 0x3, 0xc42016c240, 0xc420140480) > > /Users/jacobrosenthal/dev/go/src/mynewt.apache.org/newt/newtmgr/vendor/github.com/spf13/cobra/command.go:636 > +0x443 > mynewt.apache.org/newt/newtmgr/vendor/github.com/spf13/cobra.(*Command).ExecuteC(0xc420166000, > 0xc420166b40, 0xc420166240, 0xc42015eec0) > > /Users/jacobrosenthal/dev/go/src/mynewt.apache.org/newt/newtmgr/vendor/github.com/spf13/cobra/command.go:722 > +0x367 > mynewt.apache.org/newt/newtmgr/vendor/github.com/spf13/cobra.(*Command).Execute(0xc420166000, > 0x40d65bc, 0xc4200001a0) > > /Users/jacobrosenthal/dev/go/src/mynewt.apache.org/newt/newtmgr/vendor/github.com/spf13/cobra/command.go:681 > +0x2b > main.main() > > /Users/jacobrosenthal/dev/go/src/mynewt.apache.org/newt/newtmgr/newtmgr.go:25 > +0x2f > goroutine 17 [syscall, locked to thread]: > runtime.goexit() > /usr/local/Cellar/go/1.7.4_1/libexec/src/runtime/asm_amd64.s:2086 +0x1 > goroutine 5 [syscall]: > os/signal.signal_recv(0x0) > /usr/local/Cellar/go/1.7.4_1/libexec/src/runtime/sigqueue.go:116 +0x157 > os/signal.loop() > /usr/local/Cellar/go/1.7.4_1/libexec/src/os/signal/signal_unix.go:22 > +0x22 > created by os/signal.init.1 > /usr/local/Cellar/go/1.7.4_1/libexec/src/os/signal/signal_unix.go:28 > +0x41 > Error: Couldn't decode base64 string: AAwCAAACAAAABXt9LgA=1: > Packet hex dump: > 00000000 06 09 41 41 77 43 41 41 41 43 41 41 41 41 42 58 |..AAwCAAACAAAABX| > 00000010 74 39 4c 67 41 3d 31 3a |t9LgA=1:| > reset - Send reset request to remote endpoint using newtmgr > Usage: > newtmgr reset [flags] > Global Flags: > -c, --conn string connection profile to use. > -l, --loglevel string log level to use (default INFO.) (default "info") > -t, --trace print all bytes transmitted and received > Jacobs-MacBook-Air:mynewt-hr-observer jacobrosenthal$ > And Ive seen it hang forever: > Jacobs-MacBook-Air:apache-mynewt-core jacobrosenthal$ newtmgr -lDEBUG -c > serial1 reset > 2017/01/26 16:00:25 [DEBUG] Writing newtmgr request &{Op:2 Flags:0 Len:2 > Group:0 Seq:0 Id:5 Data:[123 125]} > 2017/01/26 16:00:25 [DEBUG] Serializing request &{Op:2 Flags:0 Len:2 Group:0 > Seq:0 Id:5 Data:[123 125]} into buffer [2 0 0 2 0 0 0 5 123 125] > 2017/01/26 16:00:25 [DEBUG] Tx packet dump: > 00000000 02 00 00 02 00 00 00 05 7b 7d |........{}| > 2017/01/26 16:00:25 [DEBUG] Writing [6 9] to data channel > 2017/01/26 16:00:25 [DEBUG] Writing [65 65 119 67 65 65 65 67 65 65 65 65 66 > 88 116 57 76 103 65 61] to data channel > 2017/01/26 16:00:25 [DEBUG] Writing [10] to data channel -- This message was sent by Atlassian JIRA (v6.3.15#6346)