We use nRF9160 on our own board with SDK 1.9.1.
The firmware "Serial lte modem" is installed on the chip with connection to an external MCU.
We are connecting to an MQTT broker.
Periodically, we need to publish something and receive something in response when subscribing.But very often we see that after unsubscribing, the next time we connect to the broker, we receive a message from the topic that we unsubscribed from earlier.
I am attaching logs from the terminal (with RTT enabled):
2022-03-17T15:42:59.553Z DEBUG modem << Ready 2022-03-17T15:43:00.535Z DEBUG modem << [00:00:00.205,535] [0m<inf> slm: Serial LTE Modem[0m 2022-03-17T15:43:00.600Z DEBUG modem << [00:00:00.212,890] [0m<dbg> slm_at_host.slm_at_host_init: UART baud: 115200 d/p/s-bits: 3/0/1 HWFC: 1[0m 2022-03-17T15:43:00.606Z DEBUG modem << [00:00:00.212,890] [0m<dbg> slm_at_host.slm_uart_configure: Set uart baudrate to: 115200, hw flow control 1[0m 2022-03-17T15:43:00.611Z DEBUG modem << [00:00:00.230,499] [0m<dbg> slm_at_host: TX 2022-03-17T15:43:00.614Z DEBUG modem << 52 65 61 64 79 0d 0a |Ready.. [0m 2022-03-17T15:43:00.616Z DEBUG modem << [00:00:00.230,590] [0m<dbg> slm_fota.slm_fota_post_process: FOTA result 0,0,0[0m 2022-03-17T15:43:00.619Z DEBUG modem << [00:00:00.237,701] [0m<inf> slm_at_host: at_host init done[0m 2022-03-17T15:43:05.752Z DEBUG modem >> AT 2022-03-17T15:43:05.766Z DEBUG modem << OK 2022-03-17T15:43:06.632Z DEBUG modem >> AT+CFUN? 2022-03-17T15:43:06.646Z DEBUG modem << +CFUN: 0 2022-03-17T15:43:06.672Z DEBUG modem << OK 2022-03-17T15:43:06.764Z DEBUG modem << [00:00:06.437,866] [0m<dbg> slm_at_host: RX 2022-03-17T15:43:06.778Z DEBUG modem << 41 54 |AT [0m 2022-03-17T15:43:06.788Z DEBUG modem << [00:00:06.444,488] [0m<dbg> slm_at_host: TX 2022-03-17T15:43:06.799Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:43:06.806Z DEBUG modem << [00:00:06.444,519] [0m<dbg> slm_at_host: TX 2022-03-17T15:43:06.823Z DEBUG modem << 4f 4b 0d 0a |OK.. [0m 2022-03-17T15:43:06.825Z DEBUG modem << [00:00:07.316,558] [0m<dbg> slm_at_host: RX 2022-03-17T15:43:06.842Z DEBUG modem << 41 54 2b 43 46 55 4e 3f |AT+CFUN? [0m 2022-03-17T15:43:06.854Z DEBUG modem << [00:00:07.317,047] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:43:06.875Z DEBUG modem << [00:00:07.323,181] [0m<dbg> slm_at_host: TX 2022-03-17T15:43:06.893Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:43:06.899Z DEBUG modem << [00:00:07.323,211] [0m<dbg> slm_at_host: TX 2022-03-17T15:43:06.909Z DEBUG modem << 2b 43 46 55 4e 3a 20 30 0d 0a 4f 4b 0d 0a |+CFUN: 0 ..OK.. [0m 2022-03-17T15:43:12.271Z DEBUG modem >> AT+CFUN? 2022-03-17T15:43:12.288Z DEBUG modem << +CFUN: 0 2022-03-17T15:43:12.309Z DEBUG modem << OK 2022-03-17T15:43:13.285Z DEBUG modem << [00:00:12.959,136] [0m<dbg> slm_at_host: RX 2022-03-17T15:43:13.298Z DEBUG modem << 41 54 2b 43 46 55 4e 3f |AT+CFUN? [0m 2022-03-17T15:43:13.308Z DEBUG modem << [00:00:12.959,625] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:43:13.313Z DEBUG modem << [00:00:12.965,759] [0m<dbg> slm_at_host: TX 2022-03-17T15:43:13.327Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:43:13.333Z DEBUG modem << [00:00:12.965,789] [0m<dbg> slm_at_host: TX 2022-03-17T15:43:13.346Z DEBUG modem << 2b 43 46 55 4e 3a 20 30 0d 0a 4f 4b 0d 0a |+CFUN: 0 ..OK.. [0m 2022-03-17T15:45:25.221Z INFO Updating CA certificate... 2022-03-17T15:45:25.225Z DEBUG modem >> AT%CMNG=0,321,0,"-----BEGIN CERTIFICATE----- 2022-03-17T15:45:25.241Z DEBUG modem >> MIIDQTCCAimgAwIBAgITBmyfz5m/jAo54vB4ikPmljZbyjANBgkqhkiG9w0BAQsF 2022-03-17T15:45:25.257Z DEBUG modem >> ADA5MQswCQYDVQQGEwJVUzEPMA0GA1UEChMGQW1hem9uMRkwFwYDVQQDExBBbWF6 2022-03-17T15:45:25.273Z DEBUG modem >> b24gUm9vdCBDQSAxMB4XDTE1MDUyNjAwMDAwMFoXDTM4MDExNzAwMDAwMFowOTEL 2022-03-17T15:45:25.289Z DEBUG modem >> MAkGA1UEBhMCVVMxDzANBgNVBAoTBkFtYXpvbjEZMBcGA1UEAxMQQW1hem9uIFJv 2022-03-17T15:45:25.304Z DEBUG modem >> b3QgQ0EgMTCCASIwDQYJKoZIhvcNAQEBBQADggEPADCCAQoCggEBALJ4gHHKeNXj 2022-03-17T15:45:25.320Z DEBUG modem >> ca9HgFB0fW7Y14h29Jlo91ghYPl0hAEvrAIthtOgQ3pOsqTQNroBvo3bSMgHFzZM 2022-03-17T15:45:25.336Z DEBUG modem >> 9O6II8c+6zf1tRn4SWiw3te5djgdYZ6k/oI2peVKVuRF4fn9tBb6dNqcmzU5L/qw 2022-03-17T15:45:25.351Z DEBUG modem >> IFAGbHrQgLKm+a/sRxmPUDgH3KKHOVj4utWp+UhnMJbulHheb4mjUcAwhmahRWa6 2022-03-17T15:45:25.365Z DEBUG modem >> VOujw5H5SNz/0egwLX0tdHA114gk957EWW67c4cX8jJGKLhD+rcdqsq08p8kDi1L 2022-03-17T15:45:25.382Z DEBUG modem >> 93FcXmn/6pUCyziKrlA4b9v7LWIbxcceVOF34GfID5yHI9Y/QCB/IIDEgEw+OyQm 2022-03-17T15:45:25.397Z DEBUG modem >> jgSubJrIqg0CAwEAAaNCMEAwDwYDVR0TAQH/BAUwAwEB/zAOBgNVHQ8BAf8EBAMC 2022-03-17T15:45:25.413Z DEBUG modem >> AYYwHQYDVR0OBBYEFIQYzIU07LwMlJQuCFmcx7IQTgoIMA0GCSqGSIb3DQEBCwUA 2022-03-17T15:45:25.428Z DEBUG modem >> A4IBAQCY8jdaQZChGsV2USggNiMOruYou6r4lK5IpDB/G/wkjUu0yKGX9rbxenDI 2022-03-17T15:45:25.443Z DEBUG modem >> U5PMCCjjmCXPI6T53iHTfIUJrU6adTrCC2qJeHZERxhlbI1Bjjt/msv0tadQ1wUs 2022-03-17T15:45:25.459Z DEBUG modem >> N+gDS63pYaACbvXy8MWy7Vu33PqUXHeeE6V/Uq2V8viTO96LXFvKWlJbYK8U90vv 2022-03-17T15:45:25.475Z DEBUG modem >> o/ufQJVtMVT8QtPHRh8jrdkPSHCa2XV4cdFyQzR1bldZwgJcJmApzyMZFo6IQ6XU 2022-03-17T15:45:25.492Z DEBUG modem >> 5MsI+yMRQ+hDKXJioaldXgjUkK642M4UwtBV8ob2xJNDd2ZhwLnoQdeXeGADbkpy 2022-03-17T15:45:25.509Z DEBUG modem >> rqXRfboQnoZsG4q5WTP468SQvvG5 2022-03-17T15:45:25.523Z DEBUG modem >> -----END CERTIFICATE-----" 2022-03-17T15:45:25.679Z DEBUG modem << OK 2022-03-17T15:45:25.681Z INFO Updating client certificate... 2022-03-17T15:45:25.682Z DEBUG modem >> AT%CMNG=0,321,1,"-----BEGIN CERTIFICATE----- 2022-03-17T15:45:25.696Z DEBUG modem >> MIICoTCCAYmgAwIBAgIVAMkfBFIvPhBfnpbhZ+BB8RA0A0reMA0GCSqGSIb3DQEB 2022-03-17T15:45:25.711Z DEBUG modem >> CwUAME0xSzBJBgNVBAsMQkFtYXpvbiBXZWIgU2VydmljZXMgTz1BbWF6b24uY29t 2022-03-17T15:45:25.727Z DEBUG modem >> IEluYy4gTD1TZWF0dGxlIFNUPVdhc2hpbmd0b24gQz1VUzAeFw0yMjAyMjcxNDQ0 2022-03-17T15:45:25.741Z DEBUG modem >> MjRaFw00OTEyMzEyMzU5NTlaMDAxDzANBgNVBAMMBjk5OTg3NjEQMA4GA1UECgwH 2022-03-17T15:45:25.756Z DEBUG modem >> UGV0UGFjZTELMAkGA1UEBhMCSUwwWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAAQ0 2022-03-17T15:45:25.773Z DEBUG modem >> 9o4vZ9vj3ms/22+LORJbzs7+uB2ru/qgFNIU6ARAp9w6hfPnmYThjpCX/nVCYP/p 2022-03-17T15:45:25.787Z DEBUG modem >> BSeWdmpsk+C82jNi9Bzro2AwXjAfBgNVHSMEGDAWgBRl/B57ButeH6UP3mZf1LLy 2022-03-17T15:45:25.803Z DEBUG modem >> q+hfVDAdBgNVHQ4EFgQUBuJLcgCiykm8xBy6pHu/tEcbJZ8wDAYDVR0TAQH/BAIw 2022-03-17T15:45:25.818Z DEBUG modem >> ADAOBgNVHQ8BAf8EBAMCB4AwDQYJKoZIhvcNAQELBQADggEBALhZEV5NPjBJJt5f 2022-03-17T15:45:25.834Z DEBUG modem >> OFcJMHDDqs1Sx7NjdkUYyEvXpkMSnQZMHmJHsRJ5I/JF2bNM1/GyovjLbX4GSeWL 2022-03-17T15:45:25.847Z DEBUG modem >> 4JItF6lqNPPQR/a3iyMEyC7DSU04soWuHlF18tDm9Ur2JhOvQ0+rY32D1yDKYeAE 2022-03-17T15:45:25.861Z DEBUG modem >> E7P02dcZjrXhcvTTttUk4tyzg4LPLxMF3epxnHn3tuCSHdXYe4/gxfvufhP1KXW+ 2022-03-17T15:45:25.876Z DEBUG modem >> ix8buVKoW0fg2t1wKzzx9WzqTBEYoklkWQRVu/53NXIXxRY1TGlHIUqVWrkaWyUe 2022-03-17T15:45:25.891Z DEBUG modem >> rHwC2PZ6OOsQZWeasbx+Q/Yyhcnz0VAuZQuqw1LDMeiHBXkz/AtftZD+T+uzfksd 2022-03-17T15:45:25.906Z DEBUG modem >> z6s4x54= 2022-03-17T15:45:25.920Z DEBUG modem >> -----END CERTIFICATE-----" 2022-03-17T15:45:26.684Z DEBUG modem << [00:02:26.612,213] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:45:26.686Z DEBUG modem << [1;31m--- 5 messages dropped --- 2022-03-17T15:45:26.688Z DEBUG modem << 2022-03-17T15:45:27.662Z DEBUG modem << [0m 2022-03-17T15:45:27.664Z DEBUG modem << OK 2022-03-17T15:45:27.666Z INFO Updating private key... 2022-03-17T15:45:27.676Z DEBUG modem >> AT%CMNG=0,321,2,"-----BEGIN EC PRIVATE KEY----- 2022-03-17T15:45:27.692Z DEBUG modem >> MHcCAQEEIJI8fYAxCsgn3wZXlT9+RJ+s9ZsD4ry8bDZRezDprWCuoAoGCCqGSM49 2022-03-17T15:45:27.712Z DEBUG modem >> AwEHoUQDQgAENPaOL2fb495rP9tvizkSW87O/rgdq7v6oBTSFOgEQKfcOoXz55mE 2022-03-17T15:45:27.729Z DEBUG modem >> 4Y6Ql/51QmD/6QUnlnZqbJPgvNozYvQc6w== 2022-03-17T15:45:27.745Z DEBUG modem >> -----END EC PRIVATE KEY-----" 2022-03-17T15:45:27.946Z DEBUG modem << OK 2022-03-17T15:45:27.948Z INFO Certificate update completed 2022-03-17T15:45:28.758Z DEBUG modem << [00:02:28.347,259] [0m<dbg> slm_at_host: TX 2022-03-17T15:45:28.773Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:45:28.778Z DEBUG modem << [00:02:28.347,290] [0m<dbg> slm_at_host: TX 2022-03-17T15:45:28.793Z DEBUG modem << 4f 4b 0d 0a |OK.. [0m 2022-03-17T15:45:28.796Z DEBUG modem << [00:02:28.438,690] [0m<dbg> slm_at_host: RX 2022-03-17T15:45:28.810Z DEBUG modem << 41 54 25 43 4d 4e 47 3d 30 2c 33 32 31 2c 32 2c |AT%CMNG= 0,321,2, 2022-03-17T15:45:29.006Z DEBUG modem << 22 2d 2d 2d 2d 2d 42 45 47 49 4e 20 45 43 20 50 |"-----BE GIN EC P 52 49 56 41 54 45 20 4b 45 59 2d 2d 2d 2d 2d 0d |RIVATE K EY-----. 0a 4d 48 63 43 41 51 45 45 49 4a 49 38 66 59 41 |.MHcCAQE EIJI8fYA 78 43 73 67 6e 33 77 5a 58 6c 54 39 2b 52 4a 2b |xCsgn3wZ XlT9+RJ+ 73 39 5a 73 44 34 72 79 38 62 44 5a 52 65 7a 44 |s9ZsD4ry 8bDZRezD 70 72 57 43 75 6f 41 6f 47 43 43 71 47 53 4d 34 |prWCuoAo GCCqGSM4 39 0d 0a 41 77 45 48 6f 55 51 44 51 67 41 45 4e |9..AwEHo UQDQgAEN 50 61 4f 4c 32 66 62 34 39 35 72 50 39 74 76 69 |PaOL2fb4 95rP9tvi 7a 6b 53 57 38 37 4f 2f 72 67 64 71 37 76 36 6f |zkSW87O/ rgdq7v6o 42 54 53 46 4f 67 45 51 4b 66 63 4f 6f 58 7a 35 |BTSFOgEQ KfcOoXz5 35 6d 45 0d 0a 34 59 36 51 6c 2f 35 31 51 6d 44 |5mE..4Y6 Ql/51QmD 2f 36 51 55 6e 6c 6e 5a 71 62 4a 50 67 76 4e 6f |/6QUnlnZ qbJPgvNo 7a 59 76 51 63 36 77 3d 3d 0d 0a 2d 2d 2d 2d 2d |zYvQc6w= =..----- 45 4e 44 20 45 43 20 50 52 49 56 41 54 45 20 4b |END EC P RIVATE K 45 59 2d 2d 2d 2d 2d 22 |EY-----" [0m 2022-03-17T15:45:29.018Z DEBUG modem << [00:02:28.439,147] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:45:29.028Z DEBUG modem << [00:02:28.630,767] [0m<dbg> slm_at_host: TX 2022-03-17T15:45:29.034Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:45:29.047Z DEBUG modem << [00:02:28.630,798] [0m<dbg> slm_at_host: TX 2022-03-17T15:45:29.062Z DEBUG modem << 4f 4b 0d 0a |OK.. [0m 2022-03-17T15:45:51.282Z DEBUG modem >> AT+CEREG=5 2022-03-17T15:45:51.295Z DEBUG modem << OK 2022-03-17T15:45:52.300Z DEBUG modem << [00:02:51.975,830] [0m<dbg> slm_at_host: RX 2022-03-17T15:45:52.316Z DEBUG modem << 41 54 2b 43 45 52 45 47 3d 35 |AT+CEREG =5 [0m 2022-03-17T15:45:52.324Z DEBUG modem << [00:02:51.976,318] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:45:52.335Z DEBUG modem << [00:02:51.982,452] [0m<dbg> slm_at_host: TX 2022-03-17T15:45:52.350Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:45:52.353Z DEBUG modem << [00:02:51.982,513] [0m<dbg> slm_at_host: TX 2022-03-17T15:45:52.371Z DEBUG modem << 4f 4b 0d 0a |OK.. [0m 2022-03-17T15:45:58.856Z DEBUG modem >> AT+CFUN=1 2022-03-17T15:45:58.898Z DEBUG modem << OK 2022-03-17T15:45:59.902Z DEBUG modem << [00:02:59.548,492] [0m<dbg> slm_at_host: RX 2022-03-17T15:45:59.917Z DEBUG modem << 41 54 2b 43 46 55 4e 3d 31 |AT+CFUN= 1 [0m 2022-03-17T15:45:59.925Z DEBUG modem << [00:02:59.548,980] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:45:59.931Z DEBUG modem << [00:02:59.584,686] [0m<dbg> slm_at_host: TX 2022-03-17T15:45:59.945Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:45:59.949Z DEBUG modem << [00:02:59.584,747] [0m<dbg> slm_at_host: TX 2022-03-17T15:45:59.964Z DEBUG modem << 4f 4b 0d 0a |OK.. [0m 2022-03-17T15:46:00.490Z DEBUG modem << +CEREG: 2,"026F","00332520",7 2022-03-17T15:46:06.771Z DEBUG modem << +CEREG: 5,"026F","00332520",7,,,"00011110","11100000" 2022-03-17T15:46:07.770Z DEBUG modem << [00:03:01.175,109] [0m<dbg> slm_at_host: TX 2022-03-17T15:46:07.785Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:46:07.790Z DEBUG modem << [00:03:01.175,170] [0m<dbg> slm_at_host: TX 2022-03-17T15:46:07.803Z DEBUG modem << 2b 43 45 52 45 47 3a 20 32 2c 22 30 32 36 46 22 |+CEREG: 2,"026F" 2022-03-17T15:46:07.817Z DEBUG modem << 2c 22 30 30 33 33 32 35 32 30 22 2c 37 0d 0a |,"003325 20",7.. [0m 2022-03-17T15:46:07.822Z DEBUG modem << [00:03:07.452,545] [0m<dbg> slm_at_host: TX 2022-03-17T15:46:07.835Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:46:07.840Z DEBUG modem << [00:03:07.452,667] [0m<dbg> slm_at_host: TX 2022-03-17T15:46:07.855Z DEBUG modem << 2b 43 45 52 45 47 3a 20 35 2c 22 30 32 36 46 22 |+CEREG: 5,"026F" 2022-03-17T15:46:07.871Z DEBUG modem << 2c 22 30 30 33 33 32 35 32 30 22 2c 37 2c 2c 2c |,"003325 20",7,,, 2022-03-17T15:46:07.895Z DEBUG modem << 22 30 30 30 31 31 31 31 30 22 2c 22 31 31 31 30 |"0001111 0","1110 30 30 30 30 22 0d 0a |0000".. [0m 2022-03-17T15:46:13.078Z DEBUG modem >> AT#XMQTTCON=1,"999876","","","a34k7wa09ujucc-ats.iot.us-east-1.amazonaws.com",8883,321 2022-03-17T15:46:14.079Z ERROR Error: 'AT#XMQTTCON=1,"999876","","","a34k7wa09ujucc-ats.iot.us-east-1.amazonaws.com",8883,321 ' timed out 2022-03-17T15:46:21.296Z DEBUG modem << OK 2022-03-17T15:46:21.640Z DEBUG modem << #XMQTTEVT: 0,0 2022-03-17T15:46:22.301Z DEBUG modem << [00:03:13.778,839] [0m<dbg> slm_at_host: RX 2022-03-17T15:46:22.366Z DEBUG modem << 41 54 23 58 4d 51 54 54 43 4f 4e 3d 31 2c 22 39 |AT#XMQTT CON=1,"9 39 39 38 37 36 22 2c 22 22 2c 22 22 2c 22 61 33 |99876"," ","","a3 34 6b 37 77 61 30 39 75 6a 75 63 63 2d 61 74 73 |4k7wa09u jucc-ats 2e 69 6f 74 2e 75 73 2d 65 61 73 74 2d 31 2e 61 |.iot.us- east-1.a 6d 61 7a 6f 6e 61 77 73 2e 63 6f 6d 22 2c 38 38 |mazonaws .com",88 2022-03-17T15:46:22.383Z DEBUG modem << 38 33 2c 33 32 31 |83,321 [0m 2022-03-17T15:46:22.405Z DEBUG modem << [00:03:13.779,327] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:46:22.427Z DEBUG modem << [00:03:21.984,100] [0m<dbg> slm_at_host: TX 2022-03-17T15:46:22.435Z DEBUG modem << 0d 0a 4f 4b 0d 0a |..OK.. [0m 2022-03-17T15:46:22.444Z DEBUG modem << [00:03:22.327,239] [0m<dbg> slm_at_host: TX 2022-03-17T15:46:22.470Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 30 2c 30 |..#XMQTT EVT: 0,0 2022-03-17T15:46:22.475Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:46:48.911Z DEBUG modem >> AT#XMQTTSUB="Rigel/ToServer/v2/AR_TEST",1 2022-03-17T15:46:48.923Z DEBUG modem << OK 2022-03-17T15:46:49.430Z DEBUG modem << #XMQTTEVT: 7,0 2022-03-17T15:46:49.927Z DEBUG modem << [00:03:49.609,710] [0m<dbg> slm_at_host: RX 2022-03-17T15:46:49.967Z DEBUG modem << 41 54 23 58 4d 51 54 54 53 55 42 3d 22 52 69 67 |AT#XMQTT SUB="Rig 65 6c 2f 54 6f 53 65 72 76 65 72 2f 76 32 2f 41 |el/ToSer ver/v2/A 52 5f 54 45 53 54 22 2c 31 |R_TEST", 1 [0m 2022-03-17T15:46:49.976Z DEBUG modem << [00:03:49.610,198] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:46:49.981Z DEBUG modem << [00:03:49.611,511] [0m<dbg> slm_at_host: TX 2022-03-17T15:46:49.995Z DEBUG modem << 0d 0a 4f 4b 0d 0a |..OK.. [0m 2022-03-17T15:46:50.011Z DEBUG modem << [00:03:50.118,408] [0m<dbg> slm_mqtt.mqtt_evt_handler: SUBACK packet id: 1[0m 2022-03-17T15:46:50.014Z DEBUG modem << [00:03:50.118,499] [0m<dbg> slm_at_host: TX 2022-03-17T15:46:50.030Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 37 2c 30 |..#XMQTT EVT: 7,0 2022-03-17T15:46:50.047Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:47:21.943Z DEBUG modem >> AT#XMQTTPUB="Rigel/ToServer/v2/AR_TEST","Test Data",1 2022-03-17T15:47:21.962Z DEBUG modem << OK 2022-03-17T15:47:22.424Z DEBUG modem << #XMQTTEVT: 3,0 2022-03-17T15:47:22.456Z DEBUG modem << #XMQTTMSG: 25,9 2022-03-17T15:47:22.461Z DEBUG modem << Rigel/ToServer/v2/AR_TEST 2022-03-17T15:47:22.463Z DEBUG modem << Test Data 2022-03-17T15:47:22.465Z DEBUG modem << #XMQTTEVT: 2,0 2022-03-17T15:47:22.966Z DEBUG modem << [00:04:22.645,355] [0m<dbg> slm_at_host: RX 2022-03-17T15:47:23.020Z DEBUG modem << 41 54 23 58 4d 51 54 54 50 55 42 3d 22 52 69 67 |AT#XMQTT PUB="Rig 65 6c 2f 54 6f 53 65 72 76 65 72 2f 76 32 2f 41 |el/ToSer ver/v2/A 52 5f 54 45 53 54 22 2c 22 54 65 73 74 20 44 61 |R_TEST", "Test Da 74 61 22 2c 31 |ta",1 [0m 2022-03-17T15:47:23.029Z DEBUG modem << [00:04:22.645,843] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:47:23.042Z DEBUG modem << [00:04:22.653,167] [0m<dbg> slm_at_host: TX 2022-03-17T15:47:23.047Z DEBUG modem << 0d 0a 4f 4b 0d 0a |..OK.. [0m 2022-03-17T15:47:23.063Z DEBUG modem << [00:04:23.113,769] [0m<dbg> slm_mqtt.mqtt_evt_handler: PUBACK packet id: 1[0m 2022-03-17T15:47:23.078Z DEBUG modem << [00:04:23.113,800] [0m<dbg> slm_at_host: TX 2022-03-17T15:47:23.095Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 33 2c 30 |..#XMQTT EVT: 3,0 2022-03-17T15:47:23.098Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:47:23.100Z DEBUG modem << [00:04:23.145,141] [0m<dbg> slm_at_host: TX 2022-03-17T15:47:23.121Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 4d 53 47 3a 20 32 35 2c |..#XMQTT MSG: 25, 2022-03-17T15:47:23.126Z DEBUG modem << 39 0d 0a |9.. [0m 2022-03-17T15:47:23.132Z DEBUG modem << [00:04:23.145,233] [0m<dbg> slm_at_host: TX 2022-03-17T15:47:23.146Z DEBUG modem << 52 69 67 65 6c 2f 54 6f 53 65 72 76 65 72 2f 76 |Rigel/To Server/v 2022-03-17T15:47:23.161Z DEBUG modem << 32 2f 41 52 5f 54 45 53 54 |2/AR_TES T [0m 2022-03-17T15:47:23.164Z DEBUG modem << [00:04:23.146,881] [0m<dbg> slm_at_host: TX 2022-03-17T15:47:23.181Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:47:23.184Z DEBUG modem << [00:04:23.149,078] [0m<dbg> slm_at_host: TX 2022-03-17T15:47:23.200Z DEBUG modem << 54 65 73 74 20 44 61 74 61 |Test Dat a [0m 2022-03-17T15:47:23.205Z DEBUG modem << [00:04:23.149,322] [0m<dbg> slm_at_host: TX 2022-03-17T15:47:23.213Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:47:23.228Z DEBUG modem << [00:04:23.150,268] [0m<dbg> slm_at_host: TX 2022-03-17T15:47:23.232Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 32 2c 30 |..#XMQTT EVT: 2,0 2022-03-17T15:47:23.246Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:47:48.631Z DEBUG modem >> AT#XMQTTCON=0 2022-03-17T15:47:48.647Z DEBUG modem << #XMQTTEVT: 1,0 2022-03-17T15:47:48.650Z DEBUG modem << OK 2022-03-17T15:47:49.650Z DEBUG modem << [00:04:49.329,101] [0m<dbg> slm_at_host: RX 2022-03-17T15:47:49.665Z DEBUG modem << 41 54 23 58 4d 51 54 54 43 4f 4e 3d 30 |AT#XMQTT CON=0 [0m 2022-03-17T15:47:49.675Z DEBUG modem << [00:04:49.329,589] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:47:49.691Z DEBUG modem << [00:04:49.337,982] [0m<dbg> slm_at_host: TX 2022-03-17T15:47:49.709Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 31 2c 30 |..#XMQTT EVT: 1,0 2022-03-17T15:47:49.732Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:47:49.735Z DEBUG modem << [00:04:49.338,348] [1;31m<err> slm_mqtt: POLLNVAL[0m 2022-03-17T15:47:49.741Z DEBUG modem << [00:04:49.338,348] [0m<inf> slm_mqtt: MQTT thread terminated[0m 2022-03-17T15:47:49.743Z DEBUG modem << [00:04:49.338,378] [0m<dbg> slm_at_host: TX 2022-03-17T15:47:49.748Z DEBUG modem << 0d 0a 4f 4b 0d 0a |..OK.. [0m 2022-03-17T15:47:57.407Z DEBUG modem >> AT#XMQTTCON=1,"999876","","","a34k7wa09ujucc-ats.iot.us-east-1.amazonaws.com",8883,321 2022-03-17T15:47:58.422Z ERROR Error: 'AT#XMQTTCON=1,"999876","","","a34k7wa09ujucc-ats.iot.us-east-1.amazonaws.com",8883,321 ' timed out 2022-03-17T15:48:05.441Z DEBUG modem << OK 2022-03-17T15:48:05.825Z DEBUG modem << #XMQTTEVT: 0,0 2022-03-17T15:48:05.936Z DEBUG modem << #XMQTTMSG: 25,9 2022-03-17T15:48:05.947Z DEBUG modem << Rigel/ToServer/v2/AR_TEST 2022-03-17T15:48:05.966Z DEBUG modem << Test Data 2022-03-17T15:48:05.969Z DEBUG modem << #XMQTTEVT: 2,0 2022-03-17T15:48:06.445Z DEBUG modem << [00:04:58.116,821] [0m<dbg> slm_at_host: RX 2022-03-17T15:48:06.511Z DEBUG modem << 41 54 23 58 4d 51 54 54 43 4f 4e 3d 31 2c 22 39 |AT#XMQTT CON=1,"9 39 39 38 37 36 22 2c 22 22 2c 22 22 2c 22 61 33 |99876"," ","","a3 34 6b 37 77 61 30 39 75 6a 75 63 63 2d 61 74 73 |4k7wa09u jucc-ats 2e 69 6f 74 2e 75 73 2d 65 61 73 74 2d 31 2e 61 |.iot.us- east-1.a 6d 61 7a 6f 6e 61 77 73 2e 63 6f 6d 22 2c 38 38 |mazonaws .com",88 2022-03-17T15:48:06.526Z DEBUG modem << 38 33 2c 33 32 31 |83,321 [0m 2022-03-17T15:48:06.535Z DEBUG modem << [00:04:58.117,309] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:48:06.538Z DEBUG modem << [00:05:06.133,636] [0m<dbg> slm_at_host: TX 2022-03-17T15:48:06.558Z DEBUG modem << 0d 0a 4f 4b 0d 0a |..OK.. [0m 2022-03-17T15:48:06.562Z DEBUG modem << [00:05:06.518,402] [0m<dbg> slm_at_host: TX 2022-03-17T15:48:06.581Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 30 2c 30 |..#XMQTT EVT: 0,0 2022-03-17T15:48:06.585Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:48:06.591Z DEBUG modem << [00:05:06.628,417] [0m<dbg> slm_at_host: TX 2022-03-17T15:48:06.607Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 4d 53 47 3a 20 32 35 2c |..#XMQTT MSG: 25, 2022-03-17T15:48:06.625Z DEBUG modem << 39 0d 0a |9.. [0m 2022-03-17T15:48:06.630Z DEBUG modem << [00:05:06.628,509] [0m<dbg> slm_at_host: TX 2022-03-17T15:48:06.653Z DEBUG modem << 52 69 67 65 6c 2f 54 6f 53 65 72 76 65 72 2f 76 |Rigel/To Server/v 2022-03-17T15:48:06.675Z DEBUG modem << 32 2f 41 52 5f 54 45 53 54 |2/AR_TES T [0m 2022-03-17T15:48:06.678Z DEBUG modem << [00:05:06.630,249] [0m<dbg> slm_at_host: TX 2022-03-17T15:48:06.699Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:48:06.702Z DEBUG modem << [00:05:06.632,476] [0m<dbg> slm_at_host: TX 2022-03-17T15:48:06.706Z DEBUG modem << 54 65 73 74 20 44 61 74 61 |Test Dat a [0m 2022-03-17T15:48:06.710Z DEBUG modem << [00:05:06.632,720] [0m<dbg> slm_at_host: TX 2022-03-17T15:48:06.725Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:48:06.727Z DEBUG modem << [00:05:06.633,666] [0m<dbg> slm_at_host: TX 2022-03-17T15:48:06.742Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 32 2c 30 |..#XMQTT EVT: 2,0 2022-03-17T15:48:06.760Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:48:36.697Z DEBUG modem << #XMQTTMSG: 25,9 2022-03-17T15:48:36.708Z DEBUG modem << Rigel/ToServer/v2/AR_TEST 2022-03-17T15:48:36.712Z DEBUG modem << Test Data 2022-03-17T15:48:36.718Z DEBUG modem << #XMQTTEVT: 2,0 2022-03-17T15:48:37.701Z DEBUG modem << [00:05:37.388,549] [0m<dbg> slm_at_host: TX 2022-03-17T15:48:37.713Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 4d 53 47 3a 20 32 35 2c |..#XMQTT MSG: 25, 2022-03-17T15:48:37.732Z DEBUG modem << 39 0d 0a |9.. [0m 2022-03-17T15:48:37.736Z DEBUG modem << [00:05:37.388,580] [0m<dbg> slm_at_host: TX 2022-03-17T15:48:37.751Z DEBUG modem << 52 69 67 65 6c 2f 54 6f 53 65 72 76 65 72 2f 76 |Rigel/To Server/v 2022-03-17T15:48:37.765Z DEBUG modem << 32 2f 41 52 5f 54 45 53 54 |2/AR_TES T [0m 2022-03-17T15:48:37.768Z DEBUG modem << [00:05:37.390,289] [0m<dbg> slm_at_host: TX 2022-03-17T15:48:37.785Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:48:37.787Z DEBUG modem << [00:05:37.392,486] [0m<dbg> slm_at_host: TX 2022-03-17T15:48:37.803Z DEBUG modem << 54 65 73 74 20 44 61 74 61 |Test Dat a [0m 2022-03-17T15:48:37.805Z DEBUG modem << [00:05:37.392,730] [0m<dbg> slm_at_host: TX 2022-03-17T15:48:37.820Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:48:37.839Z DEBUG modem << [00:05:37.393,676] [0m<dbg> slm_at_host: TX 2022-03-17T15:48:37.855Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 32 2c 30 |..#XMQTT EVT: 2,0 2022-03-17T15:48:37.869Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:48:43.033Z DEBUG modem >> AT#XMQTTUNSUB="Rigel/ToServer/v2/AR_TEST" 2022-03-17T15:48:43.045Z DEBUG modem << OK 2022-03-17T15:48:44.050Z DEBUG modem << [00:05:43.737,670] [0m<dbg> slm_at_host: RX 2022-03-17T15:48:44.089Z DEBUG modem << 41 54 23 58 4d 51 54 54 55 4e 53 55 42 3d 22 52 |AT#XMQTT UNSUB="R 69 67 65 6c 2f 54 6f 53 65 72 76 65 72 2f 76 32 |igel/ToS erver/v2 2f 41 52 5f 54 45 53 54 22 |/AR_TEST " [0m 2022-03-17T15:48:44.108Z DEBUG modem << [00:05:43.738,159] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:48:44.113Z DEBUG modem << [00:05:43.739,410] [0m<dbg> slm_at_host: TX 2022-03-17T15:48:44.129Z DEBUG modem << 0d 0a 4f 4b 0d 0a |..OK.. [0m 2022-03-17T15:48:44.196Z DEBUG modem << #XMQTTEVT: 8,0 2022-03-17T15:49:05.735Z DEBUG modem >> AT#XMQTTCON=0 2022-03-17T15:49:05.751Z DEBUG modem << #XMQTTEVT: 1,0 2022-03-17T15:49:05.766Z DEBUG modem << OK 2022-03-17T15:49:06.754Z DEBUG modem << [00:05:44.890,747] [0m<dbg> slm_mqtt.mqtt_evt_handler: UNSUBACK packet id: 2[0m 2022-03-17T15:49:06.766Z DEBUG modem << [00:05:44.890,808] [0m<dbg> slm_at_host: TX 2022-03-17T15:49:06.789Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 38 2c 30 |..#XMQTT EVT: 8,0 2022-03-17T15:49:06.795Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:49:06.799Z DEBUG modem << [00:06:06.437,652] [0m<dbg> slm_at_host: RX 2022-03-17T15:49:06.834Z DEBUG modem << 41 54 23 58 4d 51 54 54 43 4f 4e 3d 30 |AT#XMQTT CON=0 [0m 2022-03-17T15:49:06.856Z DEBUG modem << [00:06:06.438,140] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:49:06.861Z DEBUG modem << [00:06:06.446,533] [0m<dbg> slm_at_host: TX 2022-03-17T15:49:06.869Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 31 2c 30 |..#XMQTT EVT: 1,0 2022-03-17T15:49:06.905Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:49:06.907Z DEBUG modem << [00:06:06.446,868] [1;31m<err> slm_mqtt: POLLNVAL[0m 2022-03-17T15:49:06.910Z DEBUG modem << [00:06:06.446,868] [0m<inf> slm_mqtt: MQTT thread terminated[0m 2022-03-17T15:49:06.914Z DEBUG modem << [00:06:06.446,899] [0m<dbg> slm_at_host: TX 2022-03-17T15:49:06.946Z DEBUG modem << 0d 0a 4f 4b 0d 0a |..OK.. [0m 2022-03-17T15:49:16.401Z DEBUG modem >> AT#XMQTTCON=1,"999876","","","a34k7wa09ujucc-ats.iot.us-east-1.amazonaws.com",8883,321 2022-03-17T15:49:17.413Z ERROR Error: 'AT#XMQTTCON=1,"999876","","","a34k7wa09ujucc-ats.iot.us-east-1.amazonaws.com",8883,321 ' timed out 2022-03-17T15:49:22.630Z DEBUG modem << OK 2022-03-17T15:49:22.934Z DEBUG modem << #XMQTTEVT: 0,0 2022-03-17T15:49:23.635Z DEBUG modem << [00:06:17.114,501] [0m<dbg> slm_at_host: RX 2022-03-17T15:49:23.701Z DEBUG modem << 41 54 23 58 4d 51 54 54 43 4f 4e 3d 31 2c 22 39 |AT#XMQTT CON=1,"9 39 39 38 37 36 22 2c 22 22 2c 22 22 2c 22 61 33 |99876"," ","","a3 34 6b 37 77 61 30 39 75 6a 75 63 63 2d 61 74 73 |4k7wa09u jucc-ats 2e 69 6f 74 2e 75 73 2d 65 61 73 74 2d 31 2e 61 |.iot.us- east-1.a 6d 61 7a 6f 6e 61 77 73 2e 63 6f 6d 22 2c 38 38 |mazonaws .com",88 2022-03-17T15:49:23.715Z DEBUG modem << 38 33 2c 33 32 31 |83,321 [0m 2022-03-17T15:49:23.730Z DEBUG modem << [00:06:17.114,990] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:49:23.732Z DEBUG modem << [00:06:23.327,148] [0m<dbg> slm_at_host: TX 2022-03-17T15:49:23.746Z DEBUG modem << 0d 0a 4f 4b 0d 0a |..OK.. [0m 2022-03-17T15:49:23.749Z DEBUG modem << [00:06:23.628,631] [0m<dbg> slm_at_host: TX 2022-03-17T15:49:23.766Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 30 2c 30 |..#XMQTT EVT: 0,0 2022-03-17T15:49:23.782Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:49:41.760Z DEBUG modem >> AT#XMQTTCON=0 2022-03-17T15:49:41.781Z DEBUG modem << #XMQTTEVT: 1,0 2022-03-17T15:49:41.790Z DEBUG modem << OK 2022-03-17T15:49:42.779Z DEBUG modem << [00:06:42.463,378] [0m<dbg> slm_at_host: RX 2022-03-17T15:49:42.798Z DEBUG modem << 41 54 23 58 4d 51 54 54 43 4f 4e 3d 30 |AT#XMQTT CON=0 [0m 2022-03-17T15:49:42.801Z DEBUG modem << [00:06:42.463,867] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:49:42.817Z DEBUG modem << [00:06:42.472,290] [0m<dbg> slm_at_host: TX 2022-03-17T15:49:42.821Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 31 2c 30 |..#XMQTT EVT: 1,0 2022-03-17T15:49:42.835Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:49:42.851Z DEBUG modem << [00:06:42.472,625] [1;31m<err> slm_mqtt: POLLNVAL[0m 2022-03-17T15:49:42.854Z DEBUG modem << [00:06:42.472,625] [0m<inf> slm_mqtt: MQTT thread terminated[0m 2022-03-17T15:49:42.869Z DEBUG modem << [00:06:42.472,656] [0m<dbg> slm_at_host: TX 2022-03-17T15:49:42.884Z DEBUG modem << 0d 0a 4f 4b 0d 0a |..OK.. [0m 2022-03-17T15:49:46.567Z DEBUG modem >> AT#XMQTTCON=1,"999876","","","a34k7wa09ujucc-ats.iot.us-east-1.amazonaws.com",8883,321 2022-03-17T15:49:47.577Z ERROR Error: 'AT#XMQTTCON=1,"999876","","","a34k7wa09ujucc-ats.iot.us-east-1.amazonaws.com",8883,321 ' timed out 2022-03-17T15:49:54.015Z DEBUG modem << OK 2022-03-17T15:49:54.379Z DEBUG modem << #XMQTTEVT: 0,0 2022-03-17T15:49:54.454Z DEBUG modem << #XMQTTMSG: 25,9 2022-03-17T15:49:54.471Z DEBUG modem << Rigel/ToServer/v2/AR_TEST 2022-03-17T15:49:54.497Z DEBUG modem << Test Data 2022-03-17T15:49:54.500Z DEBUG modem << #XMQTTEVT: 2,0 2022-03-17T15:49:55.021Z DEBUG modem << [00:06:47.277,954] [0m<dbg> slm_at_host: RX 2022-03-17T15:49:55.087Z DEBUG modem << 41 54 23 58 4d 51 54 54 43 4f 4e 3d 31 2c 22 39 |AT#XMQTT CON=1,"9 39 39 38 37 36 22 2c 22 22 2c 22 22 2c 22 61 33 |99876"," ","","a3 34 6b 37 77 61 30 39 75 6a 75 63 63 2d 61 74 73 |4k7wa09u jucc-ats 2e 69 6f 74 2e 75 73 2d 65 61 73 74 2d 31 2e 61 |.iot.us- east-1.a 6d 61 7a 6f 6e 61 77 73 2e 63 6f 6d 22 2c 38 38 |mazonaws .com",88 2022-03-17T15:49:55.111Z DEBUG modem << 38 33 2c 33 32 31 |83,321 [0m 2022-03-17T15:49:55.115Z DEBUG modem << [00:06:47.278,442] [0m<dbg> slm_at_host.uart_callback: RX_DISABLED[0m 2022-03-17T15:49:55.148Z DEBUG modem << [00:06:54.714,050] [0m<dbg> slm_at_host: TX 2022-03-17T15:49:55.179Z DEBUG modem << 0d 0a 4f 4b 0d 0a |..OK.. [0m 2022-03-17T15:49:55.182Z DEBUG modem << [00:06:55.076,568] [0m<dbg> slm_at_host: TX 2022-03-17T15:49:55.185Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 30 2c 30 |..#XMQTT EVT: 0,0 2022-03-17T15:49:55.207Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:49:55.210Z DEBUG modem << [00:06:55.150,329] [0m<dbg> slm_at_host: TX 2022-03-17T15:49:55.213Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 4d 53 47 3a 20 32 35 2c |..#XMQTT MSG: 25, 2022-03-17T15:49:55.216Z DEBUG modem << 39 0d 0a |9.. [0m 2022-03-17T15:49:55.243Z DEBUG modem << [00:06:55.150,360] [0m<dbg> slm_at_host: TX 2022-03-17T15:49:55.247Z DEBUG modem << 52 69 67 65 6c 2f 54 6f 53 65 72 76 65 72 2f 76 |Rigel/To Server/v 2022-03-17T15:49:55.274Z DEBUG modem << 32 2f 41 52 5f 54 45 53 54 |2/AR_TES T [0m 2022-03-17T15:49:55.278Z DEBUG modem << [00:06:55.152,069] [0m<dbg> slm_at_host: TX 2022-03-17T15:49:55.281Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:49:55.287Z DEBUG modem << [00:06:55.154,266] [0m<dbg> slm_at_host: TX 2022-03-17T15:49:55.307Z DEBUG modem << 54 65 73 74 20 44 61 74 61 |Test Dat a [0m 2022-03-17T15:49:55.311Z DEBUG modem << [00:06:55.154,510] [0m<dbg> slm_at_host: TX 2022-03-17T15:49:55.314Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:49:55.317Z DEBUG modem << [00:06:55.155,456] [0m<dbg> slm_at_host: TX 2022-03-17T15:49:55.342Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 32 2c 30 |..#XMQTT EVT: 2,0 2022-03-17T15:49:55.346Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:50:25.510Z DEBUG modem << #XMQTTMSG: 25,9 2022-03-17T15:50:25.512Z DEBUG modem << Rigel/ToServer/v2/AR_TEST 2022-03-17T15:50:25.514Z DEBUG modem << Test Data 2022-03-17T15:50:25.518Z DEBUG modem << #XMQTTEVT: 2,0 2022-03-17T15:50:26.515Z DEBUG modem << [00:07:26.208,679] [0m<dbg> slm_at_host: TX 2022-03-17T15:50:26.529Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 4d 53 47 3a 20 32 35 2c |..#XMQTT MSG: 25, 2022-03-17T15:50:26.543Z DEBUG modem << 39 0d 0a |9.. [0m 2022-03-17T15:50:26.548Z DEBUG modem << [00:07:26.208,709] [0m<dbg> slm_at_host: TX 2022-03-17T15:50:26.562Z DEBUG modem << 52 69 67 65 6c 2f 54 6f 53 65 72 76 65 72 2f 76 |Rigel/To Server/v 2022-03-17T15:50:26.575Z DEBUG modem << 32 2f 41 52 5f 54 45 53 54 |2/AR_TES T [0m 2022-03-17T15:50:26.579Z DEBUG modem << [00:07:26.210,418] [0m<dbg> slm_at_host: TX 2022-03-17T15:50:26.594Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:50:26.599Z DEBUG modem << [00:07:26.212,615] [0m<dbg> slm_at_host: TX 2022-03-17T15:50:26.613Z DEBUG modem << 54 65 73 74 20 44 61 74 61 |Test Dat a [0m 2022-03-17T15:50:26.619Z DEBUG modem << [00:07:26.212,860] [0m<dbg> slm_at_host: TX 2022-03-17T15:50:26.632Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:50:26.639Z DEBUG modem << [00:07:26.213,806] [0m<dbg> slm_at_host: TX 2022-03-17T15:50:26.652Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 32 2c 30 |..#XMQTT EVT: 2,0 2022-03-17T15:50:26.664Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:50:54.459Z DEBUG modem << #XMQTTMSG: 25,9 2022-03-17T15:50:54.462Z DEBUG modem << Rigel/ToServer/v2/AR_TEST 2022-03-17T15:50:54.465Z DEBUG modem << Test Data 2022-03-17T15:50:54.466Z DEBUG modem << #XMQTTEVT: 2,0 2022-03-17T15:50:54.488Z DEBUG modem << #XMQTTEVT: 9,0 2022-03-17T15:50:55.466Z DEBUG modem << [00:07:55.159,729] [0m<dbg> slm_at_host: TX 2022-03-17T15:50:55.478Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 4d 53 47 3a 20 32 35 2c |..#XMQTT MSG: 25, 2022-03-17T15:50:55.493Z DEBUG modem << 39 0d 0a |9.. [0m 2022-03-17T15:50:55.498Z DEBUG modem << [00:07:55.159,759] [0m<dbg> slm_at_host: TX 2022-03-17T15:50:55.510Z DEBUG modem << 52 69 67 65 6c 2f 54 6f 53 65 72 76 65 72 2f 76 |Rigel/To Server/v 2022-03-17T15:50:55.524Z DEBUG modem << 32 2f 41 52 5f 54 45 53 54 |2/AR_TES T [0m 2022-03-17T15:50:55.531Z DEBUG modem << [00:07:55.161,468] [0m<dbg> slm_at_host: TX 2022-03-17T15:50:55.543Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:50:55.549Z DEBUG modem << [00:07:55.163,665] [0m<dbg> slm_at_host: TX 2022-03-17T15:50:55.563Z DEBUG modem << 54 65 73 74 20 44 61 74 61 |Test Dat a [0m 2022-03-17T15:50:55.568Z DEBUG modem << [00:07:55.163,909] [0m<dbg> slm_at_host: TX 2022-03-17T15:50:55.583Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:50:55.587Z DEBUG modem << [00:07:55.164,855] [0m<dbg> slm_at_host: TX 2022-03-17T15:50:55.601Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 32 2c 30 |..#XMQTT EVT: 2,0 2022-03-17T15:50:55.614Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:50:55.624Z DEBUG modem << [00:07:55.188,537] [0m<dbg> slm_mqtt.mqtt_evt_handler: PINGRESP packet[0m 2022-03-17T15:50:55.630Z DEBUG modem << [00:07:55.188,568] [0m<dbg> slm_at_host: TX 2022-03-17T15:50:55.642Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 39 2c 30 |..#XMQTT EVT: 9,0 2022-03-17T15:50:55.655Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:51:42.311Z DEBUG modem << #XMQTTMSG: 25,9 2022-03-17T15:51:42.321Z DEBUG modem << Rigel/ToServer/v2/AR_TEST 2022-03-17T15:51:42.328Z DEBUG modem << Test Data 2022-03-17T15:51:42.334Z DEBUG modem << #XMQTTEVT: 2,0 2022-03-17T15:51:43.314Z DEBUG modem << [00:08:43.012,237] [0m<dbg> slm_at_host: TX 2022-03-17T15:51:43.328Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 4d 53 47 3a 20 32 35 2c |..#XMQTT MSG: 25, 2022-03-17T15:51:43.341Z DEBUG modem << 39 0d 0a |9.. [0m 2022-03-17T15:51:43.347Z DEBUG modem << [00:08:43.012,298] [0m<dbg> slm_at_host: TX 2022-03-17T15:51:43.360Z DEBUG modem << 52 69 67 65 6c 2f 54 6f 53 65 72 76 65 72 2f 76 |Rigel/To Server/v 2022-03-17T15:51:43.374Z DEBUG modem << 32 2f 41 52 5f 54 45 53 54 |2/AR_TES T [0m 2022-03-17T15:51:43.381Z DEBUG modem << [00:08:43.014,007] [0m<dbg> slm_at_host: TX 2022-03-17T15:51:43.393Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:51:43.398Z DEBUG modem << [00:08:43.016,204] [0m<dbg> slm_at_host: TX 2022-03-17T15:51:43.411Z DEBUG modem << 54 65 73 74 20 44 61 74 61 |Test Dat a [0m 2022-03-17T15:51:43.417Z DEBUG modem << [00:08:43.016,448] [0m<dbg> slm_at_host: TX 2022-03-17T15:51:43.432Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:51:43.438Z DEBUG modem << [00:08:43.017,395] [0m<dbg> slm_at_host: TX 2022-03-17T15:51:43.449Z DEBUG modem << 0d 0a 23 58 4d 51 54 54 45 56 54 3a 20 32 2c 30 |..#XMQTT EVT: 2,0 2022-03-17T15:51:43.463Z DEBUG modem << 0d 0a |.. [0m 2022-03-17T15:51:54.483Z DEBUG modem << #XMQTTEVT: 9,0
What are we doing wrong, why do we receive messages from topics that were unsubscribed from?
