[00056920ms][DBG ][CELL]: callback: 4106, err: 0, data: 4097 [00056920ms][INFO][CELL]: Setup SIM (timeout 1000 ms) [00056921ms][DBG ][CELL]: AT flush [00056921ms][INFO][CELL]: AT TX ( 8): AT+CPIN? [00056922ms][INFO][CELL]: AT TX ( 1): [00056926ms][INFO][CELL]: AT RX ( 6): OK [00056932ms][WARN][CELL]: SIM state unknown [00056937ms][DBG ][CELL]: callback: 4097, err: 0, data: 3 [00056944ms][DBG ][CELL]: SIM pin: retry 3/10 [00056949ms][DBG ][CELL]: callback: CellularStateRetryEvent, err: 0, data: 4097, retrycount: 3 [00056958ms][INFO][CELL]: Continue after 8 seconds [00064964ms][DBG ][CELL]: callback: 4106, err: 0, data: 4097 [00064964ms][INFO][CELL]: Setup SIM (timeout 1000 ms) [00064965ms][DBG ][CELL]: AT flush [00064965ms][INFO][CELL]: AT TX ( 8): AT+CPIN? [00064966ms][INFO][CELL]: AT TX ( 1): [00064970ms][INFO][CELL]: AT RX (22): +CPIN: READYOK [00064979ms][INFO][CELL]: SIM is ready [00064983ms][DBG ][CELL]: callback: 4097, err: 0, data: 0 [00064990ms][DBG ][CELL]: Manual network registration to 46692 [00064996ms][INFO][CELL]: AT TX ( 8): AT+COPS= [00065002ms][INFO][CELL]: AT TX ( 1): 1 [00065006ms][INFO][CELL]: AT TX ( 1): , [00065011ms][INFO][CELL]: AT TX ( 1): 2 [00065016ms][INFO][CELL]: AT TX ( 1): , [00065021ms][INFO][CELL]: AT TX ( 1): " [00065026ms][INFO][CELL]: AT TX ( 5): 46692 [00065031ms][INFO][CELL]: AT TX ( 1): " [00065035ms][INFO][CELL]: AT TX ( 1): , [00065040ms][INFO][CELL]: AT TX ( 1): 9 [00065045ms][INFO][CELL]: AT TX ( 1): [00065271ms][INFO][CELL]: AT RX ( 6): +CME [00065271ms][INFO][CELL]: AT RX ( 8): ERROR: [00065272ms][INFO][CELL]: AT RX ( 4): 30 [00065273ms][WARN][CELL]: AT error code 30 [00065273ms][DBG ][CELL]: AT error -3012 [00065276ms][DBG ][CELL]: STM: set_registration: -3012, plmn: 46692 [00065283ms][DBG ][CELL]: SIM pin: retry 4/10 [00065289ms][DBG ][CELL]: callback: CellularStateRetryEvent, err: 0, data: 4097, retrycount: 4 [00065298ms][INFO][CELL]: Continue after 16 seconds ­'HàI_1k+Qa ¤¼!FãÜ9!ú ûÁ)"ûÁ)QaÂDa ÆÀqqo@qioñÜ1k´Æýsacàÿ 1k«s1kùÆ!Æ%"û¡0éÆÂ!Â#""BJ¦k"&B@¼¶¾!æä mbed-os-example-cellular Built: Jan 22 2020, 11:06:51 [MAIN], plmn: 46692 Establishing connection [00000001ms][DBG ][CELL]: MODEM default instance [00000002ms][DBG ][CELL]: STMOD_CELLULAR flow control: RTS 108 CTS 107 [00000003ms][DBG ][CELL]: STModCellular creation [00000457ms][INFO][CELL]: New CellularContext (0x200052b8) [00000457ms][INFO][CELL]: CellularContext plmn 46692 [00000458ms][INFO][CELL]: CellularContext connect [00000459ms][DBG ][CELL]: callback: 4106, err: 0, data: 4096 [00000459ms][INFO][CELL]: Start connecting (timeout 1000 ms) [00000467ms][INFO][CELL]: AT TX ( 2): AT [00000472ms][INFO][CELL]: AT TX ( 1): [00001468ms][DBG ][CELL]: AT error -3012 [00001468ms][INFO][CELL]: AT TX ( 2): AT [00001469ms][INFO][CELL]: AT TX ( 1): [00002469ms][DBG ][CELL]: AT error -3012 [00002469ms][DBG ][CELL]: Init => Power [00002470ms][DBG ][CELL]: callback: 4106, err: 0, data: 4096 [00002470ms][INFO][CELL]: Modem power ON (timeout 1000 ms) [00002471ms][DBG ][CELL]: Power => Device ready [00002476ms][DBG ][CELL]: callback: 4106, err: 0, data: 4096 [00002482ms][DBG ][CELL]: Device was not ready, calling soft_power_on() [00002490ms][DBG ][CELL]: STMOD cellular modem power ON [00002496ms][DBG ][CELL]: Booting BG96 [00007951ms][INFO][CELL]: AT TX ( 7): AT+IFC= [00007951ms][INFO][CELL]: AT TX ( 1): 2 [00007952ms][INFO][CELL]: AT TX ( 1): , [00007953ms][INFO][CELL]: AT TX ( 1): 2 [00007953ms][INFO][CELL]: AT TX ( 1): [00007954ms][INFO][CELL]: AT RX (27): RDYATOKAT+IFC=2,2 [00008064ms][DBG ][CELL]: AT flush [00008064ms][INFO][CELL]: AT RX ( 6): OK [00008065ms][INFO][CELL]: AT TX ( 4): ATE0 [00008065ms][INFO][CELL]: AT TX ( 1): [00008066ms][DBG ][CELL]: Modem ready to receive AT commands [00008070ms][DBG ][CELL]: Enable flow control [00008075ms][INFO][CELL]: AT TX ( 7): AT+IFC= [00008081ms][INFO][CELL]: AT TX ( 1): 2 [00008085ms][INFO][CELL]: AT TX ( 1): , [00008090ms][INFO][CELL]: AT TX ( 1): 2 [00008095ms][INFO][CELL]: AT TX ( 1): [00008100ms][INFO][CELL]: AT RX (17): ATE0OKOK [00008108ms][DBG ][CELL]: Flow control turned ON [00008614ms][INFO][CELL]: AT TX ( 7): AT+IFC? [00008614ms][INFO][CELL]: AT TX ( 1): [00008615ms][INFO][CELL]: AT RX (11): APP RDY [00008616ms][DBG ][CELL]: AT flush [00008617ms][INFO][CELL]: AT RX (16): +IFC: 2,2O [00008622ms][INFO][CELL]: AT RX ( 3): K [00008627ms][INFO][CELL]: AT TX ( 4): ATE0 [00008632ms][INFO][CELL]: AT TX ( 1): [00008637ms][INFO][CELL]: AT RX ( 6): OK [00008643ms][INFO][CELL]: AT TX ( 9): AT+CMEE=1 [00008649ms][INFO][CELL]: AT TX ( 1): [00008654ms][INFO][CELL]: AT RX ( 6): OK [00008660ms][INFO][CELL]: AT TX ( 9): AT+CFUN=1 [00008666ms][INFO][CELL]: AT TX ( 1): [00008671ms][INFO][CELL]: AT RX ( 6): OK [00008677ms][INFO][CELL]: Modem ready [00008681ms][INFO][CELL]: AT TX (26): AT+QCFG="nwscanseq",030201 [00008688ms][INFO][CELL]: AT TX ( 1): [00008703ms][INFO][CELL]: AT RX ( 6): OK [00008704ms][INFO][CELL]: AT TX (24): AT+QCFG="nwscanmode",3,1 [00008706ms][INFO][CELL]: AT TX ( 1): [00008711ms][INFO][CELL]: AT RX ( 6): OK [00008718ms][INFO][CELL]: AT TX (23): AT+QCFG="iotopmode",1,1 [00008724ms][INFO][CELL]: AT TX ( 1): [00008729ms][INFO][CELL]: AT RX ( 6): OK [00008736ms][DBG ][CELL]: callback: 4096, err: 0, data: 4096 [00008742ms][DBG ][CELL]: Device ready => SIM pin [00008748ms][DBG ][CELL]: callback: 4106, err: 0, data: 4097 [00008754ms][INFO][CELL]: Setup SIM (timeout 1000 ms) [00008760ms][DBG ][CELL]: AT flush [00008765ms][INFO][CELL]: AT TX ( 8): AT+CPIN? [00008770ms][INFO][CELL]: AT TX ( 1): [00008775ms][INFO][CELL]: AT RX (22): +CPIN: READYOK [00008784ms][INFO][CELL]: SIM is ready [00008789ms][DBG ][CELL]: callback: 4097, err: 0, data: 0 [00009795ms][INFO][CELL]: AT TX ( 7): AT+CIMI [00009795ms][INFO][CELL]: AT TX ( 1): [00009798ms][INFO][CELL]: AT RX ( 7): 46692 [00009799ms][INFO][CELL]: AT RX ( 8): 47000005 [00009799ms][INFO][CELL]: AT RX ( 9): 86OK [00009802ms][INFO][CELL]: AT RX ( 1): [00009807ms][INFO][CELL]: Looked up APN internet [00009812ms][DBG ][CELL]: Manual network registration to 46692 [00009819ms][INFO][CELL]: AT TX ( 8): AT+COPS= [00009825ms][INFO][CELL]: AT TX ( 1): 1 [00009829ms][INFO][CELL]: AT TX ( 1): , [00009834ms][INFO][CELL]: AT TX ( 1): 2 [00009839ms][INFO][CELL]: AT TX ( 1): , [00009844ms][INFO][CELL]: AT TX ( 1): " [00009848ms][INFO][CELL]: AT TX ( 5): 46692 [00009854ms][INFO][CELL]: AT TX ( 1): " [00009858ms][INFO][CELL]: AT TX ( 1): , [00009863ms][INFO][CELL]: AT TX ( 1): 9 [00009868ms][INFO][CELL]: AT TX ( 1): [00029820ms][DBG ][CELL]: AT error -3012 [00029820ms][DBG ][CELL]: STM: set_registration: -3012, plmn: 46692 [00029821ms][DBG ][CELL]: SIM pin: retry 0/10 [00029821ms][DBG ][CELL]: callback: CellularStateRetryEvent, err: 0, data: 4097, retrycount: 0 [00029825ms][INFO][CELL]: Continue after 1 seconds [00030831ms][DBG ][CELL]: callback: 4106, err: 0, data: 4097 [00030831ms][INFO][CELL]: Setup SIM (timeout 1000 ms) [00030832ms][DBG ][CELL]: AT flush [00030832ms][INFO][CELL]: AT TX ( 8): AT+CPIN? [00030833ms][INFO][CELL]: AT TX ( 1): [00030837ms][INFO][CELL]: AT RX ( 6): OK [00030843ms][WARN][CELL]: SIM state unknown [00030848ms][DBG ][CELL]: callback: 4097, err: 0, data: 3 [00030855ms][DBG ][CELL]: SIM pin: retry 1/10 [00030860ms][DBG ][CELL]: callback: CellularStateRetryEvent, err: 0, data: 4097, retrycount: 1 [00030869ms][INFO][CELL]: Continue after 2 seconds [00032875ms][DBG ][CELL]: callback: 4106, err: 0, data: 4097 [00032875ms][INFO][CELL]: Setup SIM (timeout 1000 ms) [00032876ms][DBG ][CELL]: AT flush [00032876ms][INFO][CELL]: AT TX ( 8): AT+CPIN? [00032877ms][INFO][CELL]: AT TX ( 1): [00032881ms][INFO][CELL]: AT RX (22): +CPIN: READYOK [00032890ms][INFO][CELL]: SIM is ready [00032894ms][DBG ][CELL]: callback: 4097, err: 0, data: 0 [00032901ms][DBG ][CELL]: Manual network registration to 46692 [00032907ms][INFO][CELL]: AT TX ( 8): AT+COPS= [00032913ms][INFO][CELL]: AT TX ( 1): 1 [00032917ms][INFO][CELL]: AT TX ( 1): , [00032922ms][INFO][CELL]: AT TX ( 1): 2 [00032927ms][INFO][CELL]: AT TX ( 1): , [00032932ms][INFO][CELL]: AT TX ( 1): " [00032937ms][INFO][CELL]: AT TX ( 5): 46692 [00032942ms][INFO][CELL]: AT TX ( 1): " [00032946ms][INFO][CELL]: AT TX ( 1): , [00032951ms][INFO][CELL]: AT TX ( 1): 9 [00032956ms][INFO][CELL]: AT TX ( 1): [00052908ms][DBG ][CELL]: AT error -3012 [00052908ms][DBG ][CELL]: STM: set_registration: -3012, plmn: 46692 [00052909ms][DBG ][CELL]: SIM pin: retry 2/10 [00052909ms][DBG ][CELL]: callback: CellularStateRetryEvent, err: 0, data: 4097, retrycount: 2 [00052913ms][INFO][CELL]: Continue after 4 seconds [00056919ms][DBG ][CELL]: callback: 4106, err: 0, data: 4097 [00056919ms][INFO][CELL]: Setup SIM (timeout 1000 ms) [00056920ms][DBG ][CELL]: AT flush [00056920ms][INFO][CELL]: AT TX ( 8): AT+CPIN? [00056921ms][INFO][CELL]: AT TX ( 1): [00056925ms][INFO][CELL]: AT RX ( 6): OK [00056931ms][WARN][CELL]: SIM state unknown [00056936ms][DBG ][CELL]: callback: 4097, err: 0, data: 3 [00056943ms][DBG ][CELL]: SIM pin: retry 3/10 [00056948ms][DBG ][CELL]: callback: CellularStateRetryEvent, err: 0, data: 4097, retrycount: 3 [00056957ms][INFO][CELL]: Continue after 8 seconds [00064963ms][DBG ][CELL]: callback: 4106, err: 0, data: 4097 [00064963ms][INFO][CELL]: Setup SIM (timeout 1000 ms) [00064964ms][DBG ][CELL]: AT flush [00064964ms][INFO][CELL]: AT TX ( 8): AT+CPIN? [00064965ms][INFO][CELL]: AT TX ( 1): [00064969ms][INFO][CELL]: AT RX (22): +CPIN: READYOK [00064978ms][INFO][CELL]: SIM is ready [00064982ms][DBG ][CELL]: callback: 4097, err: 0, data: 0 [00064989ms][DBG ][CELL]: Manual network registration to 46692 [00064995ms][INFO][CELL]: AT TX ( 8): AT+COPS= [00065001ms][INFO][CELL]: AT TX ( 1): 1 [00065005ms][INFO][CELL]: AT TX ( 1): , [00065010ms][INFO][CELL]: AT TX ( 1): 2 [00065015ms][INFO][CELL]: AT TX ( 1): , [00065020ms][INFO][CELL]: AT TX ( 1): " [00065025ms][INFO][CELL]: AT TX ( 5): 46692 [00065030ms][INFO][CELL]: AT TX ( 1): " [00065034ms][INFO][CELL]: AT TX ( 1): , [00065039ms][INFO][CELL]: AT TX ( 1): 9 [00065044ms][INFO][CELL]: AT TX ( 1): [00084996ms][DBG ][CELL]: AT error -3012 [00084996ms][DBG ][CELL]: STM: set_registration: -3012, plmn: 46692 [00084997ms][DBG ][CELL]: SIM pin: retry 4/10 [00084997ms][DBG ][CELL]: callback: CellularStateRetryEvent, err: 0, data: 4097, retrycount: 4 [00085001ms][INFO][CELL]: Continue after 16 seconds [00101007ms][DBG ][CELL]: callback: 4106, err: 0, data: 4097 [00101007ms][INFO][CELL]: Setup SIM (timeout 1000 ms) [00101008ms][DBG ][CELL]: AT flush [00101008ms][INFO][CELL]: AT TX ( 8): AT+CPIN? [00101009ms][INFO][CELL]: AT TX ( 1): [00101013ms][INFO][CELL]: AT RX ( 6): OK [00101019ms][WARN][CELL]: SIM state unknown [00101024ms][DBG ][CELL]: callback: 4097, err: 0, data: 3 [00101031ms][DBG ][CELL]: SIM pin: retry 5/10 [00101036ms][DBG ][CELL]: callback: CellularStateRetryEvent, err: 0, data: 4097, retrycount: 5 [00101045ms][INFO][CELL]: Continue after 32 seconds [00133051ms][DBG ][CELL]: callback: 4106, err: 0, data: 4097 [00133051ms][INFO][CELL]: Setup SIM (timeout 1000 ms) [00133052ms][DBG ][CELL]: AT flush [00133052ms][INFO][CELL]: AT TX ( 8): AT+CPIN? [00133053ms][INFO][CELL]: AT TX ( 1): [00133057ms][INFO][CELL]: AT RX (22): +CPIN: READYOK [00133066ms][INFO][CELL]: SIM is ready [00133070ms][DBG ][CELL]: callback: 4097, err: 0, data: 0 [00133077ms][DBG ][CELL]: Manual network registration to 46692 [00133083ms][INFO][CELL]: AT TX ( 8): AT+COPS= [00133089ms][INFO][CELL]: AT TX ( 1): 1 [00133093ms][INFO][CELL]: AT TX ( 1): , [00133098ms][INFO][CELL]: AT TX ( 1): 2 [00133103ms][INFO][CELL]: AT TX ( 1): , [00133108ms][INFO][CELL]: AT TX ( 1): " [00133113ms][INFO][CELL]: AT TX ( 5): 46692 [00133118ms][INFO][CELL]: AT TX ( 1): " [00133122ms][INFO][CELL]: AT TX ( 1): , [00133127ms][INFO][CELL]: AT TX ( 1): 9 [00133132ms][INFO][CELL]: AT TX ( 1): [00153084ms][DBG ][CELL]: AT error -3012 [00153084ms][DBG ][CELL]: STM: set_registration: -3012, plmn: 46692 [00153085ms][DBG ][CELL]: SIM pin: retry 6/10 [00153085ms][DBG ][CELL]: callback: CellularStateRetryEvent, err: 0, data: 4097, retrycount: 6 [00153089ms][INFO][CELL]: Continue after 64 seconds [00158983ms][DBG ][CELL]: AT OoB readable 1, len 0 [00158984ms][INFO][CELL]: AT RX ( 9): +CME ER [00158985ms][INFO][CELL]: AT RX ( 9): ROR: 30 [00159007ms][DBG ][CELL]: AT OoB done [00217095ms][DBG ][CELL]: callback: 4106, err: 0, data: 4097 [00217095ms][INFO][CELL]: Setup SIM (timeout 1000 ms) [00217096ms][DBG ][CELL]: AT flush [00217096ms][INFO][CELL]: AT TX ( 8): AT+CPIN? [00217097ms][INFO][CELL]: AT TX ( 1): [00217101ms][INFO][CELL]: AT RX (22): +CPIN: READYOK [00217110ms][INFO][CELL]: SIM is ready [00217114ms][DBG ][CELL]: callback: 4097, err: 0, data: 0 [00217121ms][DBG ][CELL]: Manual network registration to 46692 [00217127ms][INFO][CELL]: AT TX ( 8): AT+COPS= [00217133ms][INFO][CELL]: AT TX ( 1): 1 [00217137ms][INFO][CELL]: AT TX ( 1): , [00217142ms][INFO][CELL]: AT TX ( 1): 2 [00217147ms][INFO][CELL]: AT TX ( 1): , [00217152ms][INFO][CELL]: AT TX ( 1): " [00217157ms][INFO][CELL]: AT TX ( 5): 46692 [00217162ms][INFO][CELL]: AT TX ( 1): " [00217166ms][INFO][CELL]: AT TX ( 1): , [00217171ms][INFO][CELL]: AT TX ( 1): 9 [00217176ms][INFO][CELL]: AT TX ( 1): [00237128ms][DBG ][CELL]: AT error -3012 [00237128ms][DBG ][CELL]: STM: set_registration: -3012, plmn: 46692 [00237129ms][DBG ][CELL]: SIM pin: retry 7/10 [00237129ms][DBG ][CELL]: callback: CellularStateRetryEvent, err: 0, data: 4097, retrycount: 7 [00237133ms][INFO][CELL]: Continue after 128 seconds [00242971ms][DBG ][CELL]: AT OoB readable 1, len 0 [00242972ms][INFO][CELL]: AT RX ( 9): +CME ER [00242973ms][INFO][CELL]: AT RX ( 9): ROR: 30 [00242994ms][DBG ][CELL]: AT OoB done [00365139ms][DBG ][CELL]: callback: 4106, err: 0, data: 4097 [00365139ms][INFO][CELL]: Setup SIM (timeout 1000 ms) [00365140ms][DBG ][CELL]: AT flush [00365140ms][INFO][CELL]: AT TX ( 8): AT+CPIN? [00365141ms][INFO][CELL]: AT TX ( 1): [00365145ms][INFO][CELL]: AT RX (22): +CPIN: READYOK [00365154ms][INFO][CELL]: SIM is ready [00365158ms][DBG ][CELL]: callback: 4097, err: 0, data: 0 [00365165ms][DBG ][CELL]: Manual network registration to 46692 [00365171ms][INFO][CELL]: AT TX ( 8): AT+COPS= [00365177ms][INFO][CELL]: AT TX ( 1): 1 [00365181ms][INFO][CELL]: AT TX ( 1): , [00365186ms][INFO][CELL]: AT TX ( 1): 2 [00365191ms][INFO][CELL]: AT TX ( 1): , [00365196ms][INFO][CELL]: AT TX ( 1): " [00365201ms][INFO][CELL]: AT TX ( 5): 46692 [00365206ms][INFO][CELL]: AT TX ( 1): " [00365210ms][INFO][CELL]: AT TX ( 1): , [00365215ms][INFO][CELL]: AT TX ( 1): 9 [00365220ms][INFO][CELL]: AT TX ( 1): [00365594ms][INFO][CELL]: AT RX (10): +CME ERR [00365595ms][INFO][CELL]: AT RX ( 8): OR: 30 [00365595ms][WARN][CELL]: AT error code 30 [00365596ms][DBG ][CELL]: AT error -3012 [00365596ms][DBG ][CELL]: STM: set_registration: -3012, plmn: 46692 [00365602ms][DBG ][CELL]: SIM pin: retry 8/10 [00365607ms][DBG ][CELL]: callback: CellularStateRetryEvent, err: 0, data: 4097, retrycount: 8 [00365617ms][INFO][CELL]: Continue after 600 seconds [00965622ms][DBG ][CELL]: callback: 4106, err: 0, data: 4097 [00965622ms][INFO][CELL]: Setup SIM (timeout 1000 ms) [00965623ms][DBG ][CELL]: AT flush [00965623ms][INFO][CELL]: AT TX ( 8): AT+CPIN? [00965624ms][INFO][CELL]: AT TX ( 1): [00965628ms][INFO][CELL]: AT RX (18): +CPIN: READY [00965636ms][INFO][CELL]: AT RX ( 4): OK [00965641ms][INFO][CELL]: SIM is ready [00965646ms][DBG ][CELL]: callback: 4097, err: 0, data: 0 [00965652ms][DBG ][CELL]: Manual network registration to 46692 [00965659ms][INFO][CELL]: AT TX ( 8): AT+COPS= [00965664ms][INFO][CELL]: AT TX ( 1): 1 [00965669ms][INFO][CELL]: AT TX ( 1): , [00965674ms][INFO][CELL]: AT TX ( 1): 2 [00965679ms][INFO][CELL]: AT TX ( 1): , [00965683ms][INFO][CELL]: AT TX ( 1): " [00965688ms][INFO][CELL]: AT TX ( 5): 46692 [00965693ms][INFO][CELL]: AT TX ( 1): " [00965698ms][INFO][CELL]: AT TX ( 1): , [00965703ms][INFO][CELL]: AT TX ( 1): 9 [00965708ms][INFO][CELL]: AT TX ( 1): [00985660ms][DBG ][CELL]: AT error -3012 [00985660ms][DBG ][CELL]: STM: set_registration: -3012, plmn: 46692 [00985661ms][DBG ][CELL]: SIM pin: retry 9/10 [00985661ms][DBG ][CELL]: callback: CellularStateRetryEvent, err: 0, data: 4097, retrycount: 9 [00985665ms][INFO][CELL]: Continue after 1200 seconds [00991802ms][DBG ][CELL]: AT OoB readable 1, len 0 [00991803ms][INFO][CELL]: AT RX ( 8): +CME E [00991803ms][INFO][CELL]: AT RX ( 9): RROR: 30 [00991804ms][INFO][CELL]: AT RX ( 1): [00991826ms][DBG ][CELL]: AT OoB done