21:16:40: INFO: FH_LOADER WAS CALLED EXACTLY LIKE THIS ************************************************ D:\firwmare\qflash\QCMM\CH1\fh_loader.exe --port=\\.\COM12 --sendxml=rawprogram_nand_p4K_b256K_update.xml --search_path=D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose --noprompt --showpercentagecomplete --zlpawarehost=1 --memoryname=nand ************************************************ 21:16:40: DEBUG: Binary build date: Jun 25 2019 @ 03:16:10 21:16:40: DEBUG: Build Version: 19.06.25.03.16.10 21:16:40: INFO: Current working dir (cwd): D:\firwmare\qflash\ 21:16:40: INFO: Showing network mappings to allow debugging 21:16:40: DEBUG: New connections will be remembered. 21:16:40: DEBUG: 21:16:40: DEBUG: There are no entries in the list. 21:16:40: DEBUG: 21:16:40: INFO: 21:16:40: INFO: Trying to store 'rawprogram_nand_p4K_b256K_update.xml' in string table 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file 'rawprogram_nand_p4K_b256K_update.xml' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\rawprogram_nand_p4K_b256K_update.xml') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\rawprogram_nand_p4K_b256K_update.xml') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\rawprogram_nand_p4K_b256K_update.xml' (5702 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\rawprogram_nand_p4K_b256K_update.xml') with AccessMode='r' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: User set ZLPAWAREHOST to 1 21:16:40: INFO: User wants to talk to port '\\.\COM12' 21:16:40: DEBUG: port_fd=0x124 21:16:40: INFO: Took 0.00000000 seconds to open port 21:16:40: INFO: Sorting TAGS to ensure order is ,, others, , 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file 'partition_complete_p4K_b256K.mbn' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\partition_complete_p4K_b256K.mbn') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\partition_complete_p4K_b256K.mbn') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\partition_complete_p4K_b256K.mbn' (16384 bytes) 21:16:40: INFO: SectorSizeInBytes changed to 4096 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\partition_complete_p4K_b256K.mbn') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\tz.mbn' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\tz.mbn') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\tz.mbn') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\tz.mbn' (937984 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\tz.mbn') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\devcfg.mbn' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\devcfg.mbn') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\devcfg.mbn') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\devcfg.mbn' (40470 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\devcfg.mbn') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\xbl_cfg.elf' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\xbl_cfg.elf') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\xbl_cfg.elf') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\xbl_cfg.elf' (53348 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\xbl_cfg.elf') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\multi_image.mbn' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\multi_image.mbn') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\multi_image.mbn') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\multi_image.mbn' (12952 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\multi_image.mbn') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\hyp.mbn' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\hyp.mbn') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\hyp.mbn') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\hyp.mbn' (80192 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\hyp.mbn') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\abl.elf' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\abl.elf') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\abl.elf') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\abl.elf' (151552 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\abl.elf') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\uefi.elf' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\uefi.elf') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\uefi.elf') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\uefi.elf' (1323008 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\uefi.elf') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\tools.fv' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\tools.fv') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\tools.fv') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\tools.fv' (393216 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\tools.fv') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\sdxpoorwills-boot.img' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-boot.img') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-boot.img') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-boot.img' (8267776 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-boot.img') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\sdxpoorwills-boot.img' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-boot.img') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-boot.img') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-boot.img' (8267776 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-boot.img') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\NON-HLOS.ubi' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\NON-HLOS.ubi') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\NON-HLOS.ubi') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\NON-HLOS.ubi' (48758784 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\NON-HLOS.ubi') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\sdxpoorwills-recoveryfs.ubi' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-recoveryfs.ubi') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-recoveryfs.ubi') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-recoveryfs.ubi' (17301504 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-recoveryfs.ubi') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\usrdata.ubi' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\usrdata.ubi') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\usrdata.ubi') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\usrdata.ubi' (3932160 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\usrdata.ubi') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\sdxpoorwills-sysfs.ubi' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-sysfs.ubi') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-sysfs.ubi') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-sysfs.ubi' (52953088 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sdxpoorwills-sysfs.ubi') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\aop.mbn' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\aop.mbn') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\aop.mbn') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\aop.mbn' (142736 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\aop.mbn') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: ================================================================================== 21:16:40: DEBUG: ================================================================================== 21:16:40: INFO: Looking for file '..\sbl1.mbn' 21:16:40: DEBUG: 1. Calling stat('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sbl1.mbn') 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sbl1.mbn') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: DEBUG: Found 'D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sbl1.mbn' (570260 bytes) 21:16:40: DEBUG: 2. Calling fopen('D:\firwmare\EM160RGLAUR02A10M4G_01_001_01_001\update\firehose\..\sbl1.mbn') with AccessMode='rb' 21:16:40: DEBUG: Trying get filesize, calling fseek() 21:16:40: INFO: Total to be tansferd with or is 136.57 MB 21:16:40: INFO: Sending 21:16:40: DEBUG: CHANNEL DATA (P0000) (H00202) ( 228 bytes) - HOST TO TARGET --> =========================================================================================================== ============================================================================================================ 21:16:40: DEBUG: CharsInBuffer=0 Trying to read from USB 8192 bytes 21:16:40: DEBUG: CHANNEL DATA (2448 bytes) <-- TARGET to HOST 21:16:40: DEBUG: CharsInBuffer = 2448 21:16:40: DEBUG: printBuffer:6017 PRETTYPRINT Buffer is 2448 bytes 21:16:40: DEBUG: printBuffer:6094 3C 3F 78 6D 6C 20 76 65 72 73 69 6F 6E 3D 22 31 ..< 21:16:40: DEBUG: printBuffer:6094 6C 6F 67 20 76 61 6C 75 65 3D 22 49 4E 46 4F 3A log value="INFO: 21:16:40: DEBUG: printBuffer:6094 20 42 69 6E 61 72 79 20 62 75 69 6C 64 20 64 61 Binary build da 21:16:40: DEBUG: printBuffer:6094 74 65 3A 20 41 70 72 20 32 31 20 32 30 32 32 20 te: Apr 21 2022 21:16:40: DEBUG: printBuffer:6094 40 20 31 36 3A 31 38 3A 33 34 22 20 2F 3E 3C 2F @ 16:18:34" />....< 21:16:40: DEBUG: printBuffer:6094 3F 78 6D 6C 20 76 65 72 73 69 6F 6E 3D 22 31 2E ?xml version="1. 21:16:40: DEBUG: printBuffer:6094 30 22 20 65 6E 63 6F 64 69 6E 67 3D 22 55 54 46 0" encoding="UTF 21:16:40: DEBUG: printBuffer:6094 2D 38 22 20 3F 3E 0A 3C 64 61 74 61 3E 0A 3C 6C -8" ?>.... 21:16:40: DEBUG: printBuffer:6094 3C 2F 64 61 74 61 3E 3C 3F 78 6D 6C 20 76 65 72 .< 21:16:40: DEBUG: printBuffer:6094 64 61 74 61 3E 0A 3C 6C 6F 67 20 76 61 6C 75 65 data>. 21:16:40: DEBUG: printBuffer:6094 3C 2F 64 61 74 61 3E 3C 3F 78 6D 6C 20 76 65 72 .< 21:16:40: DEBUG: printBuffer:6094 64 61 74 61 3E 0A 3C 6C 6F 67 20 76 61 6C 75 65 data>.< 21:16:40: DEBUG: printBuffer:6094 2F 64 61 74 61 3E 3C 3F 78 6D 6C 20 76 65 72 73 /data>.. 21:16:40: DEBUG: printBuffer:6094 3C 2F 64 61 74 61 3E 3C 3F 78 6D 6C 20 76 65 72 .< 21:16:40: DEBUG: printBuffer:6094 64 61 74 61 3E 0A 3C 6C 6F 67 20 76 61 6C 75 65 data>...< 21:16:40: DEBUG: printBuffer:6094 3F 78 6D 6C 20 76 65 72 73 69 6F 6E 3D 22 31 2E ?xml version="1. 21:16:40: DEBUG: printBuffer:6094 30 22 20 65 6E 63 6F 64 69 6E 67 3D 22 55 54 46 0" encoding="UTF 21:16:40: DEBUG: printBuffer:6094 2D 38 22 20 3F 3E 0A 3C 64 61 74 61 3E 0A 3C 6C -8" ?>.. 21:16:40: DEBUG: printBuffer:6094 3C 3F 78 6D 6C 20 76 65 72 73 69 6F 6E 3D 22 31 ..< 21:16:40: DEBUG: printBuffer:6094 6C 6F 67 20 76 61 6C 75 65 3D 22 49 4E 46 4F 3A log value="INFO: 21:16:40: DEBUG: printBuffer:6094 20 70 6F 77 65 72 22 20 2F 3E 3C 2F 64 61 74 61 power" />.. 21:16:40: DEBUG: printBuffer:6094 3C 6C 6F 67 20 76 61 6C 75 65 3D 22 49 4E 46 4F .... 21:16:40: DEBUG: printBuffer:6094 0A 3C 64 61 74 61 3E 0A 3C 6C 6F 67 20 76 61 6C .. 21:16:40: DEBUG: printBuffer:6094 0A 3C 64 61 74 61 3E 0A 3C 6C 6F 67 20 76 61 6C ... 21:16:40: DEBUG: printBuffer:6094 3C 64 61 74 61 3E 0A 3C 6C 6F 67 20 76 61 6C 75 ....... 21:16:40: DEBUG: printBuffer:6094 3C 2F 64 61 74 61 3E 3C 3F 78 6D 6C 20 76 65 72 .< 21:16:40: DEBUG: printBuffer:6094 64 61 74 61 3E 0A 3C 6C 6F 67 20 76 61 6C 75 65 data>... 21:16:40: DEBUG: printBuffer:6094 3C 6C 6F 67 20 76 61 6C 75 65 3D 22 57 41 52 4E .. 21:16:40: DEBUG: printBuffer:6107 21:16:40: DEBUG: XML FILE (117 bytes): CharsInBuffer=2448-117=2331 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: Binary build date: Apr 21 2022 @ 16:18:34' 21:16:40: DEBUG: XML FILE (118 bytes): CharsInBuffer=2331-118=2213 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: Binary build date: Apr 21 2022 @ 16:18:34 ' 21:16:40: DEBUG: XML FILE (100 bytes): CharsInBuffer=2213-100=2113 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: Chip serial num: 0 (0x0)' 21:16:40: DEBUG: XML FILE (101 bytes): CharsInBuffer=2113-101=2012 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: Supported Functions (15):' 21:16:40: DEBUG: XML FILE (83 bytes): CharsInBuffer=2012-83=1929 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: program' 21:16:40: DEBUG: XML FILE (80 bytes): CharsInBuffer=1929-80=1849 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: read' 21:16:40: DEBUG: XML FILE (79 bytes): CharsInBuffer=1849-79=1770 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: nop' 21:16:40: DEBUG: XML FILE (81 bytes): CharsInBuffer=1770-81=1689 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: patch' 21:16:40: DEBUG: XML FILE (85 bytes): CharsInBuffer=1689-85=1604 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: configure' 21:16:40: DEBUG: XML FILE (99 bytes): CharsInBuffer=1604-99=1505 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: setbootablestoragedrive' 21:16:40: DEBUG: XML FILE (81 bytes): CharsInBuffer=1505-81=1424 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: erase' 21:16:40: DEBUG: XML FILE (81 bytes): CharsInBuffer=1424-81=1343 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: power' 21:16:40: DEBUG: XML FILE (89 bytes): CharsInBuffer=1343-89=1254 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: firmwarewrite' 21:16:40: DEBUG: XML FILE (90 bytes): CharsInBuffer=1254-90=1164 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: getstorageinfo' 21:16:40: DEBUG: XML FILE (85 bytes): CharsInBuffer=1164-85=1079 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: benchmark' 21:16:40: DEBUG: XML FILE (80 bytes): CharsInBuffer=1079-80=999 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: emmc' 21:16:40: DEBUG: XML FILE (79 bytes): CharsInBuffer=999-79=920 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: ufs' 21:16:40: DEBUG: XML FILE (82 bytes): CharsInBuffer=920-82=838 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: fixgpt' 21:16:40: DEBUG: XML FILE (91 bytes): CharsInBuffer=838-91=747 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: getsha256digest' 21:16:40: DEBUG: XML FILE (105 bytes): CharsInBuffer=747-105=642 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: End of supported functions 15' 21:16:40: DEBUG: XML FILE (105 bytes): CharsInBuffer=642-105=537 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: Calling handler for configure' 21:16:40: DEBUG: XML FILE (106 bytes): CharsInBuffer=537-106=431 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: Storage type set to value nand' 21:16:40: DEBUG: XML FILE (155 bytes): CharsInBuffer=431-155=276 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'WARN: NAK: MaxPayloadSizeToTargetInBytes sent by host 1048576 larger than supported 0' 21:16:40: DEBUG: XML FILE (276 bytes): CharsInBuffer=276-276=0 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: DEBUG: Response was 'NAK' 21:16:40: INFO: fh.attrs.MaxPayloadSizeToTargetInBytes = 16384 21:16:40: INFO: fh.attrs.MaxPayloadSizeToTargetInBytesSupported = 16384 21:16:40: INFO: Target returned NAK for your but it does not seem to be an error. This is ok, fh_loader.exe attributes updated 21:16:40: INFO: Issuing Erase 21:16:40: INFO: _____ _ _____ 21:16:40: INFO: |_ _| (_) | ___| 21:16:40: INFO: | | ___ ___ _ _ _ _ __ __ _ | |__ _ __ __ _ ___ ___ 21:16:40: INFO: | |/ __/ __| | | | | '_ \ / _` | | __| '__/ _` / __|/ _ \ 21:16:40: INFO: _| |\__ \__ \ |_| | | | | | (_| | | |__| | | (_| \__ \ __/ 21:16:40: INFO: \___/___/___/\__,_|_|_| |_|\__, | \____/_| \__,_|___/\___| 21:16:40: INFO: __/ | 21:16:40: INFO: |___/ 21:16:40: DEBUG: CHANNEL DATA (P0001) (H00203) ( 185 bytes) - HOST TO TARGET --> =========================================================================================================== ============================================================================================================ 21:16:40: DEBUG: CharsInBuffer=0 Trying to read from USB 8192 bytes 21:16:40: DEBUG: CHANNEL DATA (667 bytes) <-- TARGET to HOST 21:16:40: DEBUG: CharsInBuffer = 667 21:16:40: DEBUG: printBuffer:6017 PRETTYPRINT Buffer is 667 bytes 21:16:40: DEBUG: printBuffer:6094 3C 3F 78 6D 6C 20 76 65 72 73 69 6F 6E 3D 22 31 ..< 21:16:40: DEBUG: printBuffer:6094 6C 6F 67 20 76 61 6C 75 65 3D 22 49 4E 46 4F 3A log value="INFO: 21:16:40: DEBUG: printBuffer:6094 20 43 61 6C 6C 69 6E 67 20 68 61 6E 64 6C 65 72 Calling handler 21:16:40: DEBUG: printBuffer:6094 20 66 6F 72 20 65 72 61 73 65 22 20 2F 3E 3C 2F for erase" />.. 21:16:40: DEBUG: printBuffer:6094 3C 2F 64 61 74 61 3E 3C 3F 78 6D 6C 20 76 65 72 .< 21:16:40: DEBUG: printBuffer:6094 64 61 74 61 3E 0A 3C 6C 6F 67 20 76 61 6C 75 65 data>.< 21:16:40: DEBUG: printBuffer:6094 2F 64 61 74 61 3E 3C 3F 78 6D 6C 20 76 65 72 73 /data>.. 21:16:40: DEBUG: printBuffer:6094 0A 3C 64 61 74 61 3E 0A 3C 6C 6F 67 20 76 61 6C .... 21:16:40: DEBUG: printBuffer:6107 21:16:40: DEBUG: XML FILE (101 bytes): CharsInBuffer=667-101=566 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'INFO: Calling handler for erase' 21:16:40: DEBUG: XML FILE (98 bytes): CharsInBuffer=566-98=468 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'WARN: [269]NAND Error -1 (3)' 21:16:40: DEBUG: XML FILE (111 bytes): CharsInBuffer=468-111=357 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'ERROR: [683] device attach failed -1 (3) ' 21:16:40: DEBUG: XML FILE (131 bytes): CharsInBuffer=357-131=226 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'ERROR: Failed to open the device:4 slot:0 partition:0 error:3' 21:16:40: DEBUG: XML FILE (132 bytes): CharsInBuffer=226-132=94 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: INFO: TARGET SAID: 'ERROR: Failed to open device, type:nand, slot:0, lun:0 error:3' 21:16:40: DEBUG: XML FILE (94 bytes): CharsInBuffer=94-94=0 ------------------------------------------------------------------------------------------- ------------------------------------------------------------------------------------------- 21:16:40: DEBUG: Response was 'NAK' _____ | ___| | |__ _ __ _ __ ___ _ __ | __| '__| '__/ _ \| '__| | |__| | | | | (_) | | \____/_| |_| \___/|_| 21:16:40: {ERROR: handleErase:7750 Something failed with the command. The port_trace.txt can shed more information on this Note that for eMMC is only valid for physical_partition 0. For UFS is valid for all LUNs