Hi Kan,
I've enabled debug level logging for all and have attached a copy of the terminal output while running ./se05x_Minimal.
Please let me know how to move forward from here to resolve this issue.
Thanks,
Ethan
App :INFO :PlugAndTrust_v03.03.00_20210528
App :INFO :Running ./se05x_Minimal
App :INFO :If you want to over-ride the selection, use ENV=EX_SSS_BOOT_SSS_PORT or pass in command line arguments.
smCom :DEBUG:phPalEse_i2c_open_and_configure Opening port
smCom :DEBUG:I2CInit: opening /dev/i2c-1
smCom :DEBUG:I2C driver: PEC flag cleared
smCom :DEBUG:I2C driver supports plain i2c-level commands.
smCom :DEBUG:I2C driver Initialized :: fd = [12]
smCom :DEBUG:phNxpEseProto7816_Open: First open completed
smCom :DEBUG:phNxpEse_clearReadBuffer Enter ..
smCom :DEBUG:phPalEse_i2c_read Read Requested 260 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=260)
70 79 FB 76 00 00 00 00 00 00 00 00 36 5F 4F 70
4C 31 C1 6A 00 00 00 00 8C 6E FB 76 44 6E AD 7E
29 8F EB 76 A4 6E AD 7E 4C 6E AD 7E D0 6C FB 76
B4 18 F9 76 4C 6E AD 7E D8 8A FB 76 06 00 00 00
00 00 00 00 01 00 00 00 00 00 00 00 01 00 00 00
D0 6C FB 76 8C 6E FB 76 00 00 00 00 74 6E AD 7E
D8 8A FB 76 06 00 00 00 00 00 00 00 01 00 00 00
00 00 00 00 01 00 00 00 FF FF FF FF 8C 6E FB 76
C8 87 EB 76 D0 6C FB 76 AC 6E AD 7E D0 6C FB 76
B4 18 F9 76 AC 6E AD 7E D8 8A FB 76 06 00 00 00
0C 61 ED 76 D0 6C FB 76 78 8B EB 76 D0 14 FB 76
00 00 00 00 01 00 00 00 00 80 FB 76 04 6F AD 7E
54 6A F9 76 00 00 00 00 01 00 00 00 01 00 00 00
00 00 00 00 68 79 FB 76 C8 87 EB 76 00 00 00 00
00 60 ED 76 38 0F 01 00 E4 09 01 00 00 00 00 00
00 00 00 00 00 00 00 00 44 CB F9 76 20 1F 9B 01
00 00 00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:TransceiveProcess nextTransceiveState 4
smCom :DEBUG:S-Frame PCB: c0
smCom :DEBUG:phNxpEse_WriteFrame Enter ..
smCom :DEBUG:TX (axI2CWrite) > (Len=5)
5A C0 00 FF FC
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:RAW Tx> (Len=5)
5A C0 00 FF FC
smCom :DEBUG:phNxpEse_read Enter ..
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:TX (axI2CRead): (Len=2)
A5 E0
smCom :DEBUG:phNxpEse_readPacket Read HDR
smCom :DEBUG:phNxpEse_readPacket SOF FOUND
smCom :DEBUG:phPalEse_i2c_read Read Requested 1 bytes
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:TX (axI2CRead): (Len=1)
00
smCom :DEBUG:poll_sof_chained_delay value is 0
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:TX (axI2CRead): (Len=2)
3F 19
smCom :DEBUG:RAW Rx< (Len=5)
A5 E0 00 3F 19
smCom :DEBUG:phNxpEseProto7816_ProcessResponse p_data ----> 0x19b1f28 len ----> 0x5
smCom :DEBUG:Received CRC:0x3f19 Calculated CRC:0x3f19
smCom :DEBUG:Retry Counter = 0
smCom :DEBUG:phNxpEseProto7816_DecodeFrame S-Frame Received
smCom :DEBUG:TransceiveProcess nextTransceiveState 7
smCom :DEBUG:S-Frame PCB: c7
smCom :DEBUG:phNxpEse_WriteFrame Enter ..
smCom :DEBUG:TX (axI2CWrite) > (Len=5)
5A C7 00 F7 B1
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:RAW Tx> (Len=5)
5A C7 00 F7 B1
smCom :DEBUG:phNxpEse_read Enter ..
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:TX (axI2CRead): (Len=2)
A5 E7
smCom :DEBUG:phNxpEse_readPacket Read HDR
smCom :DEBUG:phNxpEse_readPacket SOF FOUND
smCom :DEBUG:phPalEse_i2c_read Read Requested 1 bytes
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:TX (axI2CRead): (Len=1)
23
smCom :DEBUG:poll_sof_chained_delay value is 0
smCom :DEBUG:phPalEse_i2c_read Read Requested 37 bytes
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:TX (axI2CRead): (Len=37)
00 A0 00 00 03 96 04 03 E8 00 FE 02 0B 03 E8 08
01 00 00 00 00 64 00 00 0A 4A 43 4F 50 34 20 41
54 50 4F 2A 8D
smCom :DEBUG:RAW Rx< (Len=40)
A5 E7 23 00 A0 00 00 03 96 04 03 E8 00 FE 02 0B
03 E8 08 01 00 00 00 00 64 00 00 0A 4A 43 4F 50
34 20 41 54 50 4F 2A 8D
smCom :DEBUG:phNxpEseProto7816_ProcessResponse p_data ----> 0x19b1f28 len ----> 0x28
smCom :DEBUG:Received CRC:0x2a8d Calculated CRC:0x2a8d
smCom :DEBUG:Retry Counter = 0
smCom :DEBUG:phNxpEseProto7816_DecodeFrame S-Frame Received
smCom :DEBUG:phNxpEseProto7816_DecodeSFrameData frameoffset=3 value=0x0
smCom :DEBUG:Data[0]=0x0 len=35 Data[34]=0x50 Data[79]=0x23
smCom :DEBUG:Trying to Acquire Lock thread: 1996165136
smCom :DEBUG:LOCK Acquired by thread: 1996165136
smCom :DEBUG:APDU Tx> (Len=22)
00 A4 04 00 10 A0 00 00 03 96 54 53 00 00 00 01
03 00 00 00 00 00
smCom :DEBUG:Enter phNxpEseProto7816_Transceive
smCom :DEBUG:Transceive data ptr 0x0x7ead6a58 len:22
smCom :DEBUG:I-Frame Data Len: 22 Seq. no:0
smCom :DEBUG:TransceiveProcess nextTransceiveState 1
smCom :DEBUG:phNxpEse_WriteFrame Enter ..
smCom :DEBUG:TX (axI2CWrite) > (Len=27)
5A 00 16 00 A4 04 00 10 A0 00 00 03 96 54 53 00
00 00 01 03 00 00 00 00 00 A8 C8
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:RAW Tx> (Len=27)
5A 00 16 00 A4 04 00 10 A0 00 00 03 96 54 53 00
00 00 01 03 00 00 00 00 00 A8 C8
smCom :DEBUG:phNxpEse_read Enter ..
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:TX (axI2CRead): (Len=2)
A5 00
smCom :DEBUG:phNxpEse_readPacket Read HDR
smCom :DEBUG:phNxpEse_readPacket SOF FOUND
smCom :DEBUG:phPalEse_i2c_read Read Requested 1 bytes
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:TX (axI2CRead): (Len=1)
09
smCom :DEBUG:poll_sof_chained_delay value is 0
smCom :DEBUG:phPalEse_i2c_read Read Requested 11 bytes
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:TX (axI2CRead): (Len=11)
03 01 00 6F FF 01 0B 90 00 19 14
smCom :DEBUG:RAW Rx< (Len=14)
A5 00 09 03 01 00 6F FF 01 0B 90 00 19 14
smCom :DEBUG:phNxpEseProto7816_ProcessResponse p_data ----> 0x19b1f28 len ----> 0xe
smCom :DEBUG:Received CRC:0x1914 Calculated CRC:0x1914
smCom :DEBUG:Retry Counter = 0
smCom :DEBUG:phNxpEseProto7816_DecodeFrame I-Frame Received
smCom :DEBUG:phNxpEseProto7816_DecodeFrame I-Frame lastRcvdIframeInfo.seqNo:0x0
smCom :DEBUG:Data[0]=0x3 len=9 Data[8]=0x90 Data[0]=0x9
smCom :DEBUG: phNxpEse_Transceive Exit status 0x0
smCom :DEBUG:APDU Rx< (Len=9)
03 01 00 6F FF 01 0B 90 00
smCom :DEBUG:Trying to Released Lock by thread: 1996165136
smCom :DEBUG:LOCK Released by thread: 1996165136
sss :INFO :atr (Len=35)
00 A0 00 00 03 96 04 03 E8 00 FE 02 0B 03 E8 08
01 00 00 00 00 64 00 00 0A 4A 43 4F 50 34 20 41
54 50 4F
sss :WARN :Communication channel is Plain.
sss :WARN :!!!Not recommended for production use.!!!
smCom :DEBUG:Trying to Acquire Lock thread: 1996165136
smCom :DEBUG:LOCK Acquired by thread: 1996165136
smCom :DEBUG:APDU Tx> (Len=8)
80 04 00 22 03 41 01 01
smCom :DEBUG:Enter phNxpEseProto7816_Transceive
smCom :DEBUG:Transceive data ptr 0x0x7ead62d4 len:8
smCom :DEBUG:I-Frame Data Len: 8 Seq. no:1
smCom :DEBUG:TransceiveProcess nextTransceiveState 1
smCom :DEBUG:phNxpEse_WriteFrame Enter ..
smCom :DEBUG:TX (axI2CWrite) > (Len=13)
5A 40 08 80 04 00 22 03 41 01 01 16 29
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:RAW Tx> (Len=13)
5A 40 08 80 04 00 22 03 41 01 01 16 29
smCom :DEBUG:phNxpEse_read Enter ..
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0d
smCom :DEBUG:TX (axI2CRead): (Len=2)
00 00
smCom :DEBUG:_i2c_read() error : 13
smCom :DEBUG:_i2c_read() [HDR]errno : 79 ret : FFFFFFFF
smCom :DEBUG:phNxpEse_readPacket Normal Pkt, delay read 1ms
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:TX (axI2CRead): (Len=2)
A5 40
smCom :DEBUG:phNxpEse_readPacket Read HDR
smCom :DEBUG:phNxpEse_readPacket SOF FOUND
smCom :DEBUG:phPalEse_i2c_read Read Requested 1 bytes
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:TX (axI2CRead): (Len=1)
02
smCom :DEBUG:poll_sof_chained_delay value is 0
smCom :DEBUG:phPalEse_i2c_read Read Requested 4 bytes
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:TX (axI2CRead): (Len=4)
69 85 00 C1
smCom :DEBUG:RAW Rx< (Len=7)
A5 40 02 69 85 00 C1
smCom :DEBUG:phNxpEseProto7816_ProcessResponse p_data ----> 0x19b1f28 len ----> 0x7
smCom :DEBUG:Received CRC:0xc1 Calculated CRC:0xc1
smCom :DEBUG:Retry Counter = 0
smCom :DEBUG:phNxpEseProto7816_DecodeFrame I-Frame Received
smCom :DEBUG:phNxpEseProto7816_DecodeFrame I-Frame lastRcvdIframeInfo.seqNo:0x1
smCom :DEBUG:Data[0]=0x69 len=2 Data[1]=0x69 Data[133]=0x2
smCom :DEBUG: phNxpEse_Transceive Exit status 0x0
smCom :DEBUG:APDU Rx< (Len=2)
69 85
smCom :DEBUG:Trying to Released Lock by thread: 1996165136
smCom :DEBUG:LOCK Released by thread: 1996165136
sss :WARN :nxEnsure:'ret == SM_OK' failed. At Line:6291 Function:sss_se05x_TXn
App :ERROR:Se05x_API_GetFreeMemory Failed
App :INFO :mem=0
App :ERROR:se05x_Minimal Example Failed !!!...
App :INFO :ex_sss Finished
App :ERROR:ex_sss_entry Failed
hostLib:DEBUG:CloseSession command is sent only if valid Session exists!!!
smCom :DEBUG:TransceiveProcess nextTransceiveState 6
smCom :DEBUG:S-Frame PCB: c5
smCom :DEBUG:phNxpEse_WriteFrame Enter ..
smCom :DEBUG:TX (axI2CWrite) > (Len=5)
5A C5 00 47 82
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:RAW Tx> (Len=5)
5A C5 00 47 82
smCom :DEBUG:phNxpEse_read Enter ..
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:TX (axI2CRead): (Len=2)
A5 E5
smCom :DEBUG:phNxpEse_readPacket Read HDR
smCom :DEBUG:phNxpEse_readPacket SOF FOUND
smCom :DEBUG:phPalEse_i2c_read Read Requested 1 bytes
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:TX (axI2CRead): (Len=1)
00
smCom :DEBUG:poll_sof_chained_delay value is 0
smCom :DEBUG:phPalEse_i2c_read Read Requested 2 bytes
smCom :DEBUG:Done with rv = 0c
smCom :DEBUG:TX (axI2CRead): (Len=2)
87 67
smCom :DEBUG:RAW Rx< (Len=5)
A5 E5 00 87 67
smCom :DEBUG:phNxpEseProto7816_ProcessResponse p_data ----> 0x19b1f28 len ----> 0x5
smCom :DEBUG:Received CRC:0x8767 Calculated CRC:0x8767
smCom :DEBUG:Retry Counter = 0
smCom :DEBUG:phNxpEseProto7816_DecodeFrame S-Frame Received
smCom :DEBUG:Close i2c device 3.
smCom :DEBUG:phNxpEse_close - ESE Context deinit completed
App :ERROR:!ERROR! ret != 0.