Boron device not able to connect to Particle cloud

Cloud
1

I have a Particle Boron LTE running 6.2.1 and it keeps getting an error in connecting to the Particle cloud. It was connected a few years ago but was recently unclaimed by a co-worker so that I could claim it and assign it to my account.

Here is a startup log of the device:

0000025849 [ncp.at] TRACE: < CONNECT 150000000
0000025849 [net.ppp.client] TRACE: PPP phase -> Initialize
0000025850 [net.ppp.client] TRACE: PPP phase -> Establish
0000025851 [lwip.ppp] TRACE: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x5852583b> <pcomp> <accomp>]
0000026003 [lwip.ppp] TRACE: rcvd [LCP ConfReq id=0x0 <asyncmap 0x0> <auth 0xc223 05> <magic 0xd1e797af> <pcomp> <accomp>]
0000026006 [lwip.ppp] TRACE: sent [LCP ConfNak id=0x0 <auth pap>]
0000026007 [lwip.ppp] TRACE: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0x5852583b> <pcomp> <accomp>]
0000027262 [lwip.ppp] TRACE: rcvd [LCP ConfReq id=0x1 <asyncmap 0x0> <auth pap> <magic 0xd1e797af> <pcomp> <accomp>]
0000027263 [lwip.ppp] TRACE: sent [LCP ConfAck id=0x1 <asyncmap 0x0> <auth pap> <magic 0xd1e797af> <pcomp> <accomp>]
0000027264 [lwip.ppp] TRACE: sent [LCP EchoReq id=0x0 magic=0x5852583b]
0000027265 [net.ppp.client] TRACE: PPP phase -> Authenticate
0000027265 [lwip.ppp] TRACE: sent [PAP AuthReq id=0x1 user="" password=""]
0000028542 [lwip.ppp] TRACE: rcvd [LCP ConfReq id=0x2 <asyncmap 0x0> <auth pap> <magic 0xd1e797af> <pcomp> <accomp>]
0000028543 [lwip.ppp] TRACE: sent [LCP ConfAck id=0x2 <asyncmap 0x0> <auth pap> <magic 0xd1e797af> <pcomp> <accomp>]
0000029822 [lwip.ppp] TRACE: rcvd [LCP ConfReq id=0x3 <asyncmap 0x0> <auth pap> <magic 0xd1e797af> <pcomp> <accomp>]
0000029823 [lwip.ppp] TRACE: sent [LCP ConfAck id=0x3 <asyncmap 0x0> <auth pap> <magic 0xd1e797af> <pcomp> <accomp>]
0000031102 [lwip.ppp] TRACE: rcvd [LCP ConfReq id=0x4 <asyncmap 0x0> <auth pap> <magic 0xd1e797af> <pcomp> <accomp>]
0000031103 [lwip.ppp] TRACE: sent [LCP ConfAck id=0x4 <asyncmap 0x0> <auth pap> <magic 0xd1e797af> <pcomp> <accomp>]
0000032265 [lwip.ppp] TRACE: sent [LCP EchoReq id=0x1 magic=0x5852583b]
0000032275 [lwip.ppp] TRACE: rcvd [LCP ConfReq id=0x5 <asyncmap 0x0> <auth pap> <magic 0xd1e797af> <pcomp> <accomp>]
0000032276 [lwip.ppp] TRACE: sent [LCP ConfAck id=0x5 <asyncmap 0x0> <auth pap> <magic 0xd1e797af> <pcomp> <accomp>]
0000032416 [lwip.ppp] TRACE: rcvd [LCP ConfReq id=0x6 <asyncmap 0x0> <auth pap> <magic 0xd1e797af> <pcomp> <accomp>]
0000032417 [lwip.ppp] TRACE: sent [LCP ConfAck id=0x6 <asyncmap 0x0> <auth pap> <magic 0xd1e797af> <pcomp> <accomp>]
0000033266 [lwip.ppp] TRACE: sent [PAP AuthReq id=0x2 user="" password=""]
0000033277 [lwip.ppp] TRACE: rcvd [LCP DiscReq id=0x7 magic=0xd1e797af]
0000033279 [lwip.ppp] TRACE: rcvd [PAP AuthAck id=0x2 ""]
0000033279 [net.ppp.client] TRACE: PPP phase -> Network
0000033280 [lwip.ppp] TRACE: sent [IPCP ConfReq id=0x1 <addr 0.0.0.0> <msdns1 8.8.8.8> <msdns2 8.8.4.4>]
0000033664 [lwip.ppp] TRACE: rcvd [IPCP ConfReq id=0x0]
0000033665 [lwip.ppp] TRACE: sent [IPCP ConfAck id=0x0]
0000033667 [lwip.ppp] TRACE: rcvd [IPCP ConfNak id=0x1 <addr 100.76.216.170> <msdns1 8.8.4.4> <msdns2 8.8.8.8>]
0000033668 [lwip.ppp] TRACE: sent [IPCP ConfReq id=0x2 <addr 100.76.216.170> <msdns1 8.8.4.4> <msdns2 8.8.8.8>]
0000034945 [lwip.ppp] TRACE: rcvd [IPCP ConfAck id=0x2 <addr 100.76.216.170> <msdns1 8.8.4.4> <msdns2 8.8.8.8>]
0000034948 [system.nm] INFO: State changed: IFACE_UP -> IFACE_LINK_UP
0000034949 [net.ppp.client] TRACE: PPP thread event UP data=0
0000034950 [net.ppp.client] TRACE: State CONNECTING -> CONNECTED
0000034950 [system.nm] INFO: State changed: IFACE_LINK_UP -> IP_CONFIGURED
0000034952 [net.ppp.client] TRACE: PPP phase -> Running
0000034953 [net.pppncp] TRACE: Negotiated MTU: 1500
0000035031 [system] INFO: Cloud: connecting
0000035033 [system] WARN: Failed to load session data from persistent storage
0000037551 [ncp.at] TRACE: < +CEREG: 5,"AE03","8739911",7
0000038833 [system] INFO: Cloud socket connected
0000038834 [comm.protocol.handshake] INFO: Establish secure connection
0000038837 [comm.dtls] INFO: (CMPL,RENEG,NO_SESS,ERR) restoreStatus=2
0000040975 [comm.protocol.handshake] INFO: Sending HELLO message
0000040975 [comm.coap] TRACE: Sending CoAP message
0000040976 [comm.coap] TRACE: CON POST /h size=39 token= id=1
0000045271 [comm.coap] TRACE: Retransmitting CoAP message; ID: 1; attempt 1 of 3
0000045271 [comm.coap] TRACE: Sending CoAP message
0000045272 [comm.coap] TRACE: CON POST /h size=39 token= id=1
0000049251 [ncp.at] TRACE: < +CEREG: 5,"AE03","873980F",7
0000056349 [comm.coap] TRACE: Retransmitting CoAP message; ID: 1; attempt 2 of 3
0000056349 [comm.coap] TRACE: Sending CoAP message
0000056350 [comm.coap] TRACE: CON POST /h size=39 token= id=1
0000058051 [ncp.at] TRACE: < +CEREG: 5,"AE03","8739911",7
0000073161 [comm.coap] TRACE: Retransmitting CoAP message; ID: 1; attempt 3 of 3
0000073161 [comm.coap] TRACE: Sending CoAP message
0000073162 [comm.coap] TRACE: CON POST /h size=39 token= id=1
0000118786 [comm.coap] ERROR: CoAP message timeout; ID: 1
0000118786 [comm.dtls] INFO: session cmd (CLS,DIS,MOV,LOD,SAV): 0
0000118788 [comm.protocol.handshake] ERROR: Could not send HELLO message: 10
2

That log typically indicates that the device is having trouble communicating by cellular. It was able to contact a tower, but was not able to connect to the cloud because too many packets were lost, either going to the tower, or coming back from the tower.

Double-check the antenna, and you could try moving to different location to see if that affects the problem.

3

I tried taking the device on a car ride and the blinking cyan light persisted. I'll try it again but could there by anything else?

4

I moved to a location that according to my phone was full bars 5G and this was the log transcript after a restart. Basically the same info is logged as far as I can tell:

0000001950 [ncp.at] TRACE: > AT
0000002951 [ncp.at] TRACE: > AT
0000003952 [ncp.at] TRACE: > AT
0000004953 [ncp.at] TRACE: > AT
0000004956 [ncp.at] TRACE: < OK
0000004956 [ncp.client] TRACE: NCP ready to accept AT commands
0000004957 [ncp.at] TRACE: > AT
0000004958 [ncp.at] TRACE: < OK
0000004958 [ncp.at] TRACE: > ATI9
0000004960 [ncp.at] TRACE: < L0.0.00.00.05.08,A.02.04
0000004960 [ncp.at] TRACE: < OK
0000004961 [ncp.client] TRACE: App firmware: 204
0000004961 [ncp.at] TRACE: > AT+UGPIOC?
0000004963 [ncp.at] TRACE: < +UGPIOC:
0000004963 [ncp.at] TRACE: < 7,255
0000004963 [ncp.at] TRACE: < 16,255
0000004964 [ncp.at] TRACE: < 19,255
0000004964 [ncp.at] TRACE: < 23,0
0000004965 [ncp.at] TRACE: < 24,255
0000004965 [ncp.at] TRACE: < 25,255
0000004966 [ncp.at] TRACE: < 42,255
0000004966 [ncp.at] TRACE: < OK
0000004967 [ncp.at] TRACE: > AT+UGPIOR=23
0000004969 [ncp.at] TRACE: < +UGPIOR: 23,1
0000004969 [ncp.at] TRACE: < OK
0000004969 [ncp.client] INFO: Using internal SIM card
0000004970 [ncp.at] TRACE: > AT+CPIN?
0000004972 [ncp.at] TRACE: < +CME ERROR: SIM not inserted
0000005972 [ncp.at] TRACE: > AT+CPIN?
0000005975 [ncp.at] TRACE: < +CPIN: READY
0000005975 [ncp.at] TRACE: < OK
0000005976 [ncp.at] TRACE: > AT+CCID
0000005978 [ncp.at] TRACE: < +CCID: 89883070000006631806
0000005979 [ncp.at] TRACE: < OK
0000005979 [ncp.at] TRACE: > AT+IFC?
0000005981 [ncp.at] TRACE: < +IFC: 2,2
0000005981 [ncp.at] TRACE: < OK
0000005981 [ncp.at] TRACE: > AT+CFUN=0,0
0000005989 [ncp.at] TRACE: < OK
0000005989 [ncp.at] TRACE: > AT+CFUN=1,0
0000005993 [ncp.at] TRACE: < OK
0000005993 [ncp.at] TRACE: > AT+CPIN?
0000005996 [ncp.at] TRACE: < +CPIN: READY
0000005996 [ncp.at] TRACE: < OK
0000005997 [ncp.at] TRACE: > AT+CCID
0000005999 [ncp.at] TRACE: < +CCID: 89883070000006631806
0000005999 [ncp.at] TRACE: < OK
0000005999 [ncp.at] TRACE: > AT+IFC?
0000006001 [ncp.at] TRACE: < +IFC: 2,2
0000006001 [ncp.at] TRACE: < OK
0000006001 [ncp.at] TRACE: > AT+IFC=2,2
0000006004 [ncp.at] TRACE: < OK
0000006004 [ncp.at] TRACE: > AT
0000006006 [ncp.at] TRACE: < OK
0000006006 [ncp.at] TRACE: > AT+IPR=460800
0000006013 [ncp.at] TRACE: < OK
0000007013 [ncp.at] TRACE: > AT
0000007016 [ncp.at] TRACE: < OK
0000007016 [ncp.at] TRACE: > AT+CCID
0000007019 [ncp.at] TRACE: < +CCID: 89883070000006631806
0000007019 [ncp.at] TRACE: < OK
0000007020 [ncp.at] TRACE: > AT+UMNOPROF?
0000007026 [ncp.at] TRACE: < +UMNOPROF: 100
0000007026 [ncp.at] TRACE: < OK
0000007026 [ncp.at] TRACE: > AT+UBANDMASK?
0000007030 [ncp.at] TRACE: < +UBANDMASK: 0,6170,1,524420
0000007030 [ncp.at] TRACE: < OK
0000007030 [ncp.at] TRACE: > AT+COPS=3,2
0000007033 [ncp.at] TRACE: < OK
0000007034 [ncp.at] TRACE: > AT+CGEREP=1,0
0000007036 [ncp.at] TRACE: < OK
0000007037 [ncp.at] TRACE: > AT+URAT?
0000007039 [ncp.at] TRACE: < +URAT: 7
0000007039 [ncp.at] TRACE: < OK
0000007040 [ncp.at] TRACE: > AT+CPSMS?
0000007045 [ncp.at] TRACE: < +CPSMS:0,,,"01100000","00000000"
0000007045 [ncp.at] TRACE: < OK
0000007045 [ncp.at] TRACE: > AT+CEDRXS?
0000007047 [ncp.at] TRACE: < +CEDRXS:
0000007048 [ncp.at] TRACE: < OK
0000007048 [ncp.at] TRACE: > AT+CMUX=0,0,,1509,,,,,
0000007053 [ncp.at] TRACE: < OK
0000007054 [mux] INFO: Starting GSM07.10 muxer
0000007055 [mux] INFO: Opening mux channel 0
0000007055 [mux] INFO: GSM07.10 muxer thread started
0000007058 [mux] INFO: Opening mux channel 1
0000007061 [ncp.at] TRACE: > AT
0000007066 [ncp.at] TRACE: < OK
0000007067 [ncp.client] TRACE: NCP state changed: 1
0000007067 [net.pppncp] TRACE: NCP event 1
0000007068 [net.ppp.client] TRACE: PPP thread event ADM_UP data=0
0000007069 [net.ppp.client] TRACE: State NONE -> READY
0000007071 [ncp.at] TRACE: > AT
0000007075 [ncp.at] TRACE: < OK
0000007075 [ncp.at] TRACE: > AT+CFUN?
0000007080 [ncp.at] TRACE: < +CFUN: 1
0000007080 [ncp.at] TRACE: < OK
0000007081 [ncp.at] TRACE: > AT+CCID
0000007086 [ncp.at] TRACE: < +CCID: 89883070000006631806
0000007086 [ncp.at] TRACE: < OK
0000007087 [ncp.at] TRACE: > AT+CGDCONT?
0000007093 [ncp.at] TRACE: < +CGDCONT: 1,"IP","super","0.0.0.0",0,0,0,0
0000007093 [ncp.at] TRACE: < OK
0000007094 [ncp.at] TRACE: > AT+CFUN?
0000007099 [ncp.at] TRACE: < +CFUN: 1
0000007099 [ncp.at] TRACE: < OK
0000007100 [ncp.at] TRACE: > AT+CEREG=2
0000007104 [ncp.at] TRACE: < OK
0000007104 [ncp.client] TRACE: NCP connection state changed: 1
0000007105 [net.pppncp] TRACE: NCP event 2
0000007105 [net.pppncp] TRACE: State changed event: 1
0000007106 [ncp.at] TRACE: > AT+COPS?
0000007106 [net.ppp.client] TRACE: PPP thread event LOWER_DOWN data=0
0000007110 [ncp.at] TRACE: < +COPS: 0
0000007111 [ncp.at] TRACE: < OK
0000007111 [ncp.at] TRACE: > AT+CEREG?
0000007116 [ncp.at] TRACE: < +CEREG: 2,2
0000007116 [ncp.at] TRACE: < OK
0000022217 [ncp.at] TRACE: > AT+CEREG?
0000022222 [ncp.at] TRACE: < +CEREG: 2,2
0000022223 [ncp.at] TRACE: < OK
0000022223 [ncp.at] TRACE: > AT+UCGED=5
0000022228 [ncp.at] TRACE: < OK
0000022229 [ncp.at] TRACE: > AT+UCGED?
0000022235 [ncp.at] TRACE: < +RSRP: 051,5110,"-059.40",
0000022235 [ncp.at] TRACE: < +RSRQ: 051,5110,"-15.90",
0000022236 [ncp.at] TRACE: < OK
0000024135 [ncp.at] TRACE: < +CEREG: 5,"AE03","873990F",7
0000024136 [ncp.client] TRACE: NCP connection state changed: 2
0000024136 [mux] INFO: Opening mux channel 2
0000025328 [net.pppncp] TRACE: NCP event 100
0000025328 [net.pppncp] TRACE: New auth info
0000025331 [net.pppncp] TRACE: NCP event 2
0000025331 [net.pppncp] TRACE: State changed event: 2
0000025332 [net.ppp.client] TRACE: PPP thread event LOWER_UP data=0
0000025333 [net.ppp.client] TRACE: State READY -> CONNECT
0000025333 [ncp.at] TRACE: > AT+CIMI
0000025335 [net.ppp.client] TRACE: State CONNECT -> CONNECTING
0000025339 [ncp.at] TRACE: < 732123200688189
0000025339 [ncp.at] TRACE: < OK
0000025340 [ncp.at] TRACE: > AT
0000025346 [ncp.at] TRACE: < OK
0000025347 [ncp.at] TRACE: > AT+CGATT?
0000025354 [ncp.at] TRACE: < +CGATT: 1
0000025354 [ncp.at] TRACE: < OK
0000026356 [ncp.at] TRACE: > AT
0000026363 [ncp.at] TRACE: < OK
0000026363 [ncp.at] TRACE: > ATD*99***1#
0000026370 [ncp.at] TRACE: < CONNECT 150000000
0000026371 [net.ppp.client] TRACE: PPP phase -> Initialize
0000026371 [net.ppp.client] TRACE: PPP phase -> Establish
0000026372 [lwip.ppp] TRACE: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x58525a40> <pcomp> <accomp>]
0000026520 [lwip.ppp] TRACE: rcvd [LCP ConfReq id=0x0 <asyncmap 0x0> <auth 0xc223 05> <magic 0xd271e621> <pcomp> <accomp>]
0000026522 [lwip.ppp] TRACE: sent [LCP ConfNak id=0x0 <auth pap>]
0000026524 [lwip.ppp] TRACE: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0x58525a40> <pcomp> <accomp>]
0000027127 [lwip.ppp] TRACE: rcvd [LCP ConfReq id=0x1 <asyncmap 0x0> <auth pap> <magic 0xd271e621> <pcomp> <accomp>]
0000027128 [lwip.ppp] TRACE: sent [LCP ConfAck id=0x1 <asyncmap 0x0> <auth pap> <magic 0xd271e621> <pcomp> <accomp>]
0000027129 [lwip.ppp] TRACE: sent [LCP EchoReq id=0x0 magic=0x58525a40]
0000027130 [net.ppp.client] TRACE: PPP phase -> Authenticate
0000027130 [lwip.ppp] TRACE: sent [PAP AuthReq id=0x1 user="" password=""]
0000027775 [lwip.ppp] TRACE: rcvd [LCP DiscReq id=0x2 magic=0xd271e621]
0000027777 [lwip.ppp] TRACE: rcvd [LCP EchoRep id=0x0 magic=0xd271e621 58 52 5a 40]
0000027779 [lwip.ppp] TRACE: rcvd [PAP AuthAck id=0x1 ""]
0000027779 [net.ppp.client] TRACE: PPP phase -> Network
0000027780 [lwip.ppp] TRACE: sent [IPCP ConfReq id=0x1 <addr 0.0.0.0> <msdns1 8.8.8.8> <msdns2 8.8.4.4>]
0000029057 [lwip.ppp] TRACE: rcvd [IPCP ConfReq id=0x0]
0000029058 [lwip.ppp] TRACE: sent [IPCP ConfAck id=0x0]
0000029060 [lwip.ppp] TRACE: rcvd [IPCP ConfNak id=0x1 <addr 100.77.172.14> <msdns1 8.8.4.4> <msdns2 8.8.8.8>]
0000029061 [lwip.ppp] TRACE: sent [IPCP ConfReq id=0x2 <addr 100.77.172.14> <msdns1 8.8.4.4> <msdns2 8.8.8.8>]
0000030337 [lwip.ppp] TRACE: rcvd [IPCP ConfReq id=0x1]
0000030338 [lwip.ppp] TRACE: sent [IPCP ConfAck id=0x1]
0000030340 [lwip.ppp] TRACE: rcvd [IPCP ConfAck id=0x2 <addr 100.77.172.14> <msdns1 8.8.4.4> <msdns2 8.8.8.8>]
0000030342 [system.nm] INFO: State changed: IFACE_UP -> IFACE_LINK_UP
0000030344 [system.nm] INFO: State changed: IFACE_LINK_UP -> IP_CONFIGURED
0000030345 [net.ppp.client] TRACE: PPP phase -> Running
0000030344 [net.ppp.client] TRACE: PPP thread event UP data=0
0000030346 [net.ppp.client] TRACE: State CONNECTING -> CONNECTED
0000030348 [net.pppncp] TRACE: Negotiated MTU: 1500
0000030348 [system] INFO: Cloud: connecting
0000030350 [system] WARN: Failed to load session data from persistent storage
0000031259 [lwip.ppp] TRACE: rcvd [IPCP ConfReq id=0x2]
0000031260 [lwip.ppp] TRACE: sent [IPCP ConfAck id=0x2]
0000032880 [system] INFO: Cloud socket connected
0000032880 [comm.protocol.handshake] INFO: Establish secure connection
0000032883 [comm.dtls] INFO: (CMPL,RENEG,NO_SESS,ERR) restoreStatus=2
0000034317 [comm.protocol.handshake] INFO: Sending HELLO message
0000034317 [comm.coap] TRACE: Sending CoAP message
0000034318 [comm.coap] TRACE: CON POST /h size=39 token= id=1
0000039801 [comm.coap] TRACE: Retransmitting CoAP message; ID: 1; attempt 1 of 3
0000039801 [comm.coap] TRACE: Sending CoAP message
0000039802 [comm.coap] TRACE: CON POST /h size=39 token= id=1
0000050941 [comm.coap] TRACE: Retransmitting CoAP message; ID: 1; attempt 2 of 3
0000050941 [comm.coap] TRACE: Sending CoAP message
0000050942 [comm.coap] TRACE: CON POST /h size=39 token= id=1
0000068659 [comm.coap] TRACE: Retransmitting CoAP message; ID: 1; attempt 3 of 3
0000068659 [comm.coap] TRACE: Sending CoAP message
0000068660 [comm.coap] TRACE: CON POST /h size=39 token= id=1
0000101346 [comm.coap] ERROR: CoAP message timeout; ID: 1
0000101346 [comm.dtls] INFO: session cmd (CLS,DIS,MOV,LOD,SAV): 0
0000101348 [comm.protocol.handshake] ERROR: Could not send HELLO message: 10
0000106887 [system] WARN: Internet available, cloud not reachable
0000106887 [system] WARN: Cloud handshake failed, code=-160
0000107137 [system] INFO: Cloud: disconnecting
0000107137 [system] INFO: Cloud: disconnected
0000107137 [system] INFO: Cloud: connecting
0000107139 [system] WARN: Failed to load session data from persistent storage
0000107141 [system] INFO: Cloud socket connected
5

Your device keys are out of sync with the cloud, which is causing its connection to be rejected by the cloud.

Set up the Particle CLI, connect the device by USB, then use these commands to reset the keys.

particle login
particle keys server
particle keys doctor

You can't tell only from your log, but the log contained your ICCID, which I could look up in the internal cloud logs, which indicate "udp verification failure," which is a keys issue. It's rare on Gen 3 devices, but can happen.

6

This solved it. Thanks!

1 Like