00:02:15 INFO ../app/app_main.c:119: ============================================== 00:02:15 INFO ../app/app_main.c:120: C3220 Ver: 2.12.1 00:02:15 INFO ../app/app_main.c:121: ============================================== 00:02:15 INFO ../app/app_main.c:122: CHIP: 0x31000019 00:02:15 INFO ../app/app_main.c:125: MAC: 2.7.0.0 00:02:15 INFO ../app/app_main.c:128: PHY: 2.2.0.7 00:02:15 INFO ../app/app_main.c:131: NWP: 3.20.0.1 00:02:15 INFO ../app/app_main.c:132: ROM: 0 00:02:15 INFO ../app/app_main.c:133: HOST: 3.0.1.71 00:02:15 INFO ../app/app_main.c:136: MAC address: c8:df:84:61:06:64 00:02:15 INFO ../app/app_main.c:137: ============================================== 00:02:15 INFO ../app/mqtt_client_task.c:540: Template object created successfully. 00:02:15 INFO ../app/mqtt_client_task.c:550: Json object created successfully. 00:02:15 INFO ../net/network_if.c:472: Device came up in Station mode 00:02:15 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 1 00:02:15 DEBUG ../app/app_main.c:273: ========================================= 00:02:15 DEBUG ../app/app_main.c:274: === APP STATE: 0, PROCESS EVT: 1 ==== 00:02:15 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x0101bf09 ==== 00:02:15 DEBUG ../app/app_main.c:276: ========================================= 00:02:15 DEBUG ../app/app_main.c:144: app_start_handler() 00:02:15 DEBUG ../app/mqtt_client_task.c:355: MQTT already stop. No need to stop! 00:02:15 INFO ../net/network_if.c:596: Trying to connect to AP: Airtel-MyWiFi-AMF-311WW-6ED0 ... 00:02:15 INFO ../app/ble_monitor_task.c:82: start BLE Monitor Task 00:02:15 INFO ../net/network_if.c:609: Wait 10 sec to check if connection to desire AP succeeds! 00:02:17 INFO ../net/network_if.c:147: [WLAN EVENT] STA Connected to the AP: Airtel-MyWiFi-AMF-311WW-6ED0 , BSSID: fc:dd:55:b4:6e:d0 00:02:17 DEBUG ../net/network_if.c:259: [NETAPP EVENT] IP acquired by the device 00:02:17 INFO ../net/network_if.c:641: Device has connected to Airtel-MyWiFi-AMF-311WW-6ED0 00:02:17 INFO ../net/network_if.c:651: Device IP Address is 192.168.1.101 00:02:18 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 3 00:02:18 DEBUG ../app/app_main.c:287: ========================================== 00:02:18 DEBUG ../app/app_main.c:288: === APP STATE: 2, TRIGGED BY EVT: 1 ==== 00:02:18 DEBUG ../app/app_main.c:289: ========================================== 00:02:18 INFO ../imc/aquai.c:1099: BLE Tx: Update Wifi Status 2. 00:02:18 DEBUG ../app/app_main.c:273: ========================================= 00:02:18 DEBUG ../app/app_main.c:274: === APP STATE: 2, PROCESS EVT: 3 ==== 00:02:18 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x01026211 ==== 00:02:18 DEBUG ../app/app_main.c:276: ========================================= 00:02:18 INFO ../app/mqtt_client_task.c:306: Start MQTT Thread. 00:02:18 INFO ../app/mqtt_client_task.c:332: MQTT Thread started. 00:02:18 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 10 00:02:18 DEBUG ../app/app_main.c:287: ========================================== 00:02:18 DEBUG ../app/app_main.c:288: === APP STATE: 3, TRIGGED BY EVT: 3 ==== 00:02:18 DEBUG ../app/app_main.c:289: ========================================== 00:02:18 INFO ../imc/aquai.c:1099: BLE Tx: Update Wifi Status 3. 00:02:20 INFO ../app/mqtt_client_cbs.c:81: Mqtt Connection Success 00:02:20 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 5 00:02:20 DEBUG ../app/app_main.c:273: ========================================= 00:02:20 DEBUG ../app/app_main.c:274: === APP STATE: 3, PROCESS EVT: 5 ==== 00:02:20 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x00000000 ==== 00:02:20 DEBUG ../app/app_main.c:276: ========================================= 00:02:20 DEBUG ../app/app_main.c:287: ========================================== 00:02:20 DEBUG ../app/app_main.c:288: === APP STATE: 4, TRIGGED BY EVT: 5 ==== 00:02:20 DEBUG ../app/app_main.c:289: ========================================== 00:02:20 INFO ../imc/aquai.c:1099: BLE Tx: Update Wifi Status 4. 00:02:20 INFO ../app/mqtt_client_task.c:488: Client subscribed on /topic/device/repeater/out 00:02:20 INFO ../app/mqtt_client_task.c:488: Client subscribed on /topic/device/healthcheck/out 00:02:20 INFO ../app/mqtt_client_task.c:488: Client subscribed on /topic/device/version/upgrade 00:02:22 DEBUG ../imc/aquai.c:904: --> RX: Received frame: 18 00:02:22 INFO ../imc/aquai.c:778: Update RSSI 00:03:01 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 1 00:03:18 INFO ../app/mqtt_client_cbs.c:134: Msg Recvd. by client 00:03:18 INFO ../app/mqtt_client_cbs.c:135: TOPIC: /topic/device/version/upgrade{"cmd":"upgrade","deviceId":"AQ900RP000000035","version":"1.0.14","versionCode":16,"url":"https://bjex-stg.s3.amazonaws.com/9d2/9d2c2c36-fa30-4e8e-b75a-d76d0bf53f69","che 00:03:18 INFO ../app/mqtt_client_cbs.c:136: PAYLOAD: {"cmd":"upgrade","deviceId":"AQ900RP000000035","version":"1.0.14","versionCode":16,"url":"https://bjex-stg.s3.amazonaws.com/9d2/9d2c2c36-fa30-4e8e-b75a-d76d0bf53f69","checksum":"1d0ff48e2572f78520c 00:03:18 INFO ../app/mqtt_client_cbs.c:137: QOS: 0 00:03:18 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 9 00:03:18 INFO ../app/mqtt_client_task.c:669: Received OTA Upgrade Cmd. 00:03:18 INFO ../app/app_commands.c:185: DeviceID: AQ900RP000000035 00:03:18 INFO ../app/app_commands.c:186: Command: upgrade 00:03:18 INFO ../app/app_commands.c:187: URL: https://bjex-stg.s3.amazonaws.com/9d2/9d2c2c36-fa30-4e8e-b75a-d76d0bf53f69 00:03:18 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 7 00:03:18 DEBUG ../app/app_main.c:273: ========================================= 00:03:18 DEBUG ../app/app_main.c:274: === APP STATE: 4, PROCESS EVT: 7 ==== 00:03:18 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x0100e3b5 ==== 00:03:18 DEBUG ../app/app_main.c:276: ========================================= 00:03:18 INFO ../app/ota_task.c:49: OtaInit: statistics = 0, 0, 0 00:03:18 INFO ../app/ota_task.c:51: OtaInit: call Ota_init 00:03:18 DEBUG ../ota/source/OtaLib.c:47: OTA_init: sizeof CdnClient=576, sizeof OtaArchive=4956 00:03:18 DEBUG ../ota/source/OtaLib.c:48: OTA_init: sizeof OtaLib_t=7740, sizeof OTA_memBlock=7800 00:03:18 DEBUG ../ota/source/OtaLib.c:59: OTA_init: OTA lib version = OTA_LIB_2.0.0.7 00:03:18 INFO ../ota/source/OtaArchive.c:706: OtaArchive_Init: OTA archive version = OTA_ARCHIVE_2.0.0.4 00:03:18 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:18 DEBUG ../app/app_main.c:287: ========================================== 00:03:18 DEBUG ../app/app_main.c:288: === APP STATE: 5, TRIGGED BY EVT: 7 ==== 00:03:18 DEBUG ../app/app_main.c:289: ========================================== 00:03:18 INFO ../imc/aquai.c:1099: BLE Tx: Update Wifi Status 5. 00:03:18 DEBUG ../app/app_main.c:273: ========================================= 00:03:18 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:18 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:18 DEBUG ../app/app_main.c:276: ========================================= 00:03:18 INFO ../ota/source/OtaLib.c:101: ---->Progress: 0% --- Dowloaded:0 Filesize: 0 00:03:18 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:18 DEBUG ../app/app_main.c:273: ========================================= 00:03:18 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:18 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:18 DEBUG ../app/app_main.c:276: ========================================= 00:03:18 DEBUG ../ota/source/OtaLib.c:280: OTA_run: Call CdnClient_ConnectFileServer, url = https://bjex-stg.s3.amazonaws.com/9d2/9d2c2c36-fa30-4e8e-b75a-d76d0bf53f69 00:03:18 INFO ../ota/source/OtaHttpClient.c:65: HttpClient_Connect: IP_ADDR=52.217.100.228 00:03:20 WARN ../ota/source/OtaHttpClient.c:160: HttpClient_Connect: WARNING Socket Connect, status=-453, Ignored... 00:03:20 INFO ../ota/source/OtaLib.c:101: ---->Progress: 0% --- Dowloaded:0 Filesize: 0 00:03:20 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:20 DEBUG ../app/app_main.c:273: ========================================= 00:03:20 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:20 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:20 DEBUG ../app/app_main.c:276: ========================================= 00:03:20 DEBUG ../ota/source/OtaLib.c:294: OTA_run: Call CdnClient_ReqFileContent, url = https://bjex-stg.s3.amazonaws.com/9d2/9d2c2c36-fa30-4e8e-b75a-d76d0bf53f69 00:03:20 INFO ../ota/source/OtaLib.c:101: ---->Progress: 0% --- Dowloaded:0 Filesize: 0 00:03:20 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:20 DEBUG ../app/app_main.c:273: ========================================= 00:03:20 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:20 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:20 DEBUG ../app/app_main.c:276: ========================================= 00:03:20 DEBUG ../imc/aquai.c:904: --> RX: Received frame: 18 00:03:20 INFO ../imc/aquai.c:778: Update RSSI 00:03:20 INFO ../app/mqtt_client_task.c:600: PUSH Command Data /topic/device/aquairepeater/in 00:03:20 INFO ../app/mqtt_client_task.c:601: PAYLOAD: {"deviceId":"AQ900RP000000035","rssi":-100,"waterflow":0,"type":"RSSI"} 00:03:20 INFO ../app/mqtt_client_task.c:602: LENGTH: 71 00:03:20 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 1 00:03:20 INFO ../ota/source/OtaLib.c:101: ---->Progress: 0% --- Dowloaded:0 Filesize: 256000 00:03:20 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:20 DEBUG ../app/app_main.c:273: ========================================= 00:03:20 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:20 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:20 DEBUG ../app/app_main.c:276: ========================================= 00:03:20 INFO ../ota/source/OtaArchive.c:883: OtaArchive_RunParse: set state=ARCHIVE_STATE_PARSE_HDR 00:03:20 INFO ../ota/source/OtaLib.c:101: ---->Progress: 0% --- Dowloaded:0 Filesize: 256000 00:03:20 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:20 DEBUG ../app/app_main.c:273: ========================================= 00:03:20 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:20 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:20 DEBUG ../app/app_main.c:276: ========================================= 00:03:20 INFO ../ota/source/OtaArchive.c:891: OtaArchive_RunParseTar: parsing archive file header 00:03:20 INFO ../ota/source/OtaArchive.c:974: OtaArchive_RunParseTar: filetype=5, directory=20220419124257_CC3220SF_huy-OTA-19-4-22/ 00:03:20 INFO ../ota/source/OtaLib.c:101: ---->Progress: 0% --- Dowloaded:512 Filesize: 256000 00:03:21 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:21 DEBUG ../app/app_main.c:273: ========================================= 00:03:21 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:21 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:21 DEBUG ../app/app_main.c:276: ========================================= 00:03:21 INFO ../ota/source/OtaArchive.c:891: OtaArchive_RunParseTar: parsing archive file header 00:03:21 INFO ../ota/source/OtaArchive.c:974: OtaArchive_RunParseTar: filetype=5, directory=20220419124257_CC3220SF_huy-OTA-19-4-22/0/ 00:03:21 INFO ../ota/source/OtaLib.c:101: ---->Progress: 0% --- Dowloaded:1024 Filesize: 256000 00:03:21 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:21 DEBUG ../app/app_main.c:273: ========================================= 00:03:21 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:21 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:21 DEBUG ../app/app_main.c:276: ========================================= 00:03:21 INFO ../ota/source/OtaArchive.c:891: OtaArchive_RunParseTar: parsing archive file header 00:03:21 INFO ../ota/source/OtaArchive.c:974: OtaArchive_RunParseTar: filetype=5, directory=20220419124257_CC3220SF_huy-OTA-19-4-22/1/ 00:03:21 INFO ../ota/source/OtaLib.c:101: ---->Progress: 0% --- Dowloaded:1536 Filesize: 256000 00:03:21 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:21 DEBUG ../app/app_main.c:273: ========================================= 00:03:21 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:21 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:21 DEBUG ../app/app_main.c:276: ========================================= 00:03:21 INFO ../ota/source/OtaArchive.c:891: OtaArchive_RunParseTar: parsing archive file header 00:03:21 INFO ../ota/source/OtaArchive.c:974: OtaArchive_RunParseTar: filetype=5, directory=20220419124257_CC3220SF_huy-OTA-19-4-22/2/ 00:03:21 INFO ../ota/source/OtaLib.c:101: ---->Progress: 0% --- Dowloaded:2048 Filesize: 256000 00:03:21 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:21 DEBUG ../app/app_main.c:273: ========================================= 00:03:21 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:21 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:21 DEBUG ../app/app_main.c:276: ========================================= 00:03:21 INFO ../ota/source/OtaArchive.c:891: OtaArchive_RunParseTar: parsing archive file header 00:03:21 INFO ../ota/source/OtaArchive.c:1005: OtaArchive_RunParseTar: FileType=0, FileName=ota.cmd, FileSize=1889 00:03:21 INFO ../ota/source/OtaLib.c:101: ---->Progress: 1% --- Dowloaded:2560 Filesize: 256000 00:03:21 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:21 DEBUG ../app/app_main.c:273: ========================================= 00:03:21 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:21 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:21 DEBUG ../app/app_main.c:276: ========================================= 00:03:21 DEBUG ../ota/source/OtaArchive.c:496: [_BundleCmdFile_Parse] bundle cmd file=/sys/mcuflashimg.bin, sig_len=256, SHA_256_Digets=a0d6cf10fecbe34c4ddf2a1640cf1677708e3a469a50140db2fb6a2a2207957b, cert=dummy-root-ca-cert, secured=1, bundle=1 00:03:21 DEBUG ../ota/source/OtaArchive.c:496: [_BundleCmdFile_Parse] bundle cmd file=aquaicf1, sig_len=0, SHA_256_Digets=974bcb82769d06037e30ed93ede76af7bbd42e88337562240620dfc0a92c9472, cert=, secured=0, bundle=0 00:03:21 INFO ../ota/source/OtaLib.c:101: ---->Progress: 1% --- Dowloaded:3392 Filesize: 256000 00:03:21 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:21 DEBUG ../app/app_main.c:273: ========================================= 00:03:21 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:21 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:21 DEBUG ../app/app_main.c:276: ========================================= 00:03:21 DEBUG ../ota/source/OtaArchive.c:496: [_BundleCmdFile_Parse] bundle cmd file=dummy-root-ca-cert, sig_len=0, SHA_256_Digets=34941765501d16a4ab776c3a74d89945f1a2575c5893069f62ffbe803f344549, cert=, secured=0, bundle=0 00:03:21 DEBUG ../ota/source/OtaArchive.c:496: [_BundleCmdFile_Parse] bundle cmd file=dummy_ota_vendor_cert.der, sig_len=0, SHA_256_Digets=a160b855d7a00a6002922181377249a80ecd6a738d23e1dd8976c8bb7fad1bcb, cert=, secured=0, bundle=0 00:03:21 DEBUG ../ota/source/OtaArchive.c:496: [_BundleCmdFile_Parse] bundle cmd file=/sys/servicepack.ucf, sig_len=256, SHA_256_Digets=b1c205553d8619be7b99647f44504cde64b567dc659ff784533471e9cee84ef9, cert=, secured=1, bundle=1 00:03:21 INFO ../ota/source/OtaLib.c:101: ---->Progress: 1% --- Dowloaded:4448 Filesize: 256000 00:03:21 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:21 DEBUG ../app/app_main.c:273: ========================================= 00:03:21 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:21 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:21 DEBUG ../app/app_main.c:276: ========================================= 00:03:21 INFO ../ota/source/OtaArchive.c:891: OtaArchive_RunParseTar: parsing archive file header 00:03:21 INFO ../ota/source/OtaArchive.c:904: OtaArchive_RunParseTar: skip block align RecvBufLen=1440, SkipAlignSize=160 00:03:21 INFO ../ota/source/OtaArchive.c:1005: OtaArchive_RunParseTar: FileType=0, FileName=ota.sign, FileSize=72 00:03:21 INFO ../ota/source/OtaLib.c:101: ---->Progress: 2% --- Dowloaded:5120 Filesize: 256000 00:03:21 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:21 DEBUG ../app/app_main.c:273: ========================================= 00:03:21 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:21 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:21 DEBUG ../app/app_main.c:276: ========================================= 00:03:23 INFO ../ota/source/OtaLib.c:101: ---->Progress: 2% --- Dowloaded:5192 Filesize: 256000 00:03:23 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:23 DEBUG ../app/app_main.c:273: ========================================= 00:03:23 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:23 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:23 DEBUG ../app/app_main.c:276: ========================================= 00:03:23 INFO ../ota/source/OtaArchive.c:891: OtaArchive_RunParseTar: parsing archive file header 00:03:23 INFO ../ota/source/OtaArchive.c:904: OtaArchive_RunParseTar: skip block align RecvBufLen=696, SkipAlignSize=440 00:03:23 INFO ../ota/source/OtaLib.c:101: ---->Progress: 2% --- Dowloaded:5632 Filesize: 256000 00:03:23 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:23 DEBUG ../app/app_main.c:273: ========================================= 00:03:23 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:23 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:23 DEBUG ../app/app_main.c:276: ========================================= 00:03:23 INFO ../ota/source/OtaArchive.c:891: OtaArchive_RunParseTar: parsing archive file header 00:03:23 INFO ../ota/source/OtaArchive.c:1005: OtaArchive_RunParseTar: FileType=0, FileName=dummy-root-ca-cert, FileSize=975 00:03:23 INFO ../ota/source/OtaLib.c:101: ---->Progress: 2% --- Dowloaded:6144 Filesize: 256000 00:03:23 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:23 DEBUG ../app/app_main.c:273: ========================================= 00:03:23 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:23 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:23 DEBUG ../app/app_main.c:276: ========================================= 00:03:23 INFO ../ota/source/OtaArchive.c:1080: Create/Open for write file dummy-root-ca-cert 00:03:23 INFO ../ota/source/OtaLib.c:101: ---->Progress: 2% --- Dowloaded:6144 Filesize: 256000 00:03:23 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:23 DEBUG ../app/app_main.c:273: ========================================= 00:03:23 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:23 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:23 DEBUG ../app/app_main.c:276: ========================================= 00:03:23 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 928 00:03:23 INFO ../ota/source/OtaArchive.c:1187: to file dummy-root-ca-cert 00:03:23 INFO ../ota/source/OtaArchive.c:1188: total 928. 00:03:23 INFO ../ota/source/OtaLib.c:101: ---->Progress: 2% --- Dowloaded:7072 Filesize: 256000 00:03:23 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:23 DEBUG ../app/app_main.c:273: ========================================= 00:03:23 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:23 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:23 DEBUG ../app/app_main.c:276: ========================================= 00:03:23 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 47 00:03:23 INFO ../ota/source/OtaArchive.c:1187: to file dummy-root-ca-cert 00:03:23 INFO ../ota/source/OtaArchive.c:1188: total 975. 00:03:23 INFO ../ota/source/OtaArchive.c:1209: Hash verification succeeded. 00:03:23 INFO ../ota/source/OtaArchive.c:1231: Total archive file bytes 7119. 00:03:23 INFO ../ota/source/OtaArchive.c:1280: OtaArchive_RunParseTar: 1 files that are mentioned in the ota.cmd were saved 00:03:23 INFO ../ota/source/OtaArchive.c:1283: OtaArchive_RunParseTar: Downloading File Completed - Size=975 00:03:23 INFO ../ota/source/OtaLib.c:101: ---->Progress: 2% --- Dowloaded:7119 Filesize: 256000 00:03:23 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:23 DEBUG ../app/app_main.c:273: ========================================= 00:03:23 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:23 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:23 DEBUG ../app/app_main.c:276: ========================================= 00:03:23 INFO ../ota/source/OtaArchive.c:891: OtaArchive_RunParseTar: parsing archive file header 00:03:23 INFO ../ota/source/OtaArchive.c:904: OtaArchive_RunParseTar: skip block align RecvBufLen=1393, SkipAlignSize=49 00:03:23 INFO ../ota/source/OtaArchive.c:1005: OtaArchive_RunParseTar: FileType=0, FileName=/sys/mcuflashimg.bin, FileSize=161516 00:03:23 INFO ../ota/source/OtaLib.c:101: ---->Progress: 3% --- Dowloaded:7680 Filesize: 256000 00:03:23 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:23 DEBUG ../app/app_main.c:273: ========================================= 00:03:23 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:23 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:23 DEBUG ../app/app_main.c:276: ========================================= 00:03:23 INFO ../ota/source/OtaArchive.c:1080: Create/Open for write file /sys/mcuflashimg.bin 00:03:40 DEBUG ../imc/aquai.c:904: --> RX: Received frame: 18 00:03:40 INFO ../imc/aquai.c:778: Update RSSI 00:03:40 INFO ../app/mqtt_client_task.c:600: PUSH Command Data /topic/device/aquairepeater/in 00:03:40 INFO ../app/mqtt_client_task.c:601: PAYLOAD: {"deviceId":"AQ900RP000000035","rssi":-100,"waterflow":0,"type":"RSSI"} 00:03:40 INFO ../app/mqtt_client_task.c:602: LENGTH: 71 00:03:40 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 1 00:03:45 INFO ../ota/source/OtaLi00:03:45 INFO ../app/mqtt_client_cbs.c:134: Msg Recvd. by client 00:03:45 INFO ../app/mqtt_client_cbs.c:135: TOPIC: /topic/device/aquaihealthcheck/out{"cmd":"ping","payloadType":"aquaiHealthCheck","queueName":"aquaiHealthCheck"},"url":"https://testing-stg.s3.amazonaws.com/9d2/9d2c2c36-fa30-4e8e-b75a-d76d0bf53f69","ch 00:03:45 INFO ../app/mqtt_client_cbs.c:136: PAYLOAD: {"cmd":"ping","payloadType":"aquaiHealthCheck","queueName":"aquaiHealthCheck"},"url":"https://testing-stg.s3.amazonaws.com/9d2/9d2c2c36-fa30-4e8e-b75a-d76d0bf53f69","checksum":"1d0ff48e2572f78520c5f3e 00:03:45 INFO ../app/mqtt_client_cbs.c:137: QOS: 0 00:03:45 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 8 b.c:101: ---->Progress: 3% --- Dowloaded:7680 Filesize: 256000 00:03:45 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:45 DEBUG ../app/app_main.c:273: ========================================= 00:03:45 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:45 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:45 DEBUG ../app/app_main.c:276: ========================================= 00:03:46 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 832 00:03:46 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:46 INFO ../ota/source/OtaArchive.c:1188: total 832. 00:03:46 INFO ../ota/source/OtaLib.c:101: ---->Progress: 3% --- Dowloaded:8512 Filesize: 256000 00:03:46 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:46 DEBUG ../app/app_main.c:273: ========================================= 00:03:46 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:46 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:46 DEBUG ../app/app_main.c:276: ========================================= 00:03:46 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:46 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:46 INFO ../ota/source/OtaArchive.c:1188: total 2272. 00:03:46 INFO ../ota/source/OtaLib.c:101: ---->Progress: 3% --- Dowloaded:9952 Filesize: 256000 00:03:46 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:46 DEBUG ../app/app_main.c:273: ========================================= 00:03:46 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:46 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:46 DEBUG ../app/app_main.c:276: ========================================= 00:03:46 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:46 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:46 INFO ../ota/source/OtaArchive.c:1188: total 3712. 00:03:46 INFO ../ota/source/OtaLib.c:101: ---->Progress: 4% --- Dowloaded:11392 Filesize: 256000 00:03:46 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:46 DEBUG ../app/app_main.c:273: ========================================= 00:03:46 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:46 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:46 DEBUG ../app/app_main.c:276: ========================================= 00:03:46 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:46 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:46 INFO ../ota/source/OtaArchive.c:1188: total 5152. 00:03:46 INFO ../ota/source/OtaLib.c:101: ---->Progress: 5% --- Dowloaded:12832 Filesize: 256000 00:03:46 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:46 DEBUG ../app/app_main.c:273: ========================================= 00:03:46 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:46 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:46 DEBUG ../app/app_main.c:276: ========================================= 00:03:46 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:46 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:46 INFO ../ota/source/OtaArchive.c:1188: total 6592. 00:03:46 INFO ../ota/source/OtaLib.c:101: ---->Progress: 5% --- Dowloaded:14272 Filesize: 256000 00:03:46 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:46 DEBUG ../app/app_main.c:273: ========================================= 00:03:46 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:46 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:46 DEBUG ../app/app_main.c:276: ========================================= 00:03:46 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:46 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:46 INFO ../ota/source/OtaArchive.c:1188: total 8032. 00:03:46 INFO ../ota/source/OtaLib.c:101: ---->Progress: 6% --- Dowloaded:15712 Filesize: 256000 00:03:46 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:46 DEBUG ../app/app_main.c:273: ========================================= 00:03:46 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:46 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:46 DEBUG ../app/app_main.c:276: ========================================= 00:03:46 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:46 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:46 INFO ../ota/source/OtaArchive.c:1188: total 9472. 00:03:46 INFO ../ota/source/OtaLib.c:101: ---->Progress: 6% --- Dowloaded:17152 Filesize: 256000 00:03:46 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:46 DEBUG ../app/app_main.c:273: ========================================= 00:03:46 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:46 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:46 DEBUG ../app/app_main.c:276: ========================================= 00:03:46 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:46 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:46 INFO ../ota/source/OtaArchive.c:1188: total 10912. 00:03:46 INFO ../ota/source/OtaLib.c:101: ---->Progress: 7% --- Dowloaded:18592 Filesize: 256000 00:03:46 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:46 DEBUG ../app/app_main.c:273: ========================================= 00:03:46 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:46 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:46 DEBUG ../app/app_main.c:276: ========================================= 00:03:46 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_Run00:03:46 INFO ../app/mqtt_client_task.c:663: Received Ping Cmd. 00:03:46 INFO ../imc/aquai.c:1107: BLE Tx: Send PING. ParseTar: Write size 1440 00:03:46 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:46 INFO ../ota/source/OtaArchive.c:1188: total 12352. 00:03:46 INFO ../ota/source/OtaLib.c:101: ---->Progress: 7% --- Dowloaded:20032 Filesize: 256000 00:03:46 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:46 DEBUG ../app/app_main.c:273: ========================================= 00:03:46 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:46 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:46 DEBUG ../app/app_main.c:276: ========================================= 00:03:46 DEBUG ../imc/aquai.c:904: --> RX: Received frame: 26 00:03:46 INFO ../imc/aquai.c:867: BLE Rx: Get Pong from: AQ900RP000000035 00:03:46 INFO ../app/mqtt_client_task.c:613: PUSH Pong /topic/device/aquaihealthcheck/in 00:03:46 INFO ../app/mqtt_client_task.c:614: PAYLOAD: {"deviceId":"AQ900RP000000035","cmd":"pong"} 00:03:46 INFO ../app/mqtt_client_task.c:615: LENGTH: 44 00:03:46 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 4 00:03:46 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:46 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:46 INFO ../ota/source/OtaArchive.c:1188: total 13792. 00:03:46 INFO ../ota/source/OtaLib.c:101: ---->Progress: 8% --- Dowloaded:21472 Filesize: 256000 00:03:46 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:46 DEBUG ../app/app_main.c:273: ========================================= 00:03:46 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:46 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:46 DEBUG ../app/app_main.c:276: ========================================= 00:03:46 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:46 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:46 INFO ../ota/source/OtaArchive.c:1188: total 15232. 00:03:46 INFO ../ota/source/OtaLib.c:101: ---->Progress: 8% --- Dowloaded:22912 Filesize: 256000 00:03:46 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:46 DEBUG ../app/app_main.c:273: ========================================= 00:03:46 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:46 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:46 DEBUG ../app/app_main.c:276: ========================================= 00:03:46 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:47 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:47 INFO ../ota/source/OtaArchive.c:1188: total 16672. 00:03:47 INFO ../ota/source/OtaLib.c:101: ---->Progress: 9% --- Dowloaded:24352 Filesize: 256000 00:03:47 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:47 DEBUG ../app/app_main.c:273: ========================================= 00:03:47 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:47 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:47 DEBUG ../app/app_main.c:276: ========================================= 00:03:47 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:47 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:47 INFO ../ota/source/OtaArchive.c:1188: total 18112. 00:03:47 INFO ../ota/source/OtaLib.c:101: ---->Progress: 10% --- Dowloaded:25792 Filesize: 256000 00:03:47 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:47 DEBUG ../app/app_main.c:273: ========================================= 00:03:47 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:47 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:47 DEBUG ../app/app_main.c:276: ========================================= 00:03:47 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:47 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:47 INFO ../ota/source/OtaArchive.c:1188: total 19552. 00:03:47 INFO ../ota/source/OtaLib.c:101: ---->Progress: 10% --- Dowloaded:27232 Filesize: 256000 00:03:47 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:47 DEBUG ../app/app_main.c:273: ========================================= 00:03:47 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:47 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:47 DEBUG ../app/app_main.c:276: ========================================= 00:03:47 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:47 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:47 INFO ../ota/source/OtaArchive.c:1188: total 20992. 00:03:47 INFO ../ota/source/OtaLib.c:101: ---->Progress: 11% --- Dowloaded:28672 Filesize: 256000 00:03:47 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 5 00:03:47 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:47 DEBUG ../app/app_main.c:273: ========================================= 00:03:47 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:47 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:47 DEBUG ../app/app_main.c:276: ========================================= 00:03:47 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:47 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:47 INFO ../ota/source/OtaArchive.c:1188: total 22432. 00:03:47 INFO ../ota/source/OtaLib.c:101: ---->Progress: 11% --- Dowloaded:30112 Filesize: 256000 00:03:47 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:47 INFO ../app/mqtt_client_task.c:627: PUSH OTA Progress /topic/device/version/progress 00:03:47 INFO ../app/mqtt_client_task.c:628: PAYLOAD: {"deviceId": "AQ900RP000000035","state": "downloading", "progress": 11} 00:03:47 INFO ../app/mqtt_client_task.c:629: LENGTH: 71 00:03:47 DEBUG ../app/app_main.c:273: ========================================= 00:03:47 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:47 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:47 DEBUG ../app/app_main.c:276: ========================================= 00:03:47 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:47 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:47 INFO ../ota/source/OtaArchive.c:1188: total 23872. 00:03:47 INFO ../ota/source/OtaLib.c:101: ---->Progress: 12% --- Dowloaded:31552 Filesize: 256000 00:03:47 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:47 DEBUG ../app/app_main.c:273: ========================================= 00:03:47 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:47 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:47 DEBUG ../app/app_main.c:276: ========================================= 00:03:47 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:47 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:47 INFO ../ota/source/OtaArchive.c:1188: total 25312. 00:03:47 INFO ../ota/source/OtaLib.c:101: ---->Progress: 12% --- Dowloaded:32992 Filesize: 256000 00:03:47 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:47 DEBUG ../app/app_main.c:273: ========================================= 00:03:47 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:47 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:47 DEBUG ../app/app_main.c:276: ========================================= 00:03:47 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:47 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:47 INFO ../ota/source/OtaArchive.c:1188: total 26752. 00:03:47 INFO ../ota/source/OtaLib.c:101: ---->Progress: 13% --- Dowloaded:34432 Filesize: 256000 00:03:47 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:47 DEBUG ../app/app_main.c:273: ========================================= 00:03:47 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:47 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:47 DEBUG ../app/app_main.c:276: ========================================= 00:03:47 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:47 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:47 INFO ../ota/source/OtaArchive.c:1188: total 28192. 00:03:47 INFO ../ota/source/OtaLib.c:101: ---->Progress: 14% --- Dowloaded:35872 Filesize: 256000 00:03:47 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:47 DEBUG ../app/app_main.c:273: ========================================= 00:03:47 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:47 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:47 DEBUG ../app/app_main.c:276: ========================================= 00:03:47 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:47 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:47 INFO ../ota/source/OtaArchive.c:1188: total 29632. 00:03:47 INFO ../ota/source/OtaLib.c:101: ---->Progress: 14% --- Dowloaded:37312 Filesize: 256000 00:03:47 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:47 DEBUG ../app/app_main.c:273: ========================================= 00:03:47 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:47 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:47 DEBUG ../app/app_main.c:276: ========================================= 00:03:47 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:47 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:47 INFO ../ota/source/OtaArchive.c:1188: total 31072. 00:03:47 INFO ../ota/source/OtaLib.c:101: ---->Progress: 15% --- Dowloaded:38752 Filesize: 256000 00:03:47 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:47 DEBUG ../app/app_main.c:273: ========================================= 00:03:47 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:47 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:47 DEBUG ../app/app_main.c:276: ========================================= 00:03:47 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:47 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:47 INFO ../ota/source/OtaArchive.c:1188: total 32512. 00:03:47 INFO ../ota/source/OtaLib.c:101: ---->Progress: 15% --- Dowloaded:40192 Filesize: 256000 00:03:47 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:47 DEBUG ../app/app_main.c:273: ========================================= 00:03:48 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:48 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:48 DEBUG ../app/app_main.c:276: ========================================= 00:03:48 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:48 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:48 INFO ../ota/source/OtaArchive.c:1188: total 33952. 00:03:48 INFO ../ota/source/OtaLib.c:101: ---->Progress: 16% --- Dowloaded:41632 Filesize: 256000 00:03:48 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:48 DEBUG ../app/app_main.c:273: ========================================= 00:03:48 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:48 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:48 DEBUG ../app/app_main.c:276: ========================================= 00:03:48 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:48 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:48 INFO ../ota/source/OtaArchive.c:1188: total 35392. 00:03:48 INFO ../ota/source/OtaLib.c:101: ---->Progress: 16% --- Dowloaded:43072 Filesize: 256000 00:03:48 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:48 DEBUG ../app/app_main.c:273: ========================================= 00:03:48 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:48 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:48 DEBUG ../app/app_main.c:276: ========================================= 00:03:48 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:48 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:48 INFO ../ota/source/OtaArchive.c:1188: total 36832. 00:03:48 INFO ../ota/source/OtaLib.c:101: ---->Progress: 17% --- Dowloaded:44512 Filesize: 256000 00:03:48 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:48 DEBUG ../app/app_main.c:273: ========================================= 00:03:48 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:48 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:48 DEBUG ../app/app_main.c:276: ========================================= 00:03:48 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:48 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:48 INFO ../ota/source/OtaArchive.c:1188: total 38272. 00:03:48 INFO ../ota/source/OtaLib.c:101: ---->Progress: 17% --- Dowloaded:45952 Filesize: 256000 00:03:48 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:48 DEBUG ../app/app_main.c:273: ========================================= 00:03:48 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:48 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:48 DEBUG ../app/app_main.c:276: ========================================= 00:03:48 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:48 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:48 INFO ../ota/source/OtaArchive.c:1188: total 39712. 00:03:48 INFO ../ota/source/OtaLib.c:101: ---->Progress: 18% --- Dowloaded:47392 Filesize: 256000 00:03:48 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:48 DEBUG ../app/app_main.c:273: ========================================= 00:03:48 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:48 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:48 DEBUG ../app/app_main.c:276: ========================================= 00:03:48 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:48 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:48 INFO ../ota/source/OtaArchive.c:1188: total 41152. 00:03:48 INFO ../ota/source/OtaLib.c:101: ---->Progress: 19% --- Dowloaded:48832 Filesize: 256000 00:03:48 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:48 DEBUG ../app/app_main.c:273: ========================================= 00:03:48 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:48 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:48 DEBUG ../app/app_main.c:276: ========================================= 00:03:48 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:48 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:48 INFO ../ota/source/OtaArchive.c:1188: total 42592. 00:03:48 INFO ../ota/source/OtaLib.c:101: ---->Progress: 19% --- Dowloaded:50272 Filesize: 256000 00:03:48 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:48 DEBUG ../app/app_main.c:273: ========================================= 00:03:48 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:48 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:48 DEBUG ../app/app_main.c:276: ========================================= 00:03:48 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:48 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:48 INFO ../ota/source/OtaArchive.c:1188: total 44032. 00:03:48 INFO ../ota/source/OtaLib.c:101: ---->Progress: 20% --- Dowloaded:51712 Filesize: 256000 00:03:48 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:48 DEBUG ../app/app_main.c:273: ========================================= 00:03:48 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:48 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:48 DEBUG ../app/app_main.c:276: ========================================= 00:03:48 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:48 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:48 INFO ../ota/source/OtaArchive.c:1188: total 45472. 00:03:48 INFO ../ota/source/OtaLib.c:101: ---->Progress: 20% --- Dowloaded:53152 Filesize: 256000 00:03:48 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:48 DEBUG ../app/app_main.c:273: ========================================= 00:03:48 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:48 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:48 DEBUG ../app/app_main.c:276: ========================================= 00:03:48 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:48 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:48 INFO ../ota/source/OtaArchive.c:1188: total 46912. 00:03:48 INFO ../ota/source/OtaLib.c:101: ---->Progress: 21% --- Dowloaded:54592 Filesize: 256000 00:03:48 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:48 DEBUG ../app/app_main.c:273: ========================================= 00:03:48 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:48 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:48 DEBUG ../app/app_main.c:276: ========================================= 00:03:48 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:48 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:48 INFO ../ota/source/OtaArchive.c:1188: total 48352. 00:03:48 INFO ../ota/source/OtaLib.c:101: ---->Progress: 21% --- Dowloaded:56032 Filesize: 256000 00:03:48 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:48 DEBUG ../app/app_main.c:273: ========================================= 00:03:48 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:48 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:48 DEBUG ../app/app_main.c:276: ========================================= 00:03:48 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:48 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:48 INFO ../ota/source/OtaArchive.c:1188: total 49792. 00:03:48 INFO ../ota/source/OtaLib.c:101: ---->Progress: 22% --- Dowloaded:57472 Filesize: 256000 00:03:49 INFO ../app/mqtt_client_task.c:627: PUSH OTA Progress /topic/device/version/progress 00:03:49 INFO ../app/mqtt_client_task.c:628: PAYLOAD: {"deviceId": "AQ900RP000000035","state": "downloading", "progress": 22} 00:03:49 INFO ../app/mqtt_client_task.c:629: LENGTH: 71 00:03:49 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 5 00:03:49 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:49 DEBUG ../app/app_main.c:273: ========================================= 00:03:49 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:49 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:49 DEBUG ../app/app_main.c:276: ========================================= 00:03:49 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:49 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:49 INFO ../ota/source/OtaArchive.c:1188: total 51232. 00:03:49 INFO ../ota/source/OtaLib.c:101: ---->Progress: 23% --- Dowloaded:58912 Filesize: 256000 00:03:49 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:49 DEBUG ../app/app_main.c:273: ========================================= 00:03:49 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:49 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:49 DEBUG ../app/app_main.c:276: ========================================= 00:03:49 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:49 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:49 INFO ../ota/source/OtaArchive.c:1188: total 52672. 00:03:49 INFO ../ota/source/OtaLib.c:101: ---->Progress: 23% --- Dowloaded:60352 Filesize: 256000 00:03:49 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:49 DEBUG ../app/app_main.c:273: ========================================= 00:03:49 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:49 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:49 DEBUG ../app/app_main.c:276: ========================================= 00:03:49 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:49 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:49 INFO ../ota/source/OtaArchive.c:1188: total 54112. 00:03:49 INFO ../ota/source/OtaLib.c:101: ---->Progress: 24% --- Dowloaded:61792 Filesize: 256000 00:03:49 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:49 DEBUG ../app/app_main.c:273: ========================================= 00:03:49 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:49 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:49 DEBUG ../app/app_main.c:276: ========================================= 00:03:49 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:49 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:49 INFO ../ota/source/OtaArchive.c:1188: total 55552. 00:03:49 INFO ../ota/source/OtaLib.c:101: ---->Progress: 24% --- Dowloaded:63232 Filesize: 256000 00:03:49 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:49 DEBUG ../app/app_main.c:273: ========================================= 00:03:49 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:49 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:49 DEBUG ../app/app_main.c:276: ========================================= 00:03:49 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:49 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:49 INFO ../ota/source/OtaArchive.c:1188: total 56992. 00:03:49 INFO ../ota/source/OtaLib.c:101: ---->Progress: 25% --- Dowloaded:64672 Filesize: 256000 00:03:49 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:49 DEBUG ../app/app_main.c:273: ========================================= 00:03:49 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:49 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:49 DEBUG ../app/app_main.c:276: ========================================= 00:03:49 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:49 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:49 INFO ../ota/source/OtaArchive.c:1188: total 58432. 00:03:49 INFO ../ota/source/OtaLib.c:101: ---->Progress: 25% --- Dowloaded:66112 Filesize: 256000 00:03:49 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:49 DEBUG ../app/app_main.c:273: ========================================= 00:03:49 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:49 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:49 DEBUG ../app/app_main.c:276: ========================================= 00:03:49 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:49 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:49 INFO ../ota/source/OtaArchive.c:1188: total 59872. 00:03:49 INFO ../ota/source/OtaLib.c:101: ---->Progress: 26% --- Dowloaded:67552 Filesize: 256000 00:03:49 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:49 DEBUG ../app/app_main.c:273: ========================================= 00:03:49 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:49 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:49 DEBUG ../app/app_main.c:276: ========================================= 00:03:49 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:49 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:49 INFO ../ota/source/OtaArchive.c:1188: total 61312. 00:03:49 INFO ../ota/source/OtaLib.c:101: ---->Progress: 26% --- Dowloaded:68992 Filesize: 256000 00:03:49 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:49 DEBUG ../app/app_main.c:273: ========================================= 00:03:49 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:49 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:49 DEBUG ../app/app_main.c:276: ========================================= 00:03:49 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:49 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:49 INFO ../ota/source/OtaArchive.c:1188: total 62752. 00:03:49 INFO ../ota/source/OtaLib.c:101: ---->Progress: 27% --- Dowloaded:70432 Filesize: 256000 00:03:49 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:49 DEBUG ../app/app_main.c:273: ========================================= 00:03:49 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:49 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:49 DEBUG ../app/app_main.c:276: ========================================= 00:03:49 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:49 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:49 INFO ../ota/source/OtaArchive.c:1188: total 64192. 00:03:49 INFO ../ota/source/OtaLib.c:101: ---->Progress: 28% --- Dowloaded:71872 Filesize: 256000 00:03:49 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:49 DEBUG ../app/app_main.c:273: ========================================= 00:03:49 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:49 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:49 DEBUG ../app/app_main.c:276: ========================================= 00:03:49 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:49 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:49 INFO ../ota/source/OtaArchive.c:1188: total 65632. 00:03:49 INFO ../ota/source/OtaLib.c:101: ---->Progress: 28% --- Dowloaded:73312 Filesize: 256000 00:03:49 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:49 DEBUG ../app/app_main.c:273: ========================================= 00:03:49 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:49 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:50 DEBUG ../app/app_main.c:276: ========================================= 00:03:50 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:50 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:50 INFO ../ota/source/OtaArchive.c:1188: total 67072. 00:03:50 INFO ../ota/source/OtaLib.c:101: ---->Progress: 29% --- Dowloaded:74752 Filesize: 256000 00:03:50 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:50 DEBUG ../app/app_main.c:273: ========================================= 00:03:50 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:50 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:50 DEBUG ../app/app_main.c:276: ========================================= 00:03:50 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:50 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:50 INFO ../ota/source/OtaArchive.c:1188: total 68512. 00:03:50 INFO ../ota/source/OtaLib.c:101: ---->Progress: 29% --- Dowloaded:76192 Filesize: 256000 00:03:50 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:50 DEBUG ../app/app_main.c:273: ========================================= 00:03:50 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:50 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:50 DEBUG ../app/app_main.c:276: ========================================= 00:03:50 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:50 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:50 INFO ../ota/source/OtaArchive.c:1188: total 69952. 00:03:50 INFO ../ota/source/OtaLib.c:101: ---->Progress: 30% --- Dowloaded:77632 Filesize: 256000 00:03:50 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:50 DEBUG ../app/app_main.c:273: ========================================= 00:03:50 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:50 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:50 DEBUG ../app/app_main.c:276: ========================================= 00:03:50 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:50 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:50 INFO ../ota/source/OtaArchive.c:1188: total 71392. 00:03:50 INFO ../ota/source/OtaLib.c:101: ---->Progress: 30% --- Dowloaded:79072 Filesize: 256000 00:03:50 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:50 DEBUG ../app/app_main.c:273: ========================================= 00:03:50 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:50 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:50 DEBUG ../app/app_main.c:276: ========================================= 00:03:50 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:50 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:50 INFO ../ota/source/OtaArchive.c:1188: total 72832. 00:03:50 INFO ../ota/source/OtaLib.c:101: ---->Progress: 31% --- Dowloaded:80512 Filesize: 256000 00:03:50 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:50 DEBUG ../app/app_main.c:273: ========================================= 00:03:50 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:50 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:50 DEBUG ../app/app_main.c:276: ========================================= 00:03:50 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:50 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:50 INFO ../ota/source/OtaArchive.c:1188: total 74272. 00:03:50 INFO ../ota/source/OtaLib.c:101: ---->Progress: 32% --- Dowloaded:81952 Filesize: 256000 00:03:50 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:50 DEBUG ../app/app_main.c:273: ========================================= 00:03:50 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:50 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:50 DEBUG ../app/app_main.c:276: ========================================= 00:03:50 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:50 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:50 INFO ../ota/source/OtaArchive.c:1188: total 75712. 00:03:50 INFO ../ota/source/OtaLib.c:101: ---->Progress: 32% --- Dowloaded:83392 Filesize: 256000 00:03:50 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:50 DEBUG ../app/app_main.c:273: ========================================= 00:03:50 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:50 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:50 DEBUG ../app/app_main.c:276: ========================================= 00:03:50 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:50 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:50 INFO ../ota/source/OtaArchive.c:1188: total 77152. 00:03:50 INFO ../ota/source/OtaLib.c:101: ---->Progress: 33% --- Dowloaded:84832 Filesize: 256000 00:03:50 INFO ../app/mqtt_client_task.c:627: PUSH OTA Progress /topic/device/version/progress 00:03:50 INFO ../app/mqtt_client_task.c:628: PAYLOAD: {"deviceId": "AQ900RP000000035","state": "downloading", "progress": 33} 00:03:50 INFO ../app/mqtt_client_task.c:629: LENGTH: 71 00:03:50 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 5 00:03:50 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:50 DEBUG ../app/app_main.c:273: ========================================= 00:03:50 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:50 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:50 DEBUG ../app/app_main.c:276: ========================================= 00:03:50 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:50 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:50 INFO ../ota/source/OtaArchive.c:1188: total 78592. 00:03:50 INFO ../ota/source/OtaLib.c:101: ---->Progress: 33% --- Dowloaded:86272 Filesize: 256000 00:03:50 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:50 DEBUG ../app/app_main.c:273: ========================================= 00:03:50 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:50 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:50 DEBUG ../app/app_main.c:276: ========================================= 00:03:50 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:50 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:50 INFO ../ota/source/OtaArchive.c:1188: total 80032. 00:03:50 INFO ../ota/source/OtaLib.c:101: ---->Progress: 34% --- Dowloaded:87712 Filesize: 256000 00:03:50 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:50 DEBUG ../app/app_main.c:273: ========================================= 00:03:50 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:50 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:50 DEBUG ../app/app_main.c:276: ========================================= 00:03:50 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:50 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:50 INFO ../ota/source/OtaArchive.c:1188: total 81472. 00:03:50 INFO ../ota/source/OtaLib.c:101: ---->Progress: 34% --- Dowloaded:89152 Filesize: 256000 00:03:50 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:50 DEBUG ../app/app_main.c:273: ========================================= 00:03:50 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:50 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:50 DEBUG ../app/app_main.c:276: ========================================= 00:03:50 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:51 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:51 INFO ../ota/source/OtaArchive.c:1188: total 82912. 00:03:51 INFO ../ota/source/OtaLib.c:101: ---->Progress: 35% --- Dowloaded:90592 Filesize: 256000 00:03:51 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:51 DEBUG ../app/app_main.c:273: ========================================= 00:03:51 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:51 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:51 DEBUG ../app/app_main.c:276: ========================================= 00:03:51 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:51 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:51 INFO ../ota/source/OtaArchive.c:1188: total 84352. 00:03:51 INFO ../ota/source/OtaLib.c:101: ---->Progress: 35% --- Dowloaded:92032 Filesize: 256000 00:03:51 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:51 DEBUG ../app/app_main.c:273: ========================================= 00:03:51 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:51 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:51 DEBUG ../app/app_main.c:276: ========================================= 00:03:51 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:51 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:51 INFO ../ota/source/OtaArchive.c:1188: total 85792. 00:03:51 INFO ../ota/source/OtaLib.c:101: ---->Progress: 36% --- Dowloaded:93472 Filesize: 256000 00:03:51 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:51 DEBUG ../app/app_main.c:273: ========================================= 00:03:51 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:51 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:51 DEBUG ../app/app_main.c:276: ========================================= 00:03:51 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:51 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:51 INFO ../ota/source/OtaArchive.c:1188: total 87232. 00:03:51 INFO ../ota/source/OtaLib.c:101: ---->Progress: 37% --- Dowloaded:94912 Filesize: 256000 00:03:51 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:51 DEBUG ../app/app_main.c:273: ========================================= 00:03:51 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:51 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:51 DEBUG ../app/app_main.c:276: ========================================= 00:03:51 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:51 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:51 INFO ../ota/source/OtaArchive.c:1188: total 88672. 00:03:51 INFO ../ota/source/OtaLib.c:101: ---->Progress: 37% --- Dowloaded:96352 Filesize: 256000 00:03:51 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:51 DEBUG ../app/app_main.c:273: ========================================= 00:03:51 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:51 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:51 DEBUG ../app/app_main.c:276: ========================================= 00:03:51 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:51 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:51 INFO ../ota/source/OtaArchive.c:1188: total 90112. 00:03:51 INFO ../ota/source/OtaLib.c:101: ---->Progress: 38% --- Dowloaded:97792 Filesize: 256000 00:03:51 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:51 DEBUG ../app/app_main.c:273: ========================================= 00:03:51 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:51 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:51 DEBUG ../app/app_main.c:276: ========================================= 00:03:51 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:51 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:51 INFO ../ota/source/OtaArchive.c:1188: total 91552. 00:03:51 INFO ../ota/source/OtaLib.c:101: ---->Progress: 38% --- Dowloaded:99232 Filesize: 256000 00:03:51 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:51 DEBUG ../app/app_main.c:273: ========================================= 00:03:51 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:51 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:51 DEBUG ../app/app_main.c:276: ========================================= 00:03:51 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:51 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:51 INFO ../ota/source/OtaArchive.c:1188: total 92992. 00:03:51 INFO ../ota/source/OtaLib.c:101: ---->Progress: 39% --- Dowloaded:100672 Filesize: 256000 00:03:51 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:51 DEBUG ../app/app_main.c:273: ========================================= 00:03:51 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:51 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:51 DEBUG ../app/app_main.c:276: ========================================= 00:03:51 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:51 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:51 INFO ../ota/source/OtaArchive.c:1188: total 94432. 00:03:51 INFO ../ota/source/OtaLib.c:101: ---->Progress: 39% --- Dowloaded:102112 Filesize: 256000 00:03:51 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:51 DEBUG ../app/app_main.c:273: ========================================= 00:03:51 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:51 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:51 DEBUG ../app/app_main.c:276: ========================================= 00:03:51 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:51 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:51 INFO ../ota/source/OtaArchive.c:1188: total 95872. 00:03:51 INFO ../ota/source/OtaLib.c:101: ---->Progress: 40% --- Dowloaded:103552 Filesize: 256000 00:03:51 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:51 DEBUG ../app/app_main.c:273: ========================================= 00:03:51 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:51 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:51 DEBUG ../app/app_main.c:276: ========================================= 00:03:51 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:51 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:51 INFO ../ota/source/OtaArchive.c:1188: total 97312. 00:03:51 INFO ../ota/source/OtaLib.c:101: ---->Progress: 41% --- Dowloaded:104992 Filesize: 256000 00:03:51 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:51 DEBUG ../app/app_main.c:273: ========================================= 00:03:51 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:51 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:51 DEBUG ../app/app_main.c:276: ========================================= 00:03:51 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:51 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:51 INFO ../ota/source/OtaArchive.c:1188: total 98752. 00:03:51 INFO ../ota/source/OtaLib.c:101: ---->Progress: 41% --- Dowloaded:106432 Filesize: 256000 00:03:51 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:51 DEBUG ../app/app_main.c:273: ========================================= 00:03:51 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:51 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:51 DEBUG ../app/app_main.c:276: ========================================= 00:03:52 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:52 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:52 INFO ../ota/source/OtaArchive.c:1188: total 100192. 00:03:52 INFO ../ota/source/OtaLib.c:101: ---->Progress: 42% --- Dowloaded:107872 Filesize: 256000 00:03:52 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:52 DEBUG ../app/app_main.c:273: ========================================= 00:03:52 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:52 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:52 DEBUG ../app/app_main.c:276: ========================================= 00:03:52 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:52 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:52 INFO ../ota/source/OtaArchive.c:1188: total 101632. 00:03:52 INFO ../ota/source/OtaLib.c:101: ---->Progress: 42% --- Dowloaded:109312 Filesize: 256000 00:03:52 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:52 DEBUG ../app/app_main.c:273: ========================================= 00:03:52 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:52 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:52 DEBUG ../app/app_main.c:276: ========================================= 00:03:52 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:52 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:52 INFO ../ota/source/OtaArchive.c:1188: total 103072. 00:03:52 INFO ../ota/source/OtaLib.c:101: ---->Progress: 43% --- Dowloaded:110752 Filesize: 256000 00:03:52 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:52 DEBUG ../app/app_main.c:273: ========================================= 00:03:52 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:52 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:52 DEBUG ../app/app_main.c:276: ========================================= 00:03:52 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:52 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:52 INFO ../ota/source/OtaArchive.c:1188: total 104512. 00:03:52 INFO ../ota/source/OtaLib.c:101: ---->Progress: 43% --- Dowloaded:112192 Filesize: 256000 00:03:52 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:52 DEBUG ../app/app_main.c:273: ========================================= 00:03:52 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:52 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:52 DEBUG ../app/app_main.c:276: ========================================= 00:03:52 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:52 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:52 INFO ../ota/source/OtaArchive.c:1188: total 105952. 00:03:52 INFO ../ota/source/OtaLib.c:101: ---->Progress: 44% --- Dowloaded:113632 Filesize: 256000 00:03:52 INFO ../app/mqtt_client_task.c:627: PUSH OTA Progress /topic/device/version/progress 00:03:52 INFO ../app/mqtt_client_task.c:628: PAYLOAD: {"deviceId": "AQ900RP000000035","state": "downloading", "progress": 44} 00:03:52 INFO ../app/mqtt_client_task.c:629: LENGTH: 71 00:03:52 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 5 00:03:52 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:52 DEBUG ../app/app_main.c:273: ========================================= 00:03:52 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:52 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:52 DEBUG ../app/app_main.c:276: ========================================= 00:03:52 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:52 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:52 INFO ../ota/source/OtaArchive.c:1188: total 107392. 00:03:52 INFO ../ota/source/OtaLib.c:101: ---->Progress: 44% --- Dowloaded:115072 Filesize: 256000 00:03:52 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:52 DEBUG ../app/app_main.c:273: ========================================= 00:03:52 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:52 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:52 DEBUG ../app/app_main.c:276: ========================================= 00:03:52 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:52 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:52 INFO ../ota/source/OtaArchive.c:1188: total 108832. 00:03:52 INFO ../ota/source/OtaLib.c:101: ---->Progress: 45% --- Dowloaded:116512 Filesize: 256000 00:03:52 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:52 DEBUG ../app/app_main.c:273: ========================================= 00:03:52 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:52 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:52 DEBUG ../app/app_main.c:276: ========================================= 00:03:52 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:52 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:52 INFO ../ota/source/OtaArchive.c:1188: total 110272. 00:03:52 INFO ../ota/source/OtaLib.c:101: ---->Progress: 46% --- Dowloaded:117952 Filesize: 256000 00:03:52 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:52 DEBUG ../app/app_main.c:273: ========================================= 00:03:52 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:52 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:52 DEBUG ../app/app_main.c:276: ========================================= 00:03:52 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:52 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:52 INFO ../ota/source/OtaArchive.c:1188: total 111712. 00:03:52 INFO ../ota/source/OtaLib.c:101: ---->Progress: 46% --- Dowloaded:119392 Filesize: 256000 00:03:52 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:52 DEBUG ../app/app_main.c:273: ========================================= 00:03:52 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:52 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:52 DEBUG ../app/app_main.c:276: ========================================= 00:03:52 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:52 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:52 INFO ../ota/source/OtaArchive.c:1188: total 113152. 00:03:52 INFO ../ota/source/OtaLib.c:101: ---->Progress: 47% --- Dowloaded:120832 Filesize: 256000 00:03:52 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:52 DEBUG ../app/app_main.c:273: ========================================= 00:03:52 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:52 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:52 DEBUG ../app/app_main.c:276: ========================================= 00:03:52 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:52 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:52 INFO ../ota/source/OtaArchive.c:1188: total 114592. 00:03:52 INFO ../ota/source/OtaLib.c:101: ---->Progress: 47% --- Dowloaded:122272 Filesize: 256000 00:03:52 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:52 DEBUG ../app/app_main.c:273: ========================================= 00:03:52 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:52 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:52 DEBUG ../app/app_main.c:276: ========================================= 00:03:52 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:53 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:53 INFO ../ota/source/OtaArchive.c:1188: total 116032. 00:03:53 INFO ../ota/source/OtaLib.c:101: ---->Progress: 48% --- Dowloaded:123712 Filesize: 256000 00:03:53 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:53 DEBUG ../app/app_main.c:273: ========================================= 00:03:53 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:53 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:53 DEBUG ../app/app_main.c:276: ========================================= 00:03:53 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:53 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:53 INFO ../ota/source/OtaArchive.c:1188: total 117472. 00:03:53 INFO ../ota/source/OtaLib.c:101: ---->Progress: 48% --- Dowloaded:125152 Filesize: 256000 00:03:53 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:53 DEBUG ../app/app_main.c:273: ========================================= 00:03:53 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:53 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:53 DEBUG ../app/app_main.c:276: ========================================= 00:03:53 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:53 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:53 INFO ../ota/source/OtaArchive.c:1188: total 118912. 00:03:53 INFO ../ota/source/OtaLib.c:101: ---->Progress: 49% --- Dowloaded:126592 Filesize: 256000 00:03:53 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:53 DEBUG ../app/app_main.c:273: ========================================= 00:03:53 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:53 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:53 DEBUG ../app/app_main.c:276: ========================================= 00:03:53 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:53 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:53 INFO ../ota/source/OtaArchive.c:1188: total 120352. 00:03:53 INFO ../ota/source/OtaLib.c:101: ---->Progress: 50% --- Dowloaded:128032 Filesize: 256000 00:03:53 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:53 DEBUG ../app/app_main.c:273: ========================================= 00:03:53 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:53 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:53 DEBUG ../app/app_main.c:276: ========================================= 00:03:53 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:53 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:53 INFO ../ota/source/OtaArchive.c:1188: total 121792. 00:03:53 INFO ../ota/source/OtaLib.c:101: ---->Progress: 50% --- Dowloaded:129472 Filesize: 256000 00:03:53 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:53 DEBUG ../app/app_main.c:273: ========================================= 00:03:53 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:53 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:53 DEBUG ../app/app_main.c:276: ========================================= 00:03:53 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:53 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:53 INFO ../ota/source/OtaArchive.c:1188: total 123232. 00:03:53 INFO ../ota/source/OtaLib.c:101: ---->Progress: 51% --- Dowloaded:130912 Filesize: 256000 00:03:53 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:53 DEBUG ../app/app_main.c:273: ========================================= 00:03:53 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:53 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:53 DEBUG ../app/app_main.c:276: ========================================= 00:03:53 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:53 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:53 INFO ../ota/source/OtaArchive.c:1188: total 124672. 00:03:53 INFO ../ota/source/OtaLib.c:101: ---->Progress: 51% --- Dowloaded:132352 Filesize: 256000 00:03:53 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:53 DEBUG ../app/app_main.c:273: ========================================= 00:03:53 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:53 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:53 DEBUG ../app/app_main.c:276: ========================================= 00:03:53 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:53 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:53 INFO ../ota/source/OtaArchive.c:1188: total 126112. 00:03:53 INFO ../ota/source/OtaLib.c:101: ---->Progress: 52% --- Dowloaded:133792 Filesize: 256000 00:03:53 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:53 DEBUG ../app/app_main.c:273: ========================================= 00:03:53 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:53 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:53 DEBUG ../app/app_main.c:276: ========================================= 00:03:53 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:53 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:53 INFO ../ota/source/OtaArchive.c:1188: total 127552. 00:03:53 INFO ../ota/source/OtaLib.c:101: ---->Progress: 52% --- Dowloaded:135232 Filesize: 256000 00:03:53 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:53 DEBUG ../app/app_main.c:273: ========================================= 00:03:53 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:53 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:53 DEBUG ../app/app_main.c:276: ========================================= 00:03:53 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:53 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:53 INFO ../ota/source/OtaArchive.c:1188: total 128992. 00:03:53 INFO ../ota/source/OtaLib.c:101: ---->Progress: 53% --- Dowloaded:136672 Filesize: 256000 00:03:53 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:53 DEBUG ../app/app_main.c:273: ========================================= 00:03:53 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:53 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:53 DEBUG ../app/app_main.c:276: ========================================= 00:03:53 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:53 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:53 INFO ../ota/source/OtaArchive.c:1188: total 130432. 00:03:53 INFO ../ota/source/OtaLib.c:101: ---->Progress: 53% --- Dowloaded:138112 Filesize: 256000 00:03:53 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:53 DEBUG ../app/app_main.c:273: ========================================= 00:03:53 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:53 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:53 DEBUG ../app/app_main.c:276: ========================================= 00:03:53 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:53 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:53 INFO ../ota/source/OtaArchive.c:1188: total 131872. 00:03:53 INFO ../ota/source/OtaLib.c:101: ---->Progress: 54% --- Dowloaded:139552 Filesize: 256000 00:03:53 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:53 DEBUG ../app/app_main.c:273: ========================================= 00:03:53 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:53 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:53 DEBUG ../app/app_main.c:276: ========================================= 00:03:54 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:54 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:54 INFO ../ota/source/OtaArchive.c:1188: total 133312. 00:03:54 INFO ../ota/source/OtaLib.c:101: ---->Progress: 55% --- Dowloaded:140992 Filesize: 256000 00:03:54 INFO ../app/mqtt_client_task.c:627: PUSH OTA Progress /topic/device/version/progress 00:03:54 INFO ../app/mqtt_client_task.c:628: PAYLOAD: {"deviceId": "AQ900RP000000035","state": "downloading", "progress": 55} 00:03:54 INFO ../app/mqtt_client_task.c:629: LENGTH: 71 00:03:54 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 5 00:03:54 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:54 DEBUG ../app/app_main.c:273: ========================================= 00:03:54 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:54 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:54 DEBUG ../app/app_main.c:276: ========================================= 00:03:54 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:54 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:54 INFO ../ota/source/OtaArchive.c:1188: total 134752. 00:03:54 INFO ../ota/source/OtaLib.c:101: ---->Progress: 55% --- Dowloaded:142432 Filesize: 256000 00:03:54 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:54 DEBUG ../app/app_main.c:273: ========================================= 00:03:54 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:54 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:54 DEBUG ../app/app_main.c:276: ========================================= 00:03:54 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:54 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:54 INFO ../ota/source/OtaArchive.c:1188: total 136192. 00:03:54 INFO ../ota/source/OtaLib.c:101: ---->Progress: 56% --- Dowloaded:143872 Filesize: 256000 00:03:54 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:54 DEBUG ../app/app_main.c:273: ========================================= 00:03:54 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:54 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:54 DEBUG ../app/app_main.c:276: ========================================= 00:03:54 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:54 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:54 INFO ../ota/source/OtaArchive.c:1188: total 137632. 00:03:54 INFO ../ota/source/OtaLib.c:101: ---->Progress: 56% --- Dowloaded:145312 Filesize: 256000 00:03:54 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:54 DEBUG ../app/app_main.c:273: ========================================= 00:03:54 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:54 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:54 DEBUG ../app/app_main.c:276: ========================================= 00:03:54 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:54 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:54 INFO ../ota/source/OtaArchive.c:1188: total 139072. 00:03:54 INFO ../ota/source/OtaLib.c:101: ---->Progress: 57% --- Dowloaded:146752 Filesize: 256000 00:03:54 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:54 DEBUG ../app/app_main.c:273: ========================================= 00:03:54 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:54 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:54 DEBUG ../app/app_main.c:276: ========================================= 00:03:54 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:54 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:54 INFO ../ota/source/OtaArchive.c:1188: total 140512. 00:03:54 INFO ../ota/source/OtaLib.c:101: ---->Progress: 57% --- Dowloaded:148192 Filesize: 256000 00:03:54 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:54 DEBUG ../app/app_main.c:273: ========================================= 00:03:54 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:54 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:54 DEBUG ../app/app_main.c:276: ========================================= 00:03:54 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:54 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:54 INFO ../ota/source/OtaArchive.c:1188: total 141952. 00:03:54 INFO ../ota/source/OtaLib.c:101: ---->Progress: 58% --- Dowloaded:149632 Filesize: 256000 00:03:54 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:54 DEBUG ../app/app_main.c:273: ========================================= 00:03:54 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:54 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:54 DEBUG ../app/app_main.c:276: ========================================= 00:03:54 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:54 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:54 INFO ../ota/source/OtaArchive.c:1188: total 143392. 00:03:54 INFO ../ota/source/OtaLib.c:101: ---->Progress: 59% --- Dowloaded:151072 Filesize: 256000 00:03:54 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:54 DEBUG ../app/app_main.c:273: ========================================= 00:03:54 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:54 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:54 DEBUG ../app/app_main.c:276: ========================================= 00:03:54 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:54 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:54 INFO ../ota/source/OtaArchive.c:1188: total 144832. 00:03:54 INFO ../ota/source/OtaLib.c:101: ---->Progress: 59% --- Dowloaded:152512 Filesize: 256000 00:03:54 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:54 DEBUG ../app/app_main.c:273: ========================================= 00:03:54 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:54 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:54 DEBUG ../app/app_main.c:276: ========================================= 00:03:54 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:54 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:54 INFO ../ota/source/OtaArchive.c:1188: total 146272. 00:03:54 INFO ../ota/source/OtaLib.c:101: ---->Progress: 60% --- Dowloaded:153952 Filesize: 256000 00:03:54 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:54 DEBUG ../app/app_main.c:273: ========================================= 00:03:54 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:54 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:54 DEBUG ../app/app_main.c:276: ========================================= 00:03:54 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:54 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:54 INFO ../ota/source/OtaArchive.c:1188: total 147712. 00:03:54 INFO ../ota/source/OtaLib.c:101: ---->Progress: 60% --- Dowloaded:155392 Filesize: 256000 00:03:54 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:54 DEBUG ../app/app_main.c:273: ========================================= 00:03:54 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:54 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:54 DEBUG ../app/app_main.c:276: ========================================= 00:03:54 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:54 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:55 INFO ../ota/source/OtaArchive.c:1188: total 149152. 00:03:55 INFO ../ota/source/OtaLib.c:101: ---->Progress: 61% --- Dowloaded:156832 Filesize: 256000 00:03:55 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:55 DEBUG ../app/app_main.c:273: ========================================= 00:03:55 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:55 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:55 DEBUG ../app/app_main.c:276: ========================================= 00:03:55 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:55 INFO ../ota/source/OtaArchive.c:1187: 00:03:55 INFO ../app/mqtt_client_cbs.c:134: Msg Recvd. by client 00:03:55 INFO ../app/mqtt_client_cbs.c:135: TOPIC: /topic/device/aquaihealthcheck/out{"cmd":"ping","payloadType":"aquaiHealthCheck","queueName":"aquaiHealthCheck"},"url":"https://testing-stg.s3.amazonaws.com/9d2/9d2c2c36-fa30-4e8e-b75a-d76d0bf53f69","ch 00:03:55 INFO ../app/mqtt_client_cbs.c:136: PAYLOAD: {"cmd":"ping","payloadType":"aquaiHealthCheck","queueName":"aquaiHealthCheck"},"url":"https://testing-stg.s3.amazonaws.com/9d2/9d2c2c36-fa30-4e8e-b75a-d76d0bf53f69","checksum":"1d0ff48e2572f78520c5f3e 00:03:55 INFO ../app/mqtt_client_cbs.c:137: QOS: 0 00:03:55 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 8 00:03:55 INFO ../app/mqtt_client_task.c:663: Received Ping Cmd. 00:03:55 INFO ../imc/aquai.c:1107: BLE Tx: Send PING. to file /sys/mcuflashimg.bin 00:03:55 INFO ../ota/source/OtaArchive.c:1188: total 150592. 00:03:55 INFO ../ota/source/OtaLib.c:101: ---->Progress: 61% --- Dowloaded:158272 Filesize: 256000 00:03:55 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:55 DEBUG ../app/app_main.c:273: ========================================= 00:03:55 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:55 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:55 DEBUG ../app/app_main.c:276: ========================================= 00:03:55 DEBUG ../imc/aquai.c:904: --> RX: Received frame: 26 00:03:55 INFO ../imc/aquai.c:867: BLE Rx: Get Pong from: AQ900RP000000035 00:03:55 INFO ../app/mqtt_client_task.c:613: PUSH Pong /topic/device/aquaihealthcheck/in 00:03:55 INFO ../app/mqtt_client_task.c:614: PAYLOAD: {"deviceId":"AQ900RP000000035","cmd":"pong"} 00:03:55 INFO ../app/mqtt_client_task.c:615: LENGTH: 44 00:03:55 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 4 00:03:55 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:55 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:55 INFO ../ota/source/OtaArchive.c:1188: total 152032. 00:03:55 INFO ../ota/source/OtaLib.c:101: ---->Progress: 62% --- Dowloaded:159712 Filesize: 256000 00:03:55 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:55 DEBUG ../app/app_main.c:273: ========================================= 00:03:55 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:55 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:55 DEBUG ../app/app_main.c:276: ========================================= 00:03:55 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:55 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:55 INFO ../ota/source/OtaArchive.c:1188: total 153472. 00:03:55 INFO ../ota/source/OtaLib.c:101: ---->Progress: 62% --- Dowloaded:161152 Filesize: 256000 00:03:55 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:55 DEBUG ../app/app_main.c:273: ========================================= 00:03:55 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:55 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:55 DEBUG ../app/app_main.c:276: ========================================= 00:03:55 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:55 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:55 INFO ../ota/source/OtaArchive.c:1188: total 154912. 00:03:55 INFO ../ota/source/OtaLib.c:101: ---->Progress: 63% --- Dowloaded:162592 Filesize: 256000 00:03:55 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:55 DEBUG ../app/app_main.c:273: ========================================= 00:03:55 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:55 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:55 DEBUG ../app/app_main.c:276: ========================================= 00:03:55 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:55 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:55 INFO ../ota/source/OtaArchive.c:1188: total 156352. 00:03:55 INFO ../ota/source/OtaLib.c:101: ---->Progress: 64% --- Dowloaded:164032 Filesize: 256000 00:03:55 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:55 DEBUG ../app/app_main.c:273: ========================================= 00:03:55 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:55 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:55 DEBUG ../app/app_main.c:276: ========================================= 00:03:55 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:55 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:55 INFO ../ota/source/OtaArchive.c:1188: total 157792. 00:03:55 INFO ../ota/source/OtaLib.c:101: ---->Progress: 64% --- Dowloaded:165472 Filesize: 256000 00:03:55 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:55 DEBUG ../app/app_main.c:273: ========================================= 00:03:55 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:55 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:55 DEBUG ../app/app_main.c:276: ========================================= 00:03:55 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:55 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:55 INFO ../ota/source/OtaArchive.c:1188: total 159232. 00:03:55 INFO ../ota/source/OtaLib.c:101: ---->Progress: 65% --- Dowloaded:166912 Filesize: 256000 00:03:55 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:55 DEBUG ../app/app_main.c:273: ========================================= 00:03:55 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:55 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:55 DEBUG ../app/app_main.c:276: ========================================= 00:03:55 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:03:55 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:55 INFO ../ota/source/OtaArchive.c:1188: total 160672. 00:03:55 INFO ../ota/source/OtaLib.c:101: ---->Progress: 65% --- Dowloaded:168352 Filesize: 256000 00:03:55 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:55 DEBUG ../app/app_main.c:273: ========================================= 00:03:55 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:55 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:55 DEBUG ../app/app_main.c:276: ========================================= 00:03:55 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 844 00:03:55 INFO ../ota/source/OtaArchive.c:1187: to file /sys/mcuflashimg.bin 00:03:55 INFO ../ota/source/OtaArchive.c:1188: total 161516. 00:03:55 INFO ../ota/source/OtaArchive.c:1209: Hash verification succeeded. 00:03:55 INFO ../ota/source/OtaArchive.c:1231: Total archive file bytes 169196. 00:03:56 INFO ../ota/source/OtaArchive.c:1280: OtaArchive_RunParseTar: 2 files that are mentioned in the ota.cmd were saved 00:03:56 INFO ../ota/source/OtaArchive.c:1283: OtaArchive_RunParseTar: Downloading File Completed - Size=161516 00:03:56 INFO ../ota/source/OtaLib.c:101: ---->Progress: 66% --- Dowloaded:169196 Filesize: 256000 00:03:56 INFO ../app/mqtt_client_task.c:627: PUSH OTA Progress /topic/device/version/progress 00:03:56 INFO ../app/mqtt_client_task.c:628: PAYLOAD: {"deviceId": "AQ900RP000000035","state": "downloading", "progress": 66} 00:03:56 INFO ../app/mqtt_client_task.c:629: LENGTH: 71 00:03:56 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 5 00:03:56 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:56 DEBUG ../app/app_main.c:273: ========================================= 00:03:56 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:56 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:56 DEBUG ../app/app_main.c:276: ========================================= 00:03:56 INFO ../ota/source/OtaArchive.c:891: OtaArchive_RunParseTar: parsing archive file header 00:03:56 INFO ../ota/source/OtaArchive.c:904: OtaArchive_RunParseTar: skip block align RecvBufLen=596, SkipAlignSize=276 00:03:56 INFO ../ota/source/OtaLib.c:101: ---->Progress: 66% --- Dowloaded:169472 Filesize: 256000 00:03:56 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:56 DEBUG ../app/app_main.c:273: ========================================= 00:03:56 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:56 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:56 DEBUG ../app/app_main.c:276: ========================================= 00:03:56 INFO ../ota/source/OtaArchive.c:891: OtaArchive_RunParseTar: parsing archive file header 00:03:56 INFO ../ota/source/OtaArchive.c:1005: OtaArchive_RunParseTar: FileType=0, FileName=aquaicf1, FileSize=83 00:03:56 INFO ../ota/source/OtaLib.c:101: ---->Progress: 66% --- Dowloaded:169984 Filesize: 256000 00:03:56 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:56 DEBUG ../app/app_main.c:273: ========================================= 00:03:56 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:56 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:56 DEBUG ../app/app_main.c:276: ========================================= 00:03:56 INFO ../ota/source/OtaArchive.c:1080: Create/Open for write file aquaicf1 00:03:56 INFO ../ota/source/OtaLib.c:101: ---->Progress: 66% --- Dowloaded:169984 Filesize: 256000 00:03:56 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:56 DEBUG ../app/app_main.c:273: ========================================= 00:03:56 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:56 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:56 DEBUG ../app/app_main.c:276: ========================================= 00:03:56 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 83 00:03:56 INFO ../ota/source/OtaArchive.c:1187: to file aquaicf1 00:03:56 INFO ../ota/source/OtaArchive.c:1188: total 83. 00:03:56 INFO ../ota/source/OtaArchive.c:1209: Hash verification succeeded. 00:03:56 INFO ../ota/source/OtaArchive.c:1231: Total archive file bytes 170067. 00:03:56 INFO ../ota/source/OtaArchive.c:1280: OtaArchive_RunParseTar: 3 files that are mentioned in the ota.cmd were saved 00:03:56 INFO ../ota/source/OtaArchive.c:1283: OtaArchive_RunParseTar: Downloading File Completed - Size=83 00:03:56 INFO ../ota/source/OtaLib.c:101: ---->Progress: 66% --- Dowloaded:170067 Filesize: 256000 00:03:56 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:56 DEBUG ../app/app_main.c:273: ========================================= 00:03:56 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:56 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:56 DEBUG ../app/app_main.c:276: ========================================= 00:03:56 INFO ../ota/source/OtaArchive.c:891: OtaArchive_RunParseTar: parsing archive file header 00:03:56 INFO ../ota/source/OtaArchive.c:904: OtaArchive_RunParseTar: skip block align RecvBufLen=845, SkipAlignSize=429 00:03:56 INFO ../ota/source/OtaLib.c:101: ---->Progress: 66% --- Dowloaded:170496 Filesize: 256000 00:03:56 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:56 DEBUG ../app/app_main.c:273: ========================================= 00:03:56 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:56 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:56 DEBUG ../app/app_main.c:276: ========================================= 00:03:56 INFO ../ota/source/OtaArchive.c:891: OtaArchive_RunParseTar: parsing archive file header 00:03:56 INFO ../ota/source/OtaArchive.c:1005: OtaArchive_RunParseTar: FileType=0, FileName=dummy_ota_vendor_cert.der, FileSize=614 00:03:56 INFO ../ota/source/OtaLib.c:101: ---->Progress: 66% --- Dowloaded:171008 Filesize: 256000 00:03:56 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:56 DEBUG ../app/app_main.c:273: ========================================= 00:03:56 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:56 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:56 DEBUG ../app/app_main.c:276: ========================================= 00:03:56 INFO ../ota/source/OtaArchive.c:1080: Create/Open for write file dummy_ota_vendor_cert.der 00:03:56 INFO ../ota/source/OtaLib.c:101: ---->Progress: 66% --- Dowloaded:171008 Filesize: 256000 00:03:56 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:56 DEBUG ../app/app_main.c:273: ========================================= 00:03:56 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:56 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:56 DEBUG ../app/app_main.c:276: ========================================= 00:03:56 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 614 00:03:56 INFO ../ota/source/OtaArchive.c:1187: to file dummy_ota_vendor_cert.der 00:03:56 INFO ../ota/source/OtaArchive.c:1188: total 614. 00:03:56 INFO ../ota/source/OtaArchive.c:1209: Hash verification succeeded. 00:03:57 INFO ../ota/source/OtaArchive.c:1231: Total archive file bytes 171622. 00:03:57 INFO ../ota/source/OtaArchive.c:1280: OtaArchive_RunParseTar: 4 files that are mentioned in the ota.cmd were saved 00:03:57 INFO ../ota/source/OtaArchive.c:1283: OtaArchive_RunParseTar: Downloading File Completed - Size=614 00:03:57 INFO ../ota/source/OtaLib.c:101: ---->Progress: 67% --- Dowloaded:171622 Filesize: 256000 00:03:57 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:57 DEBUG ../app/app_main.c:273: ========================================= 00:03:57 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:57 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:57 DEBUG ../app/app_main.c:276: ========================================= 00:03:57 INFO ../ota/source/OtaArchive.c:891: OtaArchive_RunParseTar: parsing archive file header 00:03:57 INFO ../ota/source/OtaArchive.c:904: OtaArchive_RunParseTar: skip block align RecvBufLen=1440, SkipAlignSize=410 00:03:57 INFO ../ota/source/OtaArchive.c:1005: OtaArchive_RunParseTar: FileType=0, FileName=/sys/servicepack.ucf, FileSize=74572 00:03:57 INFO ../ota/source/OtaLib.c:101: ---->Progress: 67% --- Dowloaded:172544 Filesize: 256000 00:03:57 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:03:57 DEBUG ../app/app_main.c:273: ========================================= 00:03:57 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:03:57 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:03:57 DEBUG ../app/app_main.c:276: ========================================= 00:03:57 INFO ../ota/source/OtaArchive.c:1080: Create/Open for write file /sys/servicepack.ucf 00:03:59 DEBUG ../imc/aquai.c:904: --> RX: Received frame: 18 00:03:59 INFO ../imc/aquai.c:778: Update RSSI 00:03:59 INFO ../app/mqtt_client_task.c:600: PUSH Command Data /topic/device/aquairepeater/in 00:03:59 INFO ../app/mqtt_client_task.c:601: PAYLOAD: {"deviceId":"AQ900RP000000035","rssi":-100,"waterflow":0,"type":"RSSI"} 00:03:59 INFO ../app/mqtt_client_task.c:602: LENGTH: 71 00:03:59 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 1 00:04:00 INFO ../ota/source/OtaLib.c:101: ---->Progress: 67% --- Dowloaded:172544 Filesize: 256000 00:04:00 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:00 DEBUG ../app/app_main.c:273: ========================================= 00:04:00 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:00 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:00 DEBUG ../app/app_main.c:276: ========================================= 00:04:00 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 518 00:04:00 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:00 INFO ../ota/source/OtaArchive.c:1188: total 518. 00:04:00 INFO ../ota/source/OtaLib.c:101: ---->Progress: 67% --- Dowloaded:173062 Filesize: 256000 00:04:00 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:00 DEBUG ../app/app_main.c:273: ========================================= 00:04:00 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:00 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:00 DEBUG ../app/app_main.c:276: ========================================= 00:04:00 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:00 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:00 INFO ../ota/source/OtaArchive.c:1188: total 1958. 00:04:00 INFO ../ota/source/OtaLib.c:101: ---->Progress: 68% --- Dowloaded:174502 Filesize: 256000 00:04:00 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:00 DEBUG ../app/app_main.c:273: ========================================= 00:04:00 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:00 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:00 DEBUG ../app/app_main.c:276: ========================================= 00:04:00 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:00 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:00 INFO ../ota/source/OtaArchive.c:1188: total 3398. 00:04:00 INFO ../ota/source/OtaLib.c:101: ---->Progress: 68% --- Dowloaded:175942 Filesize: 256000 00:04:00 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:00 DEBUG ../app/app_main.c:273: ========================================= 00:04:00 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:00 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:00 DEBUG ../app/app_main.c:276: ========================================= 00:04:00 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:00 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:00 INFO ../ota/source/OtaArchive.c:1188: total 4838. 00:04:00 INFO ../ota/source/OtaLib.c:101: ---->Progress: 69% --- Dowloaded:177382 Filesize: 256000 00:04:00 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:00 DEBUG ../app/app_main.c:273: ========================================= 00:04:00 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:00 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:00 DEBUG ../app/app_main.c:276: ========================================= 00:04:00 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:00 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:00 INFO ../ota/source/OtaArchive.c:1188: total 6278. 00:04:00 INFO ../ota/source/OtaLib.c:101: ---->Progress: 69% --- Dowloaded:178822 Filesize: 256000 00:04:00 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:00 DEBUG ../app/app_main.c:273: ========================================= 00:04:00 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:00 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:00 DEBUG ../app/app_main.c:276: ========================================= 00:04:00 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:00 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:00 INFO ../ota/source/OtaArchive.c:1188: total 7718. 00:04:00 INFO ../ota/source/OtaLib.c:101: ---->Progress: 70% --- Dowloaded:180262 Filesize: 256000 00:04:00 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:00 DEBUG ../app/app_main.c:273: ========================================= 00:04:00 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:00 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:00 DEBUG ../app/app_main.c:276: ========================================= 00:04:00 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:00 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:00 INFO ../ota/source/OtaArchive.c:1188: total 9158. 00:04:00 INFO ../ota/source/OtaLib.c:101: ---->Progress: 70% --- Dowloaded:181702 Filesize: 256000 00:04:00 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:00 DEBUG ../app/app_main.c:273: ========================================= 00:04:00 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:00 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:00 DEBUG ../app/app_main.c:276: ========================================= 00:04:00 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:00 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:00 INFO ../ota/source/OtaArchive.c:1188: total 10598. 00:04:00 INFO ../ota/source/OtaLib.c:101: ---->Progress: 71% --- Dowloaded:183142 Filesize: 256000 00:04:00 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:00 DEBUG ../app/app_main.c:273: ========================================= 00:04:00 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:00 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:00 DEBUG ../app/app_main.c:276: ========================================= 00:04:00 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:00 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:00 INFO ../ota/source/OtaArchive.c:1188: total 12038. 00:04:00 INFO ../ota/source/OtaLib.c:101: ---->Progress: 72% --- Dowloaded:184582 Filesize: 256000 00:04:00 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:00 DEBUG ../app/app_main.c:273: ========================================= 00:04:00 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:00 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:00 DEBUG ../app/app_main.c:276: ========================================= 00:04:00 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:00 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:00 INFO ../ota/source/OtaArchive.c:1188: total 13478. 00:04:00 INFO ../ota/source/OtaLib.c:101: ---->Progress: 72% --- Dowloaded:186022 Filesize: 256000 00:04:00 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:00 DEBUG ../app/app_main.c:273: ========================================= 00:04:00 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:00 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:00 DEBUG ../app/app_main.c:276: ========================================= 00:04:01 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:01 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:01 INFO ../ota/source/OtaArchive.c:1188: total 14918. 00:04:01 INFO ../ota/source/OtaLib.c:101: ---->Progress: 73% --- Dowloaded:187462 Filesize: 256000 00:04:01 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:01 DEBUG ../app/app_main.c:273: ========================================= 00:04:01 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:01 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:01 DEBUG ../app/app_main.c:276: ========================================= 00:04:01 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:01 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:01 INFO ../ota/source/OtaArchive.c:1188: total 16358. 00:04:01 INFO ../ota/source/OtaLib.c:101: ---->Progress: 73% --- Dowloaded:188902 Filesize: 256000 00:04:01 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:01 DEBUG ../app/app_main.c:273: ========================================= 00:04:01 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:01 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:01 DEBUG ../app/app_main.c:276: ========================================= 00:04:01 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:01 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:01 INFO ../ota/source/OtaArchive.c:1188: total 17798. 00:04:01 INFO ../ota/source/OtaLib.c:101: ---->Progress: 74% --- Dowloaded:190342 Filesize: 256000 00:04:01 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:01 DEBUG ../app/app_main.c:273: ========================================= 00:04:01 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:01 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:01 DEBUG ../app/app_main.c:276: ========================================= 00:04:01 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:01 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:01 INFO ../ota/source/OtaArchive.c:1188: total 19238. 00:04:01 INFO ../ota/source/OtaLib.c:101: ---->Progress: 74% --- Dowloaded:191782 Filesize: 256000 00:04:01 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:01 DEBUG ../app/app_main.c:273: ========================================= 00:04:01 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:01 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:01 DEBUG ../app/app_main.c:276: ========================================= 00:04:01 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:01 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:01 INFO ../ota/source/OtaArchive.c:1188: total 20678. 00:04:01 INFO ../ota/source/OtaLib.c:101: ---->Progress: 75% --- Dowloaded:193222 Filesize: 256000 00:04:01 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:01 DEBUG ../app/app_main.c:273: ========================================= 00:04:01 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:01 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:01 DEBUG ../app/app_main.c:276: ========================================= 00:04:01 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:01 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:01 INFO ../ota/source/OtaArchive.c:1188: total 22118. 00:04:01 INFO ../ota/source/OtaLib.c:101: ---->Progress: 76% --- Dowloaded:194662 Filesize: 256000 00:04:01 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:01 DEBUG ../app/app_main.c:273: ========================================= 00:04:01 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:01 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:01 DEBUG ../app/app_main.c:276: ========================================= 00:04:01 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:01 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:01 INFO ../ota/source/OtaArchive.c:1188: total 23558. 00:04:01 INFO ../ota/source/OtaLib.c:101: ---->Progress: 76% --- Dowloaded:196102 Filesize: 256000 00:04:01 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:01 DEBUG ../app/app_main.c:273: ========================================= 00:04:01 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:01 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:01 DEBUG ../app/app_main.c:276: ========================================= 00:04:01 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:01 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:01 INFO ../ota/source/OtaArchive.c:1188: total 24998. 00:04:01 INFO ../ota/source/OtaLib.c:101: ---->Progress: 77% --- Dowloaded:197542 Filesize: 256000 00:04:01 INFO ../app/mqtt_client_task.c:627: PUSH OTA Progress /topic/device/version/progress 00:04:01 INFO ../app/mqtt_client_task.c:628: PAYLOAD: {"deviceId": "AQ900RP000000035","state": "downloading", "progress": 77} 00:04:01 INFO ../app/mqtt_client_task.c:629: LENGTH: 71 00:04:01 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 5 00:04:01 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:01 DEBUG ../app/app_main.c:273: ========================================= 00:04:01 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:01 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:01 DEBUG ../app/app_main.c:276: ========================================= 00:04:01 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:01 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:01 INFO ../ota/source/OtaArchive.c:1188: total 26438. 00:04:01 INFO ../ota/source/OtaLib.c:101: ---->Progress: 77% --- Dowloaded:198982 Filesize: 256000 00:04:01 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:01 DEBUG ../app/app_main.c:273: ========================================= 00:04:01 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:01 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:01 DEBUG ../app/app_main.c:276: ========================================= 00:04:01 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:01 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:01 INFO ../ota/source/OtaArchive.c:1188: total 27878. 00:04:01 INFO ../ota/source/OtaLib.c:101: ---->Progress: 78% --- Dowloaded:200422 Filesize: 256000 00:04:01 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:01 DEBUG ../app/app_main.c:273: ========================================= 00:04:01 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:01 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:01 DEBUG ../app/app_main.c:276: ========================================= 00:04:01 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:01 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:01 INFO ../ota/source/OtaArchive.c:1188: total 29318. 00:04:01 INFO ../ota/source/OtaLib.c:101: ---->Progress: 78% --- Dowloaded:201862 Filesize: 256000 00:04:01 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:01 DEBUG ../app/app_main.c:273: ========================================= 00:04:01 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:01 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:01 DEBUG ../app/app_main.c:276: ========================================= 00:04:01 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:01 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:01 INFO ../ota/source/OtaArchive.c:1188: total 30758. 00:04:01 INFO ../ota/source/OtaLib.c:101: ---->Progress: 79% --- Dowloaded:203302 Filesize: 256000 00:04:01 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:02 DEBUG ../app/app_main.c:273: ========================================= 00:04:02 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:02 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:02 DEBUG ../app/app_main.c:276: ========================================= 00:04:02 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:02 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:02 INFO ../ota/source/OtaArchive.c:1188: total 32198. 00:04:02 INFO ../ota/source/OtaLib.c:101: ---->Progress: 79% --- Dowloaded:204742 Filesize: 256000 00:04:02 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:02 DEBUG ../app/app_main.c:273: ========================================= 00:04:02 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:02 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:02 DEBUG ../app/app_main.c:276: ========================================= 00:04:02 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:02 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:02 INFO ../ota/source/OtaArchive.c:1188: total 33638. 00:04:02 INFO ../ota/source/OtaLib.c:101: ---->Progress: 80% --- Dowloaded:206182 Filesize: 256000 00:04:02 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:02 DEBUG ../app/app_main.c:273: ========================================= 00:04:02 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:02 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:02 DEBUG ../app/app_main.c:276: ========================================= 00:04:02 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:02 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:02 INFO ../ota/source/OtaArchive.c:1188: total 35078. 00:04:02 INFO ../ota/source/OtaLib.c:101: ---->Progress: 81% --- Dowloaded:207622 Filesize: 256000 00:04:02 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:02 DEBUG ../app/app_main.c:273: ========================================= 00:04:02 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:02 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:02 DEBUG ../app/app_main.c:276: ========================================= 00:04:02 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:02 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:02 INFO ../ota/source/OtaArchive.c:1188: total 36518. 00:04:02 INFO ../ota/source/OtaLib.c:101: ---->Progress: 81% --- Dowloaded:209062 Filesize: 256000 00:04:02 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:02 DEBUG ../app/app_main.c:273: ========================================= 00:04:02 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:02 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:02 DEBUG ../app/app_main.c:276: ========================================= 00:04:02 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:02 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:02 INFO ../ota/source/OtaArchive.c:1188: total 37958. 00:04:02 INFO ../ota/source/OtaLib.c:101: ---->Progress: 82% --- Dowloaded:210502 Filesize: 256000 00:04:02 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:02 DEBUG ../app/app_main.c:273: ========================================= 00:04:02 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:02 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:02 DEBUG ../app/app_main.c:276: ========================================= 00:04:02 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:02 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:02 INFO ../ota/source/OtaArchive.c:1188: total 39398. 00:04:02 INFO ../ota/source/OtaLib.c:101: ---->Progress: 82% --- Dowloaded:211942 Filesize: 256000 00:04:02 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:02 DEBUG ../app/app_main.c:273: ========================================= 00:04:02 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:02 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:02 DEBUG ../app/app_main.c:276: ========================================= 00:04:02 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:02 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:02 INFO ../ota/source/OtaArchive.c:1188: total 40838. 00:04:02 INFO ../ota/source/OtaLib.c:101: ---->Progress: 83% --- Dowloaded:213382 Filesize: 256000 00:04:02 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:02 DEBUG ../app/app_main.c:273: ========================================= 00:04:02 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:02 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:02 DEBUG ../app/app_main.c:276: ========================================= 00:04:02 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:02 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:02 INFO ../ota/source/OtaArchive.c:1188: total 42278. 00:04:02 INFO ../ota/source/OtaLib.c:101: ---->Progress: 83% --- Dowloaded:214822 Filesize: 256000 00:04:02 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:02 DEBUG ../app/app_main.c:273: ========================================= 00:04:02 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:02 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:02 DEBUG ../app/app_main.c:276: ========================================= 00:04:02 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:02 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:02 INFO ../ota/source/OtaArchive.c:1188: total 43718. 00:04:02 INFO ../ota/source/OtaLib.c:101: ---->Progress: 84% --- Dowloaded:216262 Filesize: 256000 00:04:02 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:02 DEBUG ../app/app_main.c:273: ========================================= 00:04:02 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:02 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:02 DEBUG ../app/app_main.c:276: ========================================= 00:04:02 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:02 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:02 INFO ../ota/source/OtaArchive.c:1188: total 45158. 00:04:02 INFO ../ota/source/OtaLib.c:101: ---->Progress: 85% --- Dowloaded:217702 Filesize: 256000 00:04:02 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:02 DEBUG ../app/app_main.c:273: ========================================= 00:04:02 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:02 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:02 DEBUG ../app/app_main.c:276: ========================================= 00:04:02 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:02 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:02 INFO ../ota/source/OtaArchive.c:1188: total 46598. 00:04:02 INFO ../ota/source/OtaLib.c:101: ---->Progress: 85% --- Dowloaded:219142 Filesize: 256000 00:04:02 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:02 DEBUG ../app/app_main.c:273: ========================================= 00:04:02 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:02 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:02 DEBUG ../app/app_main.c:276: ========================================= 00:04:02 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:03 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:03 INFO ../ota/source/OtaArchive.c:1188: total 48038. 00:04:03 INFO ../ota/source/OtaLib.c:101: ---->Progress: 86% --- Dowloaded:220582 Filesize: 256000 00:04:03 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:03 DEBUG ../app/app_main.c:273: ========================================= 00:04:03 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:03 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:03 DEBUG ../app/app_main.c:276: ========================================= 00:04:03 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:03 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:03 INFO ../ota/source/OtaArchive.c:1188: total 49478. 00:04:03 INFO ../ota/source/OtaLib.c:101: ---->Progress: 86% --- Dowloaded:222022 Filesize: 256000 00:04:03 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:03 DEBUG ../app/app_main.c:273: ========================================= 00:04:03 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:03 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:03 DEBUG ../app/app_main.c:276: ========================================= 00:04:03 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:03 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:03 INFO ../ota/source/OtaArchive.c:1188: total 50918. 00:04:03 INFO ../ota/source/OtaLib.c:101: ---->Progress: 87% --- Dowloaded:223462 Filesize: 256000 00:04:03 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:03 DEBUG ../app/app_main.c:273: ========================================= 00:04:03 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:03 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:03 DEBUG ../app/app_main.c:276: ========================================= 00:04:03 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:03 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:03 INFO ../ota/source/OtaArchive.c:1188: total 52358. 00:04:03 INFO ../ota/source/OtaLib.c:101: ---->Progress: 87% --- Dowloaded:224902 Filesize: 256000 00:04:03 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:03 DEBUG ../app/app_main.c:273: ========================================= 00:04:03 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:03 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:03 DEBUG ../app/app_main.c:276: ========================================= 00:04:03 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:03 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:03 INFO ../ota/source/OtaArchive.c:1188: total 53798. 00:04:03 INFO ../ota/source/OtaLib.c:101: ---->Progress: 88% --- Dowloaded:226342 Filesize: 256000 00:04:03 INFO ../app/mqtt_client_task.c:627: PUSH OTA Progress /topic/device/version/progress 00:04:03 INFO ../app/mqtt_client_task.c:628: PAYLOAD: {"deviceId": "AQ900RP000000035","state": "downloading", "progress": 88} 00:04:03 INFO ../app/mqtt_client_task.c:629: LENGTH: 71 00:04:03 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 5 00:04:03 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:03 DEBUG ../app/app_main.c:273: ========================================= 00:04:03 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:03 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:03 DEBUG ../app/app_main.c:276: ========================================= 00:04:03 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:03 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:03 INFO ../ota/source/OtaArchive.c:1188: total 55238. 00:04:03 INFO ../ota/source/OtaLib.c:101: ---->Progress: 88% --- Dowloaded:227782 Filesize: 256000 00:04:03 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:03 DEBUG ../app/app_main.c:273: ========================================= 00:04:03 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:03 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:03 DEBUG ../app/app_main.c:276: ========================================= 00:04:03 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:03 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:03 INFO ../ota/source/OtaArchive.c:1188: total 56678. 00:04:03 INFO ../ota/source/OtaLib.c:101: ---->Progress: 89% --- Dowloaded:229222 Filesize: 256000 00:04:03 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:03 DEBUG ../app/app_main.c:273: ========================================= 00:04:03 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:03 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:03 DEBUG ../app/app_main.c:276: ========================================= 00:04:03 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 811 00:04:03 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:03 INFO ../ota/source/OtaArchive.c:1188: total 57489. 00:04:03 INFO ../ota/source/OtaLib.c:101: ---->Progress: 89% --- Dowloaded:230033 Filesize: 256000 00:04:03 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:03 DEBUG ../app/app_main.c:273: ========================================= 00:04:03 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:03 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:03 DEBUG ../app/app_main.c:276: ========================================= 00:04:03 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:03 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:03 INFO ../ota/source/OtaArchive.c:1188: total 58929. 00:04:03 INFO ../ota/source/OtaLib.c:101: ---->Progress: 90% --- Dowloaded:231473 Filesize: 256000 00:04:03 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:03 DEBUG ../app/app_main.c:273: ========================================= 00:04:03 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:03 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:04 DEBUG ../app/app_main.c:276: ========================================= 00:04:04 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:04 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:04 INFO ../ota/source/OtaArchive.c:1188: total 60369. 00:04:04 INFO ../ota/source/OtaLib.c:101: ---->Progress: 90% --- Dowloaded:232913 Filesize: 256000 00:04:04 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:04 DEBUG ../app/app_main.c:273: ========================================= 00:04:04 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:04 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:04 DEBUG ../app/app_main.c:276: ========================================= 00:04:04 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:04 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:04 INFO ../ota/source/OtaArchive.c:1188: total 61809. 00:04:04 INFO ../ota/source/OtaLib.c:101: ---->Progress: 91% --- Dowloaded:234353 Filesize: 256000 00:04:04 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:04 DEBUG ../app/app_main.c:273: ========================================= 00:04:04 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:04 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:04 DEBUG ../app/app_main.c:276: ========================================= 00:04:04 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:04 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:04 INFO ../ota/source/OtaArchive.c:1188: total 63249. 00:04:04 INFO ../ota/source/OtaLib.c:101: ---->Progress: 92% --- Dowloaded:235793 Filesize: 256000 00:04:04 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:04 DEBUG ../app/app_main.c:273: ========================================= 00:04:04 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:04 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:04 DEBUG ../app/app_main.c:276: ========================================= 00:04:04 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:04 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:04 INFO ../ota/source/OtaArchive.c:1188: total 64689. 00:04:04 INFO ../ota/source/OtaLib.c:101: ---->Progress: 92% --- Dowloaded:237233 Filesize: 256000 00:04:04 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:04 DEBUG ../app/app_main.c:273: ========================================= 00:04:04 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:04 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:04 DEBUG ../app/app_main.c:276: ========================================= 00:04:04 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:04 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:04 INFO ../ota/source/OtaArchive.c:1188: total 66129. 00:04:04 INFO ../ota/source/OtaLib.c:101: ---->Progress: 93% --- Dowloaded:238673 Filesize: 256000 00:04:04 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:04 DEBUG ../app/app_main.c:273: ========================================= 00:04:04 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:04 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:04 DEBUG ../app/app_main.c:276: ========================================= 00:04:04 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:04 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:04 INFO ../ota/source/OtaArchive.c:1188: total 67569. 00:04:04 INFO ../ota/source/OtaLib.c:101: ---->Progress: 93% --- Dowloaded:240113 Filesize: 256000 00:04:04 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:04 DEBUG ../app/app_main.c:273: ========================================= 00:04:04 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:04 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:04 DEBUG ../app/app_main.c:276: ========================================= 00:04:04 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:04 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:04 INFO ../ota/source/OtaArchive.c:1188: total 69009. 00:04:04 INFO ../ota/source/OtaLib.c:101: ---->Progress: 94% --- Dowloaded:241553 Filesize: 256000 00:04:04 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:04 DEBUG ../app/app_main.c:273: ========================================= 00:04:04 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:04 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:04 DEBUG ../app/app_main.c:276: ========================================= 00:04:04 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:04 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:04 INFO ../ota/source/OtaArchive.c:1188: total 70449. 00:04:04 INFO ../ota/source/OtaLib.c:101: ---->Progress: 94% --- Dowloaded:242993 Filesize: 256000 00:04:04 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:04 DEBUG ../app/app_main.c:273: ========================================= 00:04:04 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:04 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:04 DEBUG ../app/app_main.c:276: ========================================= 00:04:04 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:04 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:04 INFO ../ota/source/OtaArchive.c:1188: total 71889. 00:04:04 INFO ../ota/source/OtaLib.c:101: ---->Progress: 95% --- Dowloaded:244433 Filesize: 256000 00:04:04 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:04 DEBUG ../app/app_main.c:273: ========================================= 00:04:04 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:04 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:04 DEBUG ../app/app_main.c:276: ========================================= 00:04:04 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 1440 00:04:04 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:04 INFO ../ota/source/OtaArchive.c:1188: total 73329. 00:04:04 INFO ../ota/source/OtaLib.c:101: ---->Progress: 96% --- Dowloaded:245873 Filesize: 256000 00:04:04 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:04 DEBUG ../app/app_main.c:273: ========================================= 00:04:04 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:04 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:04 DEBUG ../app/app_main.c:276: ========================================= 00:04:04 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 544 00:04:04 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:04 INFO ../ota/source/OtaArchive.c:1188: total 73873. 00:04:04 INFO ../ota/source/OtaLib.c:101: ---->Progress: 96% --- Dowloaded:246417 Filesize: 256000 00:04:04 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:04 DEBUG ../app/app_main.c:273: ========================================= 00:04:04 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:04 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:04 DEBUG ../app/app_main.c:276: ========================================= 00:04:05 INFO ../ota/source/OtaArchive.c:1186: OtaArchive_RunParseTar: Write size 699 00:04:05 INFO ../ota/source/OtaArchive.c:1187: to file /sys/servicepack.ucf 00:04:05 INFO ../ota/source/OtaArchive.c:1188: total 74572. 00:04:05 INFO ../ota/source/OtaArchive.c:1209: Hash verification succeeded. 00:04:05 INFO ../ota/source/OtaArchive.c:1231: Total archive file bytes 247116. 00:04:05 INFO ../ota/source/OtaArchive.c:1280: OtaArchive_RunParseTar: 5 files that are mentioned in the ota.cmd were saved 00:04:05 INFO ../ota/source/OtaArchive.c:1283: OtaArchive_RunParseTar: Downloading File Completed - Size=74572 00:04:05 INFO ../ota/source/OtaLib.c:101: ---->Progress: 96% --- Dowloaded:247116 Filesize: 256000 00:04:05 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 9 00:04:05 DEBUG ../app/app_main.c:273: ========================================= 00:04:05 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 9 ==== 00:04:05 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x010060ed ==== 00:04:05 DEBUG ../app/app_main.c:276: ========================================= 00:04:05 INFO ../ota/source/OtaArchive.c:891: OtaArchive_RunParseTar: parsing archive file header 00:04:05 INFO ../ota/source/OtaArchive.c:904: OtaArchive_RunParseTar: skip block align RecvBufLen=741, SkipAlignSize=180 00:04:05 INFO ../ota/source/OtaArchive.c:930: OtaArchive_RunParseTar: End of archive... 00:04:05 INFO ../ota/source/OtaArchive.c:676: _SaveOtaVersionFile: save version file also in the bundle, version= 00:04:05 INFO ../ota/source/OtaLib.c:380: OTA_run: ---- Download file completed 00:04:06 INFO ../app/ota_task.c:240: OtaRunStep: status from Ota_run: Download done, status = 104 00:04:06 INFO ../ota/source/OtaLib.c:101: ---->Progress: 96% --- Dowloaded:247808 Filesize: 256000 00:04:06 INFO ../app/mqtt_client_task.c:627: PUSH OTA Progress /topic/device/version/progress 00:04:06 INFO ../app/mqtt_client_task.c:628: PAYLOAD: {"deviceId": "AQ900RP000000035","state": "downloading", "progress": 96} 00:04:06 INFO ../app/mqtt_client_task.c:629: LENGTH: 71 00:04:06 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 5 00:04:06 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 11 00:04:06 DEBUG ../app/app_main.c:273: ========================================= 00:04:06 DEBUG ../app/app_main.c:274: === APP STATE: 5, PROCESS EVT: 11 ==== 00:04:06 DEBUG ../app/app_main.c:275: === HANDLER ADDR: 0x0100d9ed ==== 00:04:06 DEBUG ../app/app_main.c:276: ========================================= 00:04:06 INFO ../app/ota_task.c:321: OtaImageTestingAndReset: download done 00:04:06 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 5 00:04:06 INFO ../app/mqtt_client_task.c:627: PUSH OTA Progress /topic/device/version/progress 00:04:06 INFO ../app/mqtt_client_task.c:628: PAYLOAD: {"deviceId": "AQ900RP000000035","state": "upgraded", "progress": 100} 00:04:06 INFO ../app/mqtt_client_task.c:629: LENGTH: 69 00:04:07 INFO ../app/ota_task.c:333: OtaImageTestingAndReset: call sl_Stop to move the bundle totesting state 00:04:07 INFO ../app/mqtt_client_cbs.c:180: Mqtt client disconnected!! 00:04:07 DEBUG ../app/event_queue.c:95: Emitted into APP Event Queue, Event = 6 00:04:07 DEBUG ../app/event_queue.c:146: Emitted into Mqtt Event Queue, Event = 12 00:04:07 ERROR ../app/mqtt_client_task.c:634: Could not PUSH to /topic/device/version/progress - Error: -7