opensc-debug-0.16.0rc1.log

0x801807400 21:12:40.099 [opensc-pkcs11] ctx.c:745:sc_context_create: ===================================
0x801807400 21:12:40.099 [opensc-pkcs11] ctx.c:746:sc_context_create: opensc version: 0.16.0rc1
0x801807400 21:12:40.099 [opensc-pkcs11] reader-pcsc.c:708:pcsc_init: PC/SC options: connect_exclusive=0 disconnect_action=1 transaction_end_action=0 reconnect_action=0 enable_pinpad=1 enable_pace=1
0x801807400 21:12:40.099 [opensc-pkcs11] reader-pcsc.c:1102:pcsc_detect_readers: called
0x801807400 21:12:40.099 [opensc-pkcs11] reader-pcsc.c:1116:pcsc_detect_readers: Probing PC/SC readers
0x801807400 21:12:40.099 [opensc-pkcs11] reader-pcsc.c:1145:pcsc_detect_readers: Establish PC/SC context
0x801807400 21:12:40.100 [opensc-pkcs11] reader-pcsc.c:1193:pcsc_detect_readers: Found new PC/SC reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:40.100 [opensc-pkcs11] reader-pcsc.c:303:refresh_attributes: Gemalto PC Twin Reader 00 00 check
0x801807400 21:12:40.100 [opensc-pkcs11] reader-pcsc.c:330:refresh_attributes: current  state: 0x00000022
0x801807400 21:12:40.100 [opensc-pkcs11] reader-pcsc.c:331:refresh_attributes: previous state: 0x00000000
0x801807400 21:12:40.100 [opensc-pkcs11] reader-pcsc.c:385:refresh_attributes: card present, changed
0x801807400 21:12:40.100 [opensc-pkcs11] reader-pcsc.c:1224:pcsc_detect_readers: Requesting reader features ... 
0x801807400 21:12:40.179 [opensc-pkcs11] reader-pcsc.c:1238:pcsc_detect_readers: Gemalto PC Twin Reader 00 00:SCardConnect(SHARED): 0x00000000
0x801807400 21:12:40.179 [opensc-pkcs11] reader-pcsc.c:955:detect_reader_features: called
0x801807400 21:12:40.179 [opensc-pkcs11] reader-pcsc.c:976:detect_reader_features: Reader feature 12 found
0x801807400 21:12:40.187 [opensc-pkcs11] reader-pcsc.c:935:part10_get_vendor_product: id_vendor=08e6 id_product=3437
0x801807400 21:12:40.187 [opensc-pkcs11] reader-pcsc.c:1268:pcsc_detect_readers: returning with: 0 (Success)
0x801807400 21:12:40.187 [opensc-pkcs11] misc.c:493:load_pkcs11_parameters: PKCS#11 options: max_virtual_slots=16 slots_per_card=4 hide_empty_tokens=1 lock_login=0 atomic=0 pin_unblock_style=0 zero_ckaid_for_ca_certs=0 create_slots_flags=0x8
0x801807400 21:12:40.187 [opensc-pkcs11] slot.c:90:create_slot: Creating slot with id 0x0
0x801807400 21:12:40.187 [opensc-pkcs11] slot.c:90:create_slot: Creating slot with id 0x1
0x801807400 21:12:40.187 [opensc-pkcs11] slot.c:90:create_slot: Creating slot with id 0x2
0x801807400 21:12:40.187 [opensc-pkcs11] slot.c:90:create_slot: Creating slot with id 0x3
0x801807400 21:12:40.187 [opensc-pkcs11] slot.c:147:initialize_reader: Initialize reader 'Gemalto PC Twin Reader 00 00': detect SC card presence
0x801807400 21:12:40.187 [opensc-pkcs11] sc.c:251:sc_detect_card_presence: called
0x801807400 21:12:40.187 [opensc-pkcs11] reader-pcsc.c:393:pcsc_detect_card_presence: called
0x801807400 21:12:40.187 [opensc-pkcs11] reader-pcsc.c:303:refresh_attributes: Gemalto PC Twin Reader 00 00 check
0x801807400 21:12:40.187 [opensc-pkcs11] reader-pcsc.c:322:refresh_attributes: returning with: 0 (Success)
0x801807400 21:12:40.187 [opensc-pkcs11] reader-pcsc.c:398:pcsc_detect_card_presence: returning with: 1
0x801807400 21:12:40.187 [opensc-pkcs11] sc.c:256:sc_detect_card_presence: returning with: 1
0x801807400 21:12:40.187 [opensc-pkcs11] slot.c:149:initialize_reader: Initialize reader 'Gemalto PC Twin Reader 00 00': detect PKCS11 card presence
0x801807400 21:12:40.187 [opensc-pkcs11] slot.c:203:card_detect: Gemalto PC Twin Reader 00 00: Detecting smart card
0x801807400 21:12:40.187 [opensc-pkcs11] sc.c:251:sc_detect_card_presence: called
0x801807400 21:12:40.187 [opensc-pkcs11] reader-pcsc.c:393:pcsc_detect_card_presence: called
0x801807400 21:12:40.187 [opensc-pkcs11] reader-pcsc.c:303:refresh_attributes: Gemalto PC Twin Reader 00 00 check
0x801807400 21:12:40.187 [opensc-pkcs11] reader-pcsc.c:322:refresh_attributes: returning with: 0 (Success)
0x801807400 21:12:40.187 [opensc-pkcs11] reader-pcsc.c:398:pcsc_detect_card_presence: returning with: 1
0x801807400 21:12:40.187 [opensc-pkcs11] sc.c:256:sc_detect_card_presence: returning with: 1
0x801807400 21:12:40.187 [opensc-pkcs11] slot.c:240:card_detect: Gemalto PC Twin Reader 00 00: First seen the card 
0x801807400 21:12:40.187 [opensc-pkcs11] slot.c:248:card_detect: Gemalto PC Twin Reader 00 00: Connecting ... 
0x801807400 21:12:40.187 [opensc-pkcs11] card.c:196:sc_connect_card: called
0x801807400 21:12:40.187 [opensc-pkcs11] reader-pcsc.c:475:pcsc_connect: called
0x801807400 21:12:40.187 [opensc-pkcs11] reader-pcsc.c:303:refresh_attributes: Gemalto PC Twin Reader 00 00 check
0x801807400 21:12:40.188 [opensc-pkcs11] reader-pcsc.c:322:refresh_attributes: returning with: 0 (Success)
0x801807400 21:12:40.188 [opensc-pkcs11] reader-pcsc.c:504:pcsc_connect: Initial protocol: T=1
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:989:match_atr_table: ATR     : 3b:b7:18:00:c0:3e:31:fe:65:53:50:4b:32:34:90:00:25
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:6e:00:ff:45:73:74:45:49:44:20:76:65:72:20:31:2e:30
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:fe:94:00:ff:80:b1:fa:45:1f:03:45:73:74:45:49:44:20:76:65:72:20:31:2e:30:43
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:ff:94:00:ff:80:b1:fe:45:1f:03:00:68:d2:76:00:00:28:ff:05:1e:31:80:00:90:00:23
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:ff:11:00:ff:80:b1:fe:45:1f:03:00:68:d2:76:00:00:28:ff:05:1e:31:80:00:90:00:a6
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:217:sc_connect_card: matching configured ATRs
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:260:sc_connect_card: matching built-in ATRs
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:268:sc_connect_card: trying driver 'cardos'
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:989:match_atr_table: ATR     : 3b:b7:18:00:c0:3e:31:fe:65:53:50:4b:32:34:90:00:25
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:e2:00:ff:c1:10:31:fe:55:c8:02:9c
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:e9:00:ff:c1:10:31:fe:55:00:64:05:00:c8:02:31:80:00:47
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:fb:98:00:ff:c1:10:31:fe:55:00:64:05:20:47:03:31:80:00:90:00:f3
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:fc:98:00:ff:c1:10:31:fe:55:c8:03:49:6e:66:6f:63:61:6d:65:72:65:28
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:f4:98:00:ff:c1:10:31:fe:55:4d:34:63:76:b4
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:f2:18:00:ff:c1:0a:31:fe:55:c8:06:8a
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:d2:18:02:c1:0a:31:fe:58:c8:0d:51
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:d2:18:00:81:31:fe:58:c9:01:14
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:268:sc_connect_card: trying driver 'flex'
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:989:match_atr_table: ATR     : 3b:b7:18:00:c0:3e:31:fe:65:53:50:4b:32:34:90:00:25
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:95:15:40:20:68:01:02:00:00
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:15:40:FF:68:01:02:02:01
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:15:40:FF:68:01:02:02:04
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:85:40:20:68:01:01:05:01
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:94:40:FF:63:01:01:02:01
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:15:40:FF:63:01:01:02:01
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:64:02:01:01:02
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:62:01:01:00:00
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:62:01:02:01:04
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:62:04:01:01:05
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:95:15:40:ff:68:01:02:45:47
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:E2:00:00:40:20:49:06
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:E2:00:00:40:20:49:05
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:E2:00:00:40:20:49:07
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:85:40:20:68:01:01:03:05
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:02:14:50
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:19:14:55:90:01:02:01:00:05:04:B0
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:32:15:00:06:80
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:32:15:00:06:95
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:19:14:59:01:01:0F:01:00:05:08:B0
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:19:14:55:90:01:01:01:00:05:08:B0
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:16:94:81:10:06:01:81:3F
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:16:94:81:10:06:01:81:2F
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:268:sc_connect_card: trying driver 'cyberflex'
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:989:match_atr_table: ATR     : 3b:b7:18:00:c0:3e:31:fe:65:53:50:4b:32:34:90:00:25
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:95:15:40:20:68:01:02:00:00
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:15:40:FF:68:01:02:02:01
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:15:40:FF:68:01:02:02:04
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:85:40:20:68:01:01:05:01
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:94:40:FF:63:01:01:02:01
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:15:40:FF:63:01:01:02:01
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:64:02:01:01:02
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:62:01:01:00:00
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:62:01:02:01:04
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:62:04:01:01:05
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:95:15:40:ff:68:01:02:45:47
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:E2:00:00:40:20:49:06
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:E2:00:00:40:20:49:05
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:E2:00:00:40:20:49:07
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:85:40:20:68:01:01:03:05
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:02:14:50
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:19:14:55:90:01:02:01:00:05:04:B0
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:32:15:00:06:80
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:32:15:00:06:95
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:19:14:59:01:01:0F:01:00:05:08:B0
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:19:14:55:90:01:01:01:00:05:08:B0
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:16:94:81:10:06:01:81:3F
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.188 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:16:94:81:10:06:01:81:2F
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:268:sc_connect_card: trying driver 'gpk'
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:989:match_atr_table: ATR     : 3b:b7:18:00:c0:3e:31:fe:65:53:50:4b:32:34:90:00:25
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:27:00:80:65:A2:04:01:01:37
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:27:00:80:65:A2:05:01:01:37
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:27:00:80:65:A2:0C:01:01:37
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:A7:00:40:14:80:65:A2:14:01:01:37
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:A7:00:40:18:80:65:A2:08:01:01:52
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:A7:00:40:18:80:65:A2:09:01:01:52
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:A7:00:40:18:80:65:A2:09:01:02:52
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:A7:00:40:18:80:65:A2:09:01:03:52
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:268:sc_connect_card: trying driver 'gemsafeV1'
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:989:match_atr_table: ATR     : 3b:b7:18:00:c0:3e:31:fe:65:53:50:4b:32:34:90:00:25
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:7B:94:00:00:80:65:B0:83:01:01:74:83:00:90:00
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:6B:00:00:80:65:B0:83:01:01:74:83:00:90:00
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:6d:00:00:80:31:80:65:b0:83:01:02:90:83:00:90:00
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:6B:00:00:80:65:B0:83:01:03:74:83:00:90:00
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:7A:94:00:00:80:65:A2:01:01:01:3D:72:D6:43
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:7D:94:00:00:80:31:80:65:B0:83:01:01:90:83:00:90:00
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:7D:96:00:00:80:31:80:65:B0:83:11:48:C8:83:00:90:00
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:7D:95:00:00:80:31:80:65:B0:83:11:C0:A9:83:00
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:7D:95:00:00:80:31:80:65:B0:83:11:C0:A9:83:00:90:00
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:7D:95:00:00:80:31:80:65:B0:83:11:00:C8:83:00
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:7D:95:00:00:80:31:80:65:B0:83:11:00:C8:83:00:90:00
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:7D:96:00:00:80:31:80:65:B0:83:11:00:C8:83:00:90:00
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:7d:96:00:00:80:31:80:65:b0:83:02:01:f3:83:00:90:00
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:268:sc_connect_card: trying driver 'miocos'
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:989:match_atr_table: ATR     : 3b:b7:18:00:c0:3e:31:fe:65:53:50:4b:32:34:90:00:25
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:9D:94:40:23:00:68:10:11:4D:69:6F:43:4F:53:00:90:00
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:9D:94:40:23:00:68:20:01:4D:69:6F:43:4F:53:00:90:00
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:268:sc_connect_card: trying driver 'asepcos'
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:989:match_atr_table: ATR     : 3b:b7:18:00:c0:3e:31:fe:65:53:50:4b:32:34:90:00:25
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:d6:18:00:81:b1:80:7d:1f:03:80:51:00:61:10:30:8f
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:d6:18:00:81:b1:fe:7d:1f:03:41:53:45:37:35:35:01
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:268:sc_connect_card: trying driver 'starcos'
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:989:match_atr_table: ATR     : 3b:b7:18:00:c0:3e:31:fe:65:53:50:4b:32:34:90:00:25
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:B7:94:00:c0:24:31:fe:65:53:50:4b:32:33:90:00:b4
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3B:B7:94:00:81:31:fe:65:53:50:4b:32:33:90:00:d1
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1003:match_atr_table: ignored - wrong length
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1000:match_atr_table: ATR try : 3b:b7:18:00:c0:3e:31:fe:65:53:50:4b:32:34:90:00:25
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:282:sc_connect_card: matched: STARCOS SPK 2.3/2.4/3.4
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:310:sc_connect_card: card info name:'STARCOS SPK 2.3', type:7001, flags:0x0, max_send/recv_size:255/256
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1356:sc_card_sm_check: called
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1357:sc_card_sm_check: card->sm_ctx.ops.open 0x0
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:1362:sc_card_sm_check: returning with: 0 (Success)
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:322:sc_connect_card: returning with: 0 (Success)
0x801807400 21:12:40.189 [opensc-pkcs11] slot.c:255:card_detect: Gemalto PC Twin Reader 00 00: Connected SC card 0x8018ab400
0x801807400 21:12:40.189 [opensc-pkcs11] dir.c:163:sc_enum_apps: called
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:709:sc_select_file: called; type=2, path=3f002f00
0x801807400 21:12:40.189 [opensc-pkcs11] card-starcos.c:623:starcos_select_file: called
0x801807400 21:12:40.189 [opensc-pkcs11] card-starcos.c:633:starcos_select_file: current path (path, invalid):  (len: 0)
0x801807400 21:12:40.189 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:40.189 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:40.189 [opensc-pkcs11] reader-pcsc.c:543:pcsc_lock: called
0x801807400 21:12:40.189 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:40.189 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:40.189 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:0, data(2) 0x7fffffffd6c0
0x801807400 21:12:40.189 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:40.189 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (8 bytes):
00 A4 00 00 02 3F 00 00 .....?..
0x801807400 21:12:40.189 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.033 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (2 bytes):
62 84 b.
0x801807400 21:12:41.033 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.033 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.033 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.033 [opensc-pkcs11] reader-pcsc.c:583:pcsc_unlock: called
0x801807400 21:12:41.037 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.037 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.037 [opensc-pkcs11] reader-pcsc.c:543:pcsc_lock: called
0x801807400 21:12:41.037 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.037 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.037 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:C, data(2) 0x7fffffffd6c0
0x801807400 21:12:41.037 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.037 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (7 bytes):
00 A4 00 0C 02 3F 00 .....?.
0x801807400 21:12:41.037 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.044 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (2 bytes):
90 00 ..
0x801807400 21:12:41.044 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.044 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.044 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.044 [opensc-pkcs11] reader-pcsc.c:583:pcsc_unlock: called
0x801807400 21:12:41.048 [opensc-pkcs11] card-starcos.c:611:starcos_select_fid: returning with: 0 (Success)
0x801807400 21:12:41.048 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.048 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.048 [opensc-pkcs11] reader-pcsc.c:543:pcsc_lock: called
0x801807400 21:12:41.048 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.048 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.048 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:0, data(2) 0x7fffffffd6c0
0x801807400 21:12:41.048 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.048 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (8 bytes):
00 A4 00 00 02 2F 00 00 ...../..
0x801807400 21:12:41.048 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.056 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (11 bytes):
6F 07 80 02 00 80 82 01 01 90 00 o..........
0x801807400 21:12:41.056 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.056 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.056 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.056 [opensc-pkcs11] reader-pcsc.c:583:pcsc_unlock: called
0x801807400 21:12:41.063 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.063 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.063 [opensc-pkcs11] reader-pcsc.c:543:pcsc_lock: called
0x801807400 21:12:41.063 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.063 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.063 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) 0x0
0x801807400 21:12:41.063 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.063 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 00 01 .....
0x801807400 21:12:41.063 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.071 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (3 bytes):
61 90 00 a..
0x801807400 21:12:41.071 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.071 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.071 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.071 [opensc-pkcs11] reader-pcsc.c:583:pcsc_unlock: called
0x801807400 21:12:41.073 [opensc-pkcs11] card-starcos.c:176:process_fci: processing FCI bytes
0x801807400 21:12:41.073 [opensc-pkcs11] card-starcos.c:198:process_fci:   bytes in file: 128
0x801807400 21:12:41.073 [opensc-pkcs11] card-starcos.c:247:process_fci:   type: working EF
0x801807400 21:12:41.073 [opensc-pkcs11] card-starcos.c:249:process_fci:   EF structure: transparent
0x801807400 21:12:41.073 [opensc-pkcs11] card-starcos.c:611:starcos_select_fid: returning with: 0 (Success)
0x801807400 21:12:41.073 [opensc-pkcs11] card.c:744:sc_select_file: returning with: 0 (Success)
0x801807400 21:12:41.073 [opensc-pkcs11] card.c:530:sc_read_binary: called; 128 bytes at index 0
0x801807400 21:12:41.073 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.073 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.073 [opensc-pkcs11] reader-pcsc.c:543:pcsc_lock: called
0x801807400 21:12:41.073 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.073 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.073 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) 0x0
0x801807400 21:12:41.073 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.073 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 00 80 .....
0x801807400 21:12:41.073 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.095 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (130 bytes):
61 21 4F 0C A0 00 00 00 63 50 4B 43 53 2D 31 35 a!O.....cPKCS-15
50 0B 4F 70 65 6E 53 43 20 43 61 72 64 51 04 3F P.OpenSC CardQ.?
00 50 15 00 00 00 00 00 00 00 00 00 00 00 00 00 .P..............
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
90 00                                           ..
0x801807400 21:12:41.095 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.095 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.095 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.095 [opensc-pkcs11] reader-pcsc.c:583:pcsc_unlock: called
0x801807400 21:12:41.102 [opensc-pkcs11] card-starcos.c:1591:starcos_check_sw: sw1 = 0x90, sw2 = 0x00
0x801807400 21:12:41.102 [opensc-pkcs11] iso7816.c:168:iso7816_read_binary: returning with: 128
0x801807400 21:12:41.102 [opensc-pkcs11] card.c:574:sc_read_binary: returning with: 128
0x801807400 21:12:41.102 [opensc-pkcs11] dir.c:71:parse_dir_record: called
0x801807400 21:12:41.102 [opensc-pkcs11] asn1.c:1447:asn1_decode: called, left=128, depth 0
0x801807400 21:12:41.102 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'dirRecord', tag 0x11000001
0x801807400 21:12:41.102 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry: decoding 'dirRecord'
0x801807400 21:12:41.102 [opensc-pkcs11] asn1.c:1447:asn1_decode:  called, left=33, depth 1
0x801807400 21:12:41.102 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'aid', tag 0x1000000f
0x801807400 21:12:41.102 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'aid'
0x801807400 21:12:41.102 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'label', tag 0x10000010, OPTIONAL
0x801807400 21:12:41.102 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'label'
0x801807400 21:12:41.102 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'path', tag 0x10000011, OPTIONAL
0x801807400 21:12:41.102 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'path'
0x801807400 21:12:41.102 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'ddo', tag 0x11000013, OPTIONAL
0x801807400 21:12:41.102 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.102 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.102 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.102 [opensc-pkcs11] dir.c:151:parse_dir_record: returning with: 0 (Success)
0x801807400 21:12:41.102 [opensc-pkcs11] dir.c:71:parse_dir_record: called
0x801807400 21:12:41.102 [opensc-pkcs11] asn1.c:1447:asn1_decode: called, left=93, depth 0
0x801807400 21:12:41.102 [opensc-pkcs11] dir.c:84:parse_dir_record: returning with: -1403 (Premature end of ASN.1 stream)
0x801807400 21:12:41.102 [opensc-pkcs11] dir.c:256:sc_enum_apps: returning with: 0 (Success)
0x801807400 21:12:41.102 [opensc-pkcs11] slot.c:262:card_detect: Gemalto PC Twin Reader 00 00: Detecting Framework. 1 on-card applications
0x801807400 21:12:41.102 [opensc-pkcs11] slot.c:263:card_detect: Gemalto PC Twin Reader 00 00: generic application <none>
0x801807400 21:12:41.102 [opensc-pkcs11] slot.c:275:card_detect: Gemalto PC Twin Reader 00 00: Detected framework 0. Creating tokens.
0x801807400 21:12:41.102 [opensc-pkcs11] slot.c:312:card_detect: Gemalto PC Twin Reader 00 00: Binding OpenSC Card token.
0x801807400 21:12:41.102 [opensc-pkcs11] framework-pkcs15.c:269:pkcs15_bind: Bind PKCS#15 'OpenSC Card' application
0x801807400 21:12:41.102 [opensc-pkcs11] pkcs15.c:1184:sc_pkcs15_bind: called
0x801807400 21:12:41.102 [opensc-pkcs11] pkcs15.c:1185:sc_pkcs15_bind: application(aid:'A000000063504B43532D3135')
0x801807400 21:12:41.102 [opensc-pkcs11] pkcs15.c:1209:sc_pkcs15_bind: PKCS#15 options: use_file_cache=0 use_pin_cache=1 pin_cache_counter=10 pin_cache_ignore_user_consent=0
0x801807400 21:12:41.102 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.102 [opensc-pkcs11] reader-pcsc.c:543:pcsc_lock: called
0x801807400 21:12:41.102 [opensc-pkcs11] pkcs15.c:1220:sc_pkcs15_bind: PKCS#15 emulation enabled
0x801807400 21:12:41.103 [opensc-pkcs11] pkcs15.c:988:sc_pkcs15_bind_internal: called
0x801807400 21:12:41.103 [opensc-pkcs11] pkcs15.c:1005:sc_pkcs15_bind_internal: bind to application('OpenSC Card',aid:'A000000063504B43532D3135')
0x801807400 21:12:41.103 [opensc-pkcs11] pkcs15.c:1024:sc_pkcs15_bind_internal: application path '3f005015'
0x801807400 21:12:41.103 [opensc-pkcs11] card.c:709:sc_select_file: called; type=2, path=3f005015
0x801807400 21:12:41.103 [opensc-pkcs11] card-starcos.c:623:starcos_select_file: called
0x801807400 21:12:41.103 [opensc-pkcs11] card-starcos.c:633:starcos_select_file: current path (path, valid): 3f00 (len: 2)
0x801807400 21:12:41.103 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.103 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.103 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.103 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.103 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:0, data(2) 0x7fffffffd1a0
0x801807400 21:12:41.103 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.103 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (8 bytes):
00 A4 00 00 02 50 15 00 .....P..
0x801807400 21:12:41.103 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.109 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (2 bytes):
62 84 b.
0x801807400 21:12:41.109 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.109 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.109 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.109 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.109 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.109 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.109 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.109 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:C, data(2) 0x7fffffffd1a0
0x801807400 21:12:41.109 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.109 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (7 bytes):
00 A4 00 0C 02 50 15 .....P.
0x801807400 21:12:41.109 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.116 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (2 bytes):
90 00 ..
0x801807400 21:12:41.116 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.116 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.116 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.116 [opensc-pkcs11] card-starcos.c:611:starcos_select_fid: returning with: 0 (Success)
0x801807400 21:12:41.116 [opensc-pkcs11] card.c:744:sc_select_file: returning with: 0 (Success)
0x801807400 21:12:41.116 [opensc-pkcs11] pkcs15.c:1050:sc_pkcs15_bind_internal: absolute path to EF(ODF) 3f0050155031
0x801807400 21:12:41.116 [opensc-pkcs11] card.c:709:sc_select_file: called; type=2, path=3f0050155031
0x801807400 21:12:41.116 [opensc-pkcs11] card-starcos.c:623:starcos_select_file: called
0x801807400 21:12:41.116 [opensc-pkcs11] card-starcos.c:633:starcos_select_file: current path (path, valid): 3f005015 (len: 4)
0x801807400 21:12:41.116 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.116 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.116 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.116 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.116 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:0, data(2) 0x7fffffffd1a0
0x801807400 21:12:41.116 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.116 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (8 bytes):
00 A4 00 00 02 50 31 00 .....P1.
0x801807400 21:12:41.116 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.124 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (11 bytes):
6F 07 80 02 01 00 82 01 01 90 00 o..........
0x801807400 21:12:41.124 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.124 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.124 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.124 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.124 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.124 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.124 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.124 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) 0x0
0x801807400 21:12:41.124 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.124 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 00 01 .....
0x801807400 21:12:41.124 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.134 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (3 bytes):
A8 90 00 ...
0x801807400 21:12:41.134 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.134 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.134 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.134 [opensc-pkcs11] card-starcos.c:176:process_fci: processing FCI bytes
0x801807400 21:12:41.134 [opensc-pkcs11] card-starcos.c:198:process_fci:   bytes in file: 256
0x801807400 21:12:41.134 [opensc-pkcs11] card-starcos.c:247:process_fci:   type: working EF
0x801807400 21:12:41.134 [opensc-pkcs11] card-starcos.c:249:process_fci:   EF structure: transparent
0x801807400 21:12:41.134 [opensc-pkcs11] card-starcos.c:611:starcos_select_fid: returning with: 0 (Success)
0x801807400 21:12:41.134 [opensc-pkcs11] card.c:744:sc_select_file: returning with: 0 (Success)
0x801807400 21:12:41.134 [opensc-pkcs11] card.c:530:sc_read_binary: called; 256 bytes at index 0
0x801807400 21:12:41.134 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.134 [opensc-pkcs11] card.c:530:sc_read_binary: called; 128 bytes at index 0
0x801807400 21:12:41.134 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.134 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.134 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.134 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.134 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) 0x0
0x801807400 21:12:41.134 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.134 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 00 80 .....
0x801807400 21:12:41.134 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.158 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (130 bytes):
A8 0A 30 08 04 06 3F 00 50 15 44 01 A0 0A 30 08 ..0...?.P.D...0.
04 06 3F 00 50 15 44 02 A1 0A 30 08 04 06 3F 00 ..?.P.D...0...?.
50 15 44 03 00 00 00 00 00 00 00 00 00 00 00 00 P.D.............
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
90 00                                           ..
0x801807400 21:12:41.158 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.158 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.158 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.158 [opensc-pkcs11] card-starcos.c:1591:starcos_check_sw: sw1 = 0x90, sw2 = 0x00
0x801807400 21:12:41.158 [opensc-pkcs11] iso7816.c:168:iso7816_read_binary: returning with: 128
0x801807400 21:12:41.158 [opensc-pkcs11] card.c:574:sc_read_binary: returning with: 128
0x801807400 21:12:41.158 [opensc-pkcs11] card.c:530:sc_read_binary: called; 128 bytes at index 128
0x801807400 21:12:41.158 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.158 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.158 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.158 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.158 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:80, data(0) 0x0
0x801807400 21:12:41.158 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.158 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 80 80 .....
0x801807400 21:12:41.158 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.182 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (130 bytes):
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
90 00                                           ..
0x801807400 21:12:41.182 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.182 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.182 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.182 [opensc-pkcs11] card-starcos.c:1591:starcos_check_sw: sw1 = 0x90, sw2 = 0x00
0x801807400 21:12:41.182 [opensc-pkcs11] iso7816.c:168:iso7816_read_binary: returning with: 128
0x801807400 21:12:41.182 [opensc-pkcs11] card.c:574:sc_read_binary: returning with: 128
0x801807400 21:12:41.182 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.182 [opensc-pkcs11] card.c:571:sc_read_binary: returning with: 256
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1447:asn1_decode: called, left=256, depth 0, choice
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'privateKeys', tag 0x21000000, CHOICE
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'publicKeys', tag 0x21000001, CHOICE
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'trustedPublicKeys', tag 0x21000002, CHOICE
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'secretKeys', tag 0x21000003, CHOICE
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'certificates', tag 0x21000004, CHOICE
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'trustedCertificates', tag 0x21000005, CHOICE
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'usefulCertificates', tag 0x21000006, CHOICE
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'dataObjects', tag 0x21000007, CHOICE
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'authObjects', tag 0x21000008, CHOICE
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry: decoding 'authObjects'
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1447:asn1_decode:  called, left=10, depth 1
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'path', tag 0x1000010
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'path'
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1447:asn1_decode:   called, left=8, depth 2
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'path', tag 0x4, OPTIONAL
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'path'
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'index', tag 0x2, OPTIONAL
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'length', tag 0x20000000, OPTIONAL
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'pathExtended', tag 0x21000001, OPTIONAL
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1519:asn1_decode: returning with: 8
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1447:asn1_decode: called, left=244, depth 0, choice
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'privateKeys', tag 0x21000000, CHOICE
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry: decoding 'privateKeys'
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1447:asn1_decode:  called, left=10, depth 1
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'path', tag 0x1000010
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'path'
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1447:asn1_decode:   called, left=8, depth 2
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'path', tag 0x4, OPTIONAL
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'path'
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'index', tag 0x2, OPTIONAL
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'length', tag 0x20000000, OPTIONAL
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'pathExtended', tag 0x21000001, OPTIONAL
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1519:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1447:asn1_decode: called, left=232, depth 0, choice
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'privateKeys', tag 0x21000000, CHOICE
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'publicKeys', tag 0x21000001, CHOICE
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry: decoding 'publicKeys'
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1447:asn1_decode:  called, left=10, depth 1
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'path', tag 0x1000010
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'path'
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1447:asn1_decode:   called, left=8, depth 2
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'path', tag 0x4, OPTIONAL
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'path'
0x801807400 21:12:41.182 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'index', tag 0x2, OPTIONAL
0x801807400 21:12:41.183 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.183 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'length', tag 0x20000000, OPTIONAL
0x801807400 21:12:41.183 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.183 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'pathExtended', tag 0x21000001, OPTIONAL
0x801807400 21:12:41.183 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.183 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.183 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.183 [opensc-pkcs11] asn1.c:1519:asn1_decode: returning with: 1
0x801807400 21:12:41.183 [opensc-pkcs11] asn1.c:1447:asn1_decode: called, left=220, depth 0, choice
0x801807400 21:12:41.183 [opensc-pkcs11] pkcs15.c:1094:sc_pkcs15_bind_internal: The following DFs were found:
0x801807400 21:12:41.183 [opensc-pkcs11] pkcs15.c:1097:sc_pkcs15_bind_internal:   DF type 8, path 3f0050154401, index 0, count -1
0x801807400 21:12:41.183 [opensc-pkcs11] pkcs15.c:1097:sc_pkcs15_bind_internal:   DF type 0, path 3f0050154402, index 0, count -1
0x801807400 21:12:41.183 [opensc-pkcs11] pkcs15.c:1097:sc_pkcs15_bind_internal:   DF type 1, path 3f0050154403, index 0, count -1
0x801807400 21:12:41.183 [opensc-pkcs11] pkcs15.c:1106:sc_pkcs15_bind_internal: absolute path to EF(TokenInfo) 3f0050155032
0x801807400 21:12:41.183 [opensc-pkcs11] card.c:709:sc_select_file: called; type=2, path=3f0050155032
0x801807400 21:12:41.183 [opensc-pkcs11] card-starcos.c:623:starcos_select_file: called
0x801807400 21:12:41.183 [opensc-pkcs11] card-starcos.c:633:starcos_select_file: current path (path, valid): 3f005015 (len: 4)
0x801807400 21:12:41.183 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.183 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.183 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.183 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.183 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:0, data(2) 0x7fffffffd1a0
0x801807400 21:12:41.183 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.183 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (8 bytes):
00 A4 00 00 02 50 32 00 .....P2.
0x801807400 21:12:41.183 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.190 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (11 bytes):
6F 07 80 02 00 41 82 01 01 90 00 o....A.....
0x801807400 21:12:41.190 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.190 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.190 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.190 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.190 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.190 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.190 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.190 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) 0x0
0x801807400 21:12:41.190 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.190 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 00 01 .....
0x801807400 21:12:41.190 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.198 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (3 bytes):
30 90 00 0..
0x801807400 21:12:41.198 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.198 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.198 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.198 [opensc-pkcs11] card-starcos.c:176:process_fci: processing FCI bytes
0x801807400 21:12:41.198 [opensc-pkcs11] card-starcos.c:198:process_fci:   bytes in file: 65
0x801807400 21:12:41.198 [opensc-pkcs11] card-starcos.c:247:process_fci:   type: working EF
0x801807400 21:12:41.198 [opensc-pkcs11] card-starcos.c:249:process_fci:   EF structure: transparent
0x801807400 21:12:41.198 [opensc-pkcs11] card-starcos.c:611:starcos_select_fid: returning with: 0 (Success)
0x801807400 21:12:41.198 [opensc-pkcs11] card.c:744:sc_select_file: returning with: 0 (Success)
0x801807400 21:12:41.198 [opensc-pkcs11] card.c:530:sc_read_binary: called; 65 bytes at index 0
0x801807400 21:12:41.198 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.198 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.198 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.198 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.198 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) 0x0
0x801807400 21:12:41.198 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.198 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 00 41 ....A
0x801807400 21:12:41.198 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.212 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (67 bytes):
30 3F 02 01 00 04 08 21 91 31 36 00 10 2F 1F 0C 0?.....!.16../..
0E 4F 70 65 6E 53 43 20 50 72 6F 6A 65 63 74 80 .OpenSC Project.
0B 4F 70 65 6E 53 43 20 43 61 72 64 03 02 04 10 .OpenSC Card....
85 0F 32 30 31 30 30 34 33 30 31 37 34 36 30 37 ..20100430174607
5A 90 00                                        Z..
0x801807400 21:12:41.212 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.212 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.212 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.212 [opensc-pkcs11] card-starcos.c:1591:starcos_check_sw: sw1 = 0x90, sw2 = 0x00
0x801807400 21:12:41.212 [opensc-pkcs11] iso7816.c:168:iso7816_read_binary: returning with: 65
0x801807400 21:12:41.212 [opensc-pkcs11] card.c:574:sc_read_binary: returning with: 65
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1447:asn1_decode: called, left=65, depth 0
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'TokenInfo', tag 0x1000010
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry: decoding 'TokenInfo'
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1447:asn1_decode:  called, left=63, depth 1
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'version', tag 0x2
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'version'
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1287:asn1_decode_entry:  decoding 'version' returned 0
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'serialNumber', tag 0x4, OPTIONAL
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'serialNumber'
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'manufacturerID', tag 0xc, OPTIONAL
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'manufacturerID'
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'label', tag 0x20000000, OPTIONAL
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'label'
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'label-tw', tag 0x21000000, OPTIONAL
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'tokenflags', tag 0x3
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'tokenflags'
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'seInfo', tag 0x1000010, OPTIONAL
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'recordInfo', tag 0x21000001, OPTIONAL
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'supportedAlgorithms', tag 0x21000002, OPTIONAL
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'issuerId', tag 0x20000003, OPTIONAL
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'holderId', tag 0x20000004, OPTIONAL
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'lastUpdate', tag 0x21000005, OPTIONAL
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'preferredLanguage', tag 0x13, OPTIONAL
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'profileIndication', tag 0x21000006, OPTIONAL
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.212 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.212 [opensc-pkcs11] pkcs15.c:254:sc_pkcs15_parse_tokeninfo: LastUpdate.path ''
0x801807400 21:12:41.212 [opensc-pkcs11] pkcs15.c:255:sc_pkcs15_parse_tokeninfo: ProfileIndication.name '(null)'
0x801807400 21:12:41.212 [opensc-pkcs11] pkcs15.c:1171:sc_pkcs15_bind_internal: returning with: 0 (Success)
0x801807400 21:12:41.212 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.212 [opensc-pkcs11] reader-pcsc.c:583:pcsc_unlock: called
0x801807400 21:12:41.216 [opensc-pkcs11] pkcs15.c:1248:sc_pkcs15_bind: returning with: 0 (Success)
0x801807400 21:12:41.217 [opensc-pkcs11] slot.c:319:card_detect: Gemalto PC Twin Reader 00 00: Creating OpenSC Card token.
0x801807400 21:12:41.217 [opensc-pkcs11] framework-pkcs15.c:1256:pkcs15_create_tokens: create PKCS#15 tokens; fws:0x801826500,0x0,0x0
0x801807400 21:12:41.217 [opensc-pkcs11] framework-pkcs15.c:1257:pkcs15_create_tokens: create slots flags 0x8
0x801807400 21:12:41.217 [opensc-pkcs11] framework-pkcs15.c:1266:pkcs15_create_tokens: Use FW data with index 0; fw_data->p15_card 0x801820900
0x801807400 21:12:41.217 [opensc-pkcs11] pkcs15.c:1707:sc_pkcs15_find_pin_by_flags: called
0x801807400 21:12:41.217 [opensc-pkcs11] pkcs15.c:1708:sc_pkcs15_find_pin_by_flags: Find PIN flags:0x10, mask:0xD2, index:-1
0x801807400 21:12:41.217 [opensc-pkcs11] pkcs15.c:2022:sc_pkcs15_parse_df: called; path=3f0050154401, type=8, enum=0
0x801807400 21:12:41.217 [opensc-pkcs11] pkcs15.c:2311:sc_pkcs15_read_file: called
0x801807400 21:12:41.217 [opensc-pkcs11] pkcs15.c:2312:sc_pkcs15_read_file: path=3f0050154401, index=0, count=-1
0x801807400 21:12:41.217 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.217 [opensc-pkcs11] reader-pcsc.c:543:pcsc_lock: called
0x801807400 21:12:41.217 [opensc-pkcs11] card.c:709:sc_select_file: called; type=2, path=3f0050154401
0x801807400 21:12:41.217 [opensc-pkcs11] card-starcos.c:623:starcos_select_file: called
0x801807400 21:12:41.217 [opensc-pkcs11] card-starcos.c:633:starcos_select_file: current path (path, valid): 3f005015 (len: 4)
0x801807400 21:12:41.217 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.217 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.217 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.217 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.217 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:0, data(2) 0x7fffffffd3a0
0x801807400 21:12:41.217 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.217 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (8 bytes):
00 A4 00 00 02 44 01 00 .....D..
0x801807400 21:12:41.217 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.225 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (11 bytes):
6F 07 80 02 01 00 82 01 01 90 00 o..........
0x801807400 21:12:41.225 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.225 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.225 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.225 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.225 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.225 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.225 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.225 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) 0x0
0x801807400 21:12:41.225 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.225 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 00 01 .....
0x801807400 21:12:41.225 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.235 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (3 bytes):
30 90 00 0..
0x801807400 21:12:41.235 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.235 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.235 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.235 [opensc-pkcs11] card-starcos.c:176:process_fci: processing FCI bytes
0x801807400 21:12:41.235 [opensc-pkcs11] card-starcos.c:198:process_fci:   bytes in file: 256
0x801807400 21:12:41.235 [opensc-pkcs11] card-starcos.c:247:process_fci:   type: working EF
0x801807400 21:12:41.235 [opensc-pkcs11] card-starcos.c:249:process_fci:   EF structure: transparent
0x801807400 21:12:41.235 [opensc-pkcs11] card-starcos.c:611:starcos_select_fid: returning with: 0 (Success)
0x801807400 21:12:41.235 [opensc-pkcs11] card.c:744:sc_select_file: returning with: 0 (Success)
0x801807400 21:12:41.235 [opensc-pkcs11] card.c:530:sc_read_binary: called; 256 bytes at index 0
0x801807400 21:12:41.235 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.235 [opensc-pkcs11] card.c:530:sc_read_binary: called; 128 bytes at index 0
0x801807400 21:12:41.235 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.235 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.235 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.235 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.235 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) 0x0
0x801807400 21:12:41.235 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.235 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 00 80 .....
0x801807400 21:12:41.235 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.259 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (130 bytes):
30 2F 30 04 03 02 06 C0 30 04 04 02 38 21 A1 21 0/0.....0...8!.!
30 1F 03 02 02 4C 0A 01 01 02 01 04 02 01 08 02 0....L..........
01 08 80 02 00 83 04 01 00 30 06 04 04 3F 00 50 .........0...?.P
15 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
90 00                                           ..
0x801807400 21:12:41.259 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.259 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.259 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.259 [opensc-pkcs11] card-starcos.c:1591:starcos_check_sw: sw1 = 0x90, sw2 = 0x00
0x801807400 21:12:41.259 [opensc-pkcs11] iso7816.c:168:iso7816_read_binary: returning with: 128
0x801807400 21:12:41.259 [opensc-pkcs11] card.c:574:sc_read_binary: returning with: 128
0x801807400 21:12:41.259 [opensc-pkcs11] card.c:530:sc_read_binary: called; 128 bytes at index 128
0x801807400 21:12:41.259 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.259 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.259 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.259 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.259 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:80, data(0) 0x0
0x801807400 21:12:41.259 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.259 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 80 80 .....
0x801807400 21:12:41.259 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.283 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (130 bytes):
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
90 00                                           ..
0x801807400 21:12:41.283 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.283 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.283 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.283 [opensc-pkcs11] card-starcos.c:1591:starcos_check_sw: sw1 = 0x90, sw2 = 0x00
0x801807400 21:12:41.283 [opensc-pkcs11] iso7816.c:168:iso7816_read_binary: returning with: 128
0x801807400 21:12:41.283 [opensc-pkcs11] card.c:574:sc_read_binary: returning with: 128
0x801807400 21:12:41.283 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.283 [opensc-pkcs11] card.c:571:sc_read_binary: returning with: 256
0x801807400 21:12:41.283 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.283 [opensc-pkcs11] reader-pcsc.c:583:pcsc_unlock: called
0x801807400 21:12:41.289 [opensc-pkcs11] pkcs15.c:2404:sc_pkcs15_read_file: returning with: 0 (Success)
0x801807400 21:12:41.289 [opensc-pkcs11] pkcs15-pin.c:96:sc_pkcs15_decode_aodf_entry: called
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1447:asn1_decode: called, left=256, depth 0
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'authType', tag 0x0
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1447:asn1_decode:  called, left=256, depth 1, choice
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'pin', tag 0x1000010, CHOICE, OPTIONAL
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'pin'
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1447:asn1_decode:   called, left=47, depth 2
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'commonObjectAttributes', tag 0x1000010
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'commonObjectAttributes'
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1447:asn1_decode:    called, left=4, depth 3
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'label', tag 0xc, OPTIONAL
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'flags', tag 0x3, OPTIONAL
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:    decoding 'flags'
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'authId', tag 0x4, OPTIONAL
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'userConsent', tag 0x2, OPTIONAL
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'accessControlRules', tag 0x1000010, OPTIONAL
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'classAttributes', tag 0x1000010
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'classAttributes'
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1447:asn1_decode:    called, left=4, depth 3
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'authId', tag 0x4
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:    decoding 'authId'
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'subClassAttributes', tag 0x21000000, OPTIONAL
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'typeAttributes', tag 0x21000001
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'typeAttributes'
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1447:asn1_decode:    called, left=33, depth 3
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'pinAttributes', tag 0x1000010
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:    decoding 'pinAttributes'
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1447:asn1_decode:     called, left=31, depth 4
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'pinFlags', tag 0x3
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:     decoding 'pinFlags'
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'pinType', tag 0xa
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:     decoding 'pinType'
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1287:asn1_decode_entry:     decoding 'pinType' returned 1
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'minLength', tag 0x2
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:     decoding 'minLength'
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1287:asn1_decode_entry:     decoding 'minLength' returned 4
0x801807400 21:12:41.289 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'storedLength', tag 0x2
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:     decoding 'storedLength'
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1287:asn1_decode_entry:     decoding 'storedLength' returned 8
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'maxLength', tag 0x2, OPTIONAL
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:     decoding 'maxLength'
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1287:asn1_decode_entry:     decoding 'maxLength' returned 8
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'pinReference', tag 0x20000000, OPTIONAL
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:     decoding 'pinReference'
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1287:asn1_decode_entry:     decoding 'pinReference' returned 131
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'padChar', tag 0x4, OPTIONAL
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:     decoding 'padChar'
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'lastPinChange', tag 0x18, OPTIONAL
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'path', tag 0x1000010, OPTIONAL
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:     decoding 'path'
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1447:asn1_decode:      called, left=6, depth 5
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'path', tag 0x4, OPTIONAL
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:      decoding 'path'
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'index', tag 0x2, OPTIONAL
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'length', tag 0x20000000, OPTIONAL
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'pathExtended', tag 0x21000001, OPTIONAL
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1519:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.290 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.290 [opensc-pkcs11] pkcs15-pin.c:143:sc_pkcs15_decode_aodf_entry: AuthType: PIN
0x801807400 21:12:41.290 [opensc-pkcs11] pkcs15-pin.c:177:sc_pkcs15_decode_aodf_entry: decoded PIN(ref:83,path:3f005015)
0x801807400 21:12:41.290 [opensc-pkcs11] pkcs15-pin.c:199:sc_pkcs15_decode_aodf_entry: returning with: 0 (Success)
0x801807400 21:12:41.290 [opensc-pkcs11] pkcs15.c:2096:sc_pkcs15_parse_df: returning with: 0 (Success)
0x801807400 21:12:41.290 [opensc-pkcs11] pkcs15.c:1734:sc_pkcs15_find_pin_by_flags: returning with: -1407 (Requested object not found)
0x801807400 21:12:41.290 [opensc-pkcs11] pkcs15.c:1707:sc_pkcs15_find_pin_by_flags: called
0x801807400 21:12:41.290 [opensc-pkcs11] pkcs15.c:1708:sc_pkcs15_find_pin_by_flags: Find PIN flags:0x12, mask:0xD2, index:-1
0x801807400 21:12:41.290 [opensc-pkcs11] pkcs15.c:1731:sc_pkcs15_find_pin_by_flags: returning with: 0 (Success)
0x801807400 21:12:41.290 [opensc-pkcs11] framework-pkcs15.c:1272:pkcs15_create_tokens: Flags:0x8; Auth User/Sign PINs 0x8018d0b00/0x0
0x801807400 21:12:41.290 [opensc-pkcs11] pkcs15.c:2022:sc_pkcs15_parse_df: called; path=3f0050154402, type=0, enum=0
0x801807400 21:12:41.290 [opensc-pkcs11] pkcs15.c:2311:sc_pkcs15_read_file: called
0x801807400 21:12:41.290 [opensc-pkcs11] pkcs15.c:2312:sc_pkcs15_read_file: path=3f0050154402, index=0, count=-1
0x801807400 21:12:41.290 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.290 [opensc-pkcs11] reader-pcsc.c:543:pcsc_lock: called
0x801807400 21:12:41.290 [opensc-pkcs11] card.c:709:sc_select_file: called; type=2, path=3f0050154402
0x801807400 21:12:41.290 [opensc-pkcs11] card-starcos.c:623:starcos_select_file: called
0x801807400 21:12:41.290 [opensc-pkcs11] card-starcos.c:633:starcos_select_file: current path (path, valid): 3f005015 (len: 4)
0x801807400 21:12:41.290 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.290 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.290 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.290 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.290 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:0, data(2) 0x7fffffffd220
0x801807400 21:12:41.290 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.290 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (8 bytes):
00 A4 00 00 02 44 02 00 .....D..
0x801807400 21:12:41.290 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.298 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (11 bytes):
6F 07 80 02 01 00 82 01 01 90 00 o..........
0x801807400 21:12:41.298 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.298 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.298 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.298 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.298 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.298 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.298 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.298 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) 0x0
0x801807400 21:12:41.298 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.298 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 00 01 .....
0x801807400 21:12:41.298 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.308 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (3 bytes):
30 90 00 0..
0x801807400 21:12:41.308 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.308 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.308 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.308 [opensc-pkcs11] card-starcos.c:176:process_fci: processing FCI bytes
0x801807400 21:12:41.308 [opensc-pkcs11] card-starcos.c:198:process_fci:   bytes in file: 256
0x801807400 21:12:41.308 [opensc-pkcs11] card-starcos.c:247:process_fci:   type: working EF
0x801807400 21:12:41.308 [opensc-pkcs11] card-starcos.c:249:process_fci:   EF structure: transparent
0x801807400 21:12:41.308 [opensc-pkcs11] card-starcos.c:611:starcos_select_fid: returning with: 0 (Success)
0x801807400 21:12:41.308 [opensc-pkcs11] card.c:744:sc_select_file: returning with: 0 (Success)
0x801807400 21:12:41.308 [opensc-pkcs11] card.c:530:sc_read_binary: called; 256 bytes at index 0
0x801807400 21:12:41.308 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.308 [opensc-pkcs11] card.c:530:sc_read_binary: called; 128 bytes at index 0
0x801807400 21:12:41.308 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.308 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.308 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.308 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.308 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) 0x0
0x801807400 21:12:41.308 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.308 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 00 80 .....
0x801807400 21:12:41.308 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.332 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (130 bytes):
30 3C 30 15 0C 0B 50 72 69 76 61 74 65 20 4B 65 0<0...Private Ke
79 03 02 06 C0 04 02 38 21 30 11 04 02 93 52 03 y......8!0....R.
03 06 74 40 03 02 03 B8 02 02 00 91 A0 00 A1 0E ..t@............
30 0C 30 06 04 04 3F 00 50 15 02 02 04 00 FF FF 0.0...?.P.......
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
90 00                                           ..
0x801807400 21:12:41.332 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.332 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.332 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.332 [opensc-pkcs11] card-starcos.c:1591:starcos_check_sw: sw1 = 0x90, sw2 = 0x00
0x801807400 21:12:41.332 [opensc-pkcs11] iso7816.c:168:iso7816_read_binary: returning with: 128
0x801807400 21:12:41.332 [opensc-pkcs11] card.c:574:sc_read_binary: returning with: 128
0x801807400 21:12:41.332 [opensc-pkcs11] card.c:530:sc_read_binary: called; 128 bytes at index 128
0x801807400 21:12:41.332 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.332 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.332 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.332 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.332 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:80, data(0) 0x0
0x801807400 21:12:41.332 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.332 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 80 80 .....
0x801807400 21:12:41.332 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.356 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (130 bytes):
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
90 00                                           ..
0x801807400 21:12:41.356 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.356 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.356 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.356 [opensc-pkcs11] card-starcos.c:1591:starcos_check_sw: sw1 = 0x90, sw2 = 0x00
0x801807400 21:12:41.356 [opensc-pkcs11] iso7816.c:168:iso7816_read_binary: returning with: 128
0x801807400 21:12:41.356 [opensc-pkcs11] card.c:574:sc_read_binary: returning with: 128
0x801807400 21:12:41.356 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.356 [opensc-pkcs11] card.c:571:sc_read_binary: returning with: 256
0x801807400 21:12:41.356 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.356 [opensc-pkcs11] reader-pcsc.c:583:pcsc_unlock: called
0x801807400 21:12:41.360 [opensc-pkcs11] pkcs15.c:2404:sc_pkcs15_read_file: returning with: 0 (Success)
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1447:asn1_decode: called, left=256, depth 0, choice
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'privateRSAKey', tag 0x1000010, CHOICE, OPTIONAL
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry: decoding 'privateRSAKey'
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1447:asn1_decode:  called, left=60, depth 1
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'commonObjectAttributes', tag 0x1000010
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'commonObjectAttributes'
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1447:asn1_decode:   called, left=21, depth 2
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'label', tag 0xc, OPTIONAL
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'label'
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'flags', tag 0x3, OPTIONAL
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'flags'
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'authId', tag 0x4, OPTIONAL
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'authId'
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'userConsent', tag 0x2, OPTIONAL
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'accessControlRules', tag 0x1000010, OPTIONAL
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'classAttributes', tag 0x1000010
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'classAttributes'
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1447:asn1_decode:   called, left=17, depth 2
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'iD', tag 0x4
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'iD'
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'usage', tag 0x3
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'usage'
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'native', tag 0x1, OPTIONAL
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'accessFlags', tag 0x3, OPTIONAL
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'accessFlags'
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'keyReference', tag 0x2, OPTIONAL
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'keyReference'
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1287:asn1_decode_entry:   decoding 'keyReference' returned 145
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'algReference', tag 0x21000001, OPTIONAL
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'subClassAttributes', tag 0x21000000, OPTIONAL
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'subClassAttributes'
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1447:asn1_decode:   called, left=0, depth 2
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'typeAttributes', tag 0x21000001
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'typeAttributes'
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1447:asn1_decode:   called, left=14, depth 2
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'privateRSAKeyAttributes', tag 0x1000010
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'privateRSAKeyAttributes'
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1447:asn1_decode:    called, left=12, depth 3
0x801807400 21:12:41.360 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'value', tag 0x1000010
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:    decoding 'value'
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1447:asn1_decode:     called, left=6, depth 4
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'path', tag 0x4, OPTIONAL
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:     decoding 'path'
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'index', tag 0x2, OPTIONAL
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'length', tag 0x20000000, OPTIONAL
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'pathExtended', tag 0x21000001, OPTIONAL
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'modulusLength', tag 0x2
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:    decoding 'modulusLength'
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1287:asn1_decode_entry:    decoding 'modulusLength' returned 1024
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'keyInfo', tag 0x2, OPTIONAL
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1519:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.361 [opensc-pkcs11] pkcs15-prkey.c:300:sc_pkcs15_decode_prkdf_entry: PrivKey path '3f005015'
0x801807400 21:12:41.361 [opensc-pkcs11] pkcs15-prkey.c:342:sc_pkcs15_decode_prkdf_entry: Key Subject 
0x801807400 21:12:41.361 [opensc-pkcs11] pkcs15-prkey.c:343:sc_pkcs15_decode_prkdf_entry: Key path 3f005015
0x801807400 21:12:41.361 [opensc-pkcs11] asn1.c:1447:asn1_decode: called, left=194, depth 0, choice
0x801807400 21:12:41.361 [opensc-pkcs11] pkcs15.c:2096:sc_pkcs15_parse_df: returning with: 0 (Success)
0x801807400 21:12:41.361 [opensc-pkcs11] framework-pkcs15.c:736:pkcs15_create_pkcs11_objects: Found 1 RSA private key
0x801807400 21:12:41.361 [opensc-pkcs11] pkcs15.c:2022:sc_pkcs15_parse_df: called; path=3f0050154403, type=1, enum=0
0x801807400 21:12:41.361 [opensc-pkcs11] pkcs15.c:2311:sc_pkcs15_read_file: called
0x801807400 21:12:41.361 [opensc-pkcs11] pkcs15.c:2312:sc_pkcs15_read_file: path=3f0050154403, index=0, count=-1
0x801807400 21:12:41.361 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.361 [opensc-pkcs11] reader-pcsc.c:543:pcsc_lock: called
0x801807400 21:12:41.361 [opensc-pkcs11] card.c:709:sc_select_file: called; type=2, path=3f0050154403
0x801807400 21:12:41.361 [opensc-pkcs11] card-starcos.c:623:starcos_select_file: called
0x801807400 21:12:41.361 [opensc-pkcs11] card-starcos.c:633:starcos_select_file: current path (path, valid): 3f005015 (len: 4)
0x801807400 21:12:41.361 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.361 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.361 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.361 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.361 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:0, data(2) 0x7fffffffd220
0x801807400 21:12:41.361 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.361 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (8 bytes):
00 A4 00 00 02 44 03 00 .....D..
0x801807400 21:12:41.361 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.369 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (11 bytes):
6F 07 80 02 01 00 82 01 01 90 00 o..........
0x801807400 21:12:41.369 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.369 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.369 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.369 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.369 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.369 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.369 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.369 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) 0x0
0x801807400 21:12:41.369 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.369 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 00 01 .....
0x801807400 21:12:41.369 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.379 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (3 bytes):
30 90 00 0..
0x801807400 21:12:41.379 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.379 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.379 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.379 [opensc-pkcs11] card-starcos.c:176:process_fci: processing FCI bytes
0x801807400 21:12:41.379 [opensc-pkcs11] card-starcos.c:198:process_fci:   bytes in file: 256
0x801807400 21:12:41.379 [opensc-pkcs11] card-starcos.c:247:process_fci:   type: working EF
0x801807400 21:12:41.379 [opensc-pkcs11] card-starcos.c:249:process_fci:   EF structure: transparent
0x801807400 21:12:41.379 [opensc-pkcs11] card-starcos.c:611:starcos_select_fid: returning with: 0 (Success)
0x801807400 21:12:41.379 [opensc-pkcs11] card.c:744:sc_select_file: returning with: 0 (Success)
0x801807400 21:12:41.379 [opensc-pkcs11] card.c:530:sc_read_binary: called; 256 bytes at index 0
0x801807400 21:12:41.379 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.379 [opensc-pkcs11] card.c:530:sc_read_binary: called; 128 bytes at index 0
0x801807400 21:12:41.379 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.379 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.379 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.379 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.379 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) 0x0
0x801807400 21:12:41.379 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.379 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 00 80 .....
0x801807400 21:12:41.379 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.403 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (130 bytes):
30 36 30 10 0C 0A 50 75 62 6C 69 63 20 4B 65 79 060...Public Key
03 02 06 40 30 0E 04 02 93 52 03 02 05 20 01 01 ...@0....R... ..
00 02 01 00 A0 00 A1 10 30 0E 30 08 04 06 3F 00 ........0.0...?.
50 15 30 55 02 02 04 00 FF FF FF FF FF FF FF FF P.0U............
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
90 00                                           ..
0x801807400 21:12:41.403 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.403 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.403 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.403 [opensc-pkcs11] card-starcos.c:1591:starcos_check_sw: sw1 = 0x90, sw2 = 0x00
0x801807400 21:12:41.403 [opensc-pkcs11] iso7816.c:168:iso7816_read_binary: returning with: 128
0x801807400 21:12:41.403 [opensc-pkcs11] card.c:574:sc_read_binary: returning with: 128
0x801807400 21:12:41.403 [opensc-pkcs11] card.c:530:sc_read_binary: called; 128 bytes at index 128
0x801807400 21:12:41.403 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.403 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.403 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.403 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.403 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:80, data(0) 0x0
0x801807400 21:12:41.403 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.403 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 80 80 .....
0x801807400 21:12:41.403 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.427 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (130 bytes):
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF ................
90 00                                           ..
0x801807400 21:12:41.427 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.427 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.427 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.427 [opensc-pkcs11] card-starcos.c:1591:starcos_check_sw: sw1 = 0x90, sw2 = 0x00
0x801807400 21:12:41.427 [opensc-pkcs11] iso7816.c:168:iso7816_read_binary: returning with: 128
0x801807400 21:12:41.427 [opensc-pkcs11] card.c:574:sc_read_binary: returning with: 128
0x801807400 21:12:41.427 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.427 [opensc-pkcs11] card.c:571:sc_read_binary: returning with: 256
0x801807400 21:12:41.427 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.427 [opensc-pkcs11] reader-pcsc.c:583:pcsc_unlock: called
0x801807400 21:12:41.435 [opensc-pkcs11] pkcs15.c:2404:sc_pkcs15_read_file: returning with: 0 (Success)
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1447:asn1_decode: called, left=256, depth 0
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'publicKey', tag 0x0
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1447:asn1_decode:  called, left=256, depth 1, choice
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'publicRSAKey', tag 0x1000010, CHOICE
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'publicRSAKey'
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1447:asn1_decode:   called, left=54, depth 2
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'commonObjectAttributes', tag 0x1000010
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'commonObjectAttributes'
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1447:asn1_decode:    called, left=16, depth 3
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'label', tag 0xc, OPTIONAL
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:    decoding 'label'
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'flags', tag 0x3, OPTIONAL
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:    decoding 'flags'
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'authId', tag 0x4, OPTIONAL
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'userConsent', tag 0x2, OPTIONAL
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'accessControlRules', tag 0x1000010, OPTIONAL
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'classAttributes', tag 0x1000010
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'classAttributes'
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1447:asn1_decode:    called, left=14, depth 3
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'iD', tag 0x4
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:    decoding 'iD'
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'usage', tag 0x3
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:    decoding 'usage'
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'native', tag 0x1, OPTIONAL
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:    decoding 'native'
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'accessFlags', tag 0x3, OPTIONAL
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'keyReference', tag 0x2, OPTIONAL
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:    decoding 'keyReference'
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1287:asn1_decode_entry:    decoding 'keyReference' returned 0
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'subClassAttributes', tag 0x21000000, OPTIONAL
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'subClassAttributes'
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1447:asn1_decode:    called, left=0, depth 3
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'typeAttributes', tag 0x21000001
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:   decoding 'typeAttributes'
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1447:asn1_decode:    called, left=16, depth 3
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'publicRSAKeyAttributes', tag 0x1000010
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:    decoding 'publicRSAKeyAttributes'
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1447:asn1_decode:     called, left=14, depth 4
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'value', tag 0x0
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1447:asn1_decode:      called, left=14, depth 5, choice
0x801807400 21:12:41.435 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'path', tag 0x1000010, CHOICE
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:      decoding 'path'
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1447:asn1_decode:       called, left=8, depth 6
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'path', tag 0x4, OPTIONAL
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:       decoding 'path'
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'index', tag 0x2, OPTIONAL
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'length', tag 0x20000000, OPTIONAL
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'pathExtended', tag 0x21000001, OPTIONAL
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1519:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'modulusLength', tag 0x2
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:     decoding 'modulusLength'
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1287:asn1_decode_entry:     decoding 'modulusLength' returned 1024
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'keyInfo', tag 0x2, OPTIONAL
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1485:asn1_decode: not present
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1519:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.436 [opensc-pkcs11] pkcs15-pubkey.c:343:sc_pkcs15_decode_pukdf_entry: PubKey path '3f0050153055'
0x801807400 21:12:41.436 [opensc-pkcs11] pkcs15-pubkey.c:169:sc_pkcs15_decode_pubkey_direct_value: called
0x801807400 21:12:41.436 [opensc-pkcs11] pkcs15-pubkey.c:171:sc_pkcs15_decode_pubkey_direct_value: returning with: 0 (Success)
0x801807400 21:12:41.436 [opensc-pkcs11] asn1.c:1447:asn1_decode: called, left=200, depth 0
0x801807400 21:12:41.436 [opensc-pkcs11] pkcs15.c:2096:sc_pkcs15_parse_df: returning with: 0 (Success)
0x801807400 21:12:41.436 [opensc-pkcs11] framework-pkcs15.c:736:pkcs15_create_pkcs11_objects: Found 1 RSA public key
0x801807400 21:12:41.436 [opensc-pkcs11] framework-pkcs15.c:623:__pkcs15_create_pubkey_object: __pkcs15_create_pubkey_object() called, pubkey 0x8018d2100, data 0x8018f1200
0x801807400 21:12:41.436 [opensc-pkcs11] framework-pkcs15.c:640:__pkcs15_create_pubkey_object: Get pubkey from PKCS#15 object
0x801807400 21:12:41.436 [opensc-pkcs11] pkcs15-pubkey.c:909:sc_pkcs15_read_pubkey: called
0x801807400 21:12:41.436 [opensc-pkcs11] pkcs15-pubkey.c:910:sc_pkcs15_read_pubkey: Public key type 0x201
0x801807400 21:12:41.436 [opensc-pkcs11] pkcs15-pubkey.c:967:sc_pkcs15_read_pubkey: Read from EF and decode
0x801807400 21:12:41.436 [opensc-pkcs11] pkcs15.c:2311:sc_pkcs15_read_file: called
0x801807400 21:12:41.436 [opensc-pkcs11] pkcs15.c:2312:sc_pkcs15_read_file: path=3f0050153055, index=0, count=-1
0x801807400 21:12:41.436 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.436 [opensc-pkcs11] reader-pcsc.c:543:pcsc_lock: called
0x801807400 21:12:41.436 [opensc-pkcs11] card.c:709:sc_select_file: called; type=2, path=3f0050153055
0x801807400 21:12:41.436 [opensc-pkcs11] card-starcos.c:623:starcos_select_file: called
0x801807400 21:12:41.436 [opensc-pkcs11] card-starcos.c:633:starcos_select_file: current path (path, valid): 3f005015 (len: 4)
0x801807400 21:12:41.436 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.436 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.436 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.436 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.436 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:0, data(2) 0x7fffffffd260
0x801807400 21:12:41.436 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.436 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (8 bytes):
00 A4 00 00 02 30 55 00 .....0U.
0x801807400 21:12:41.436 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.444 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (11 bytes):
6F 07 80 02 00 8C 82 01 01 90 00 o..........
0x801807400 21:12:41.444 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.444 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.444 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.444 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.444 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.444 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.444 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.444 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) 0x0
0x801807400 21:12:41.444 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.444 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 00 01 .....
0x801807400 21:12:41.444 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.452 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (3 bytes):
30 90 00 0..
0x801807400 21:12:41.452 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.452 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.452 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.452 [opensc-pkcs11] card-starcos.c:176:process_fci: processing FCI bytes
0x801807400 21:12:41.452 [opensc-pkcs11] card-starcos.c:198:process_fci:   bytes in file: 140
0x801807400 21:12:41.452 [opensc-pkcs11] card-starcos.c:247:process_fci:   type: working EF
0x801807400 21:12:41.452 [opensc-pkcs11] card-starcos.c:249:process_fci:   EF structure: transparent
0x801807400 21:12:41.452 [opensc-pkcs11] card-starcos.c:611:starcos_select_fid: returning with: 0 (Success)
0x801807400 21:12:41.452 [opensc-pkcs11] card.c:744:sc_select_file: returning with: 0 (Success)
0x801807400 21:12:41.452 [opensc-pkcs11] card.c:530:sc_read_binary: called; 140 bytes at index 0
0x801807400 21:12:41.452 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.452 [opensc-pkcs11] card.c:530:sc_read_binary: called; 128 bytes at index 0
0x801807400 21:12:41.452 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.452 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.452 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.452 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.452 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) 0x0
0x801807400 21:12:41.452 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.452 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 00 80 .....
0x801807400 21:12:41.452 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.474 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (130 bytes):
30 81 89 02 81 81 00 CF D8 AD EC 02 31 96 C6 28 0...........1..(
66 04 5D 66 5B C0 E4 13 DC EE 25 0C 60 A2 B2 59 f.]f[.....%.`..Y
5F 92 8C D7 0C BC 95 BF DD 8B 9B EE 2B 4E 37 B4 _...........+N7.
63 69 43 B5 64 F8 4B 5E 2F B3 D5 8B 38 FB 2A BE ciC.d.K^/...8.*.
E5 A9 BC A1 6E C7 42 8B 2C 5B 56 35 8C 94 82 4C ....n.B.,[V5...L
28 52 78 F3 32 82 85 3D 8F EA C8 E5 5A 83 AC C6 (Rx.2..=....Z...
57 D4 06 C4 98 EC 2E FF 85 17 02 07 5B 6C 95 F9 W...........[l..
47 1D 83 4E 81 A5 FF FA 02 09 43 86 74 D5 F2 F7 G..N......C.t...
90 00                                           ..
0x801807400 21:12:41.474 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.474 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.474 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.474 [opensc-pkcs11] card-starcos.c:1591:starcos_check_sw: sw1 = 0x90, sw2 = 0x00
0x801807400 21:12:41.474 [opensc-pkcs11] iso7816.c:168:iso7816_read_binary: returning with: 128
0x801807400 21:12:41.474 [opensc-pkcs11] card.c:574:sc_read_binary: returning with: 128
0x801807400 21:12:41.474 [opensc-pkcs11] card.c:530:sc_read_binary: called; 12 bytes at index 128
0x801807400 21:12:41.474 [opensc-pkcs11] apdu.c:546:sc_transmit_apdu: called
0x801807400 21:12:41.474 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:41.474 [opensc-pkcs11] apdu.c:513:sc_transmit: called
0x801807400 21:12:41.474 [opensc-pkcs11] apdu.c:367:sc_single_transmit: called
0x801807400 21:12:41.474 [opensc-pkcs11] apdu.c:372:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:80, data(0) 0x0
0x801807400 21:12:41.474 [opensc-pkcs11] reader-pcsc.c:269:pcsc_transmit: reader 'Gemalto PC Twin Reader 00 00'
0x801807400 21:12:41.474 [opensc-pkcs11] reader-pcsc.c:270:pcsc_transmit: 
Outgoing APDU (5 bytes):
00 B0 00 80 0C .....
0x801807400 21:12:41.474 [opensc-pkcs11] reader-pcsc.c:199:pcsc_internal_transmit: called
0x801807400 21:12:41.484 [opensc-pkcs11] reader-pcsc.c:279:pcsc_transmit: 
Incoming APDU (14 bytes):
3F A1 61 AA 00 1A 4B 02 03 01 00 01 90 00 ?.a...K.......
0x801807400 21:12:41.484 [opensc-pkcs11] apdu.c:382:sc_single_transmit: returning with: 0 (Success)
0x801807400 21:12:41.484 [opensc-pkcs11] apdu.c:535:sc_transmit: returning with: 0 (Success)
0x801807400 21:12:41.484 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.484 [opensc-pkcs11] card-starcos.c:1591:starcos_check_sw: sw1 = 0x90, sw2 = 0x00
0x801807400 21:12:41.484 [opensc-pkcs11] iso7816.c:168:iso7816_read_binary: returning with: 12
0x801807400 21:12:41.484 [opensc-pkcs11] card.c:574:sc_read_binary: returning with: 12
0x801807400 21:12:41.484 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.484 [opensc-pkcs11] card.c:571:sc_read_binary: returning with: 140
0x801807400 21:12:41.484 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:41.484 [opensc-pkcs11] reader-pcsc.c:583:pcsc_unlock: called
0x801807400 21:12:41.488 [opensc-pkcs11] pkcs15.c:2404:sc_pkcs15_read_file: returning with: 0 (Success)
0x801807400 21:12:41.488 [opensc-pkcs11] pkcs15-pubkey.c:576:sc_pkcs15_decode_pubkey_rsa: called
0x801807400 21:12:41.488 [opensc-pkcs11] asn1.c:1447:asn1_decode: called, left=140, depth 0
0x801807400 21:12:41.488 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'publicKeyCoefficients', tag 0x1000010
0x801807400 21:12:41.488 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry: decoding 'publicKeyCoefficients'
0x801807400 21:12:41.488 [opensc-pkcs11] asn1.c:1447:asn1_decode:  called, left=137, depth 1
0x801807400 21:12:41.488 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'modulus', tag 0x2
0x801807400 21:12:41.488 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'modulus'
0x801807400 21:12:41.488 [opensc-pkcs11] asn1.c:1471:asn1_decode: Looking for 'exponent', tag 0x2
0x801807400 21:12:41.488 [opensc-pkcs11] asn1.c:1263:asn1_decode_entry:  decoding 'exponent'
0x801807400 21:12:41.488 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.488 [opensc-pkcs11] asn1.c:1520:asn1_decode: returning with: 0 (Success)
0x801807400 21:12:41.488 [opensc-pkcs11] pkcs15-pubkey.c:587:sc_pkcs15_decode_pubkey_rsa: returning with: 0 (Success)
0x801807400 21:12:41.488 [opensc-pkcs11] pkcs15-pubkey.c:988:sc_pkcs15_read_pubkey: returning with: 0 (Success)
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:660:__pkcs15_create_pubkey_object: __pkcs15_create_pubkey_object() returns pubkey object 0x80182e4c0
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:736:pkcs15_create_pkcs11_objects: Found 0 EC private keys
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:736:pkcs15_create_pkcs11_objects: Found 0 EC public keys
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:736:pkcs15_create_pkcs11_objects: Found 0 GOSTR3410 private keys
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:736:pkcs15_create_pkcs11_objects: Found 0 GOSTR3410 public keys
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:736:pkcs15_create_pkcs11_objects: Found 0 certificates
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:736:pkcs15_create_pkcs11_objects: Found 0 data objects
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:846:pkcs15_bind_related_objects: Looking for objects related to object 0
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:751:__pkcs15_prkey_bind_related: Object is a private key and has id 9352
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:776:__pkcs15_prkey_bind_related: Associating object 1 as public key
0x801807400 21:12:41.488 [opensc-pkcs11] pkcs15-pubkey.c:1139:sc_pkcs15_dup_pubkey: returning with: 0 (Success)
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:846:pkcs15_bind_related_objects: Looking for objects related to object 1
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:1073:_pkcs15_create_typed_objects: found 2 FW objects
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:1278:pkcs15_create_tokens: Found 2 FW objects objects
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:1294:pkcs15_create_tokens: Found 1 authentication objects
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:1303:pkcs15_create_tokens: Found authentication object ''
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:1009:pkcs15_create_slot: Create slot (p11card 0x80182f4c0, fw_data 0x801826500, auth 0x8018d0b00, app_info 0x80181c400)
0x801807400 21:12:41.488 [opensc-pkcs11] slot.c:375:slot_allocate: Allocated slot 0x0 for card in reader Gemalto PC Twin Reader 00 00
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:997:pkcs15_init_slot: Initialized token 'OpenSC Card' in slot 0x0
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:1164:_add_pin_related_objects: Add objects related to PIN('',ID:3821)
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:1176:_add_pin_related_objects: ObjID(0x80182e460,Private Key,101):3821
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:1183:_add_pin_related_objects: Slot:0x801825900, obj:0x80182e460  Adding private key 0 to PIN ''
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:903:pkcs15_add_object: Slot:0 Setting object handle of 0x0 to 0x80182e460
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:903:pkcs15_add_object: Slot:0 Setting object handle of 0x0 to 0x80182e4c0
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:1352:pkcs15_create_tokens: Add public objects to slot 0x801825900
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:1220:_add_public_objects: 2 public objects to process
0x801807400 21:12:41.488 [opensc-pkcs11] framework-pkcs15.c:1356:pkcs15_create_tokens: All tokens created
0x801807400 21:12:41.488 [opensc-pkcs11] slot.c:328:card_detect: Gemalto PC Twin Reader 00 00: Detection ended
0x801807400 21:12:41.488 [opensc-pkcs11] slot.c:153:initialize_reader: Reader 'Gemalto PC Twin Reader 00 00' initialized
0x801807400 21:12:41.489 [opensc-pkcs11] pkcs11-global.c:273:C_Initialize: C_Initialize() = CKR_OK
0x801807400 21:12:41.489 [opensc-pkcs11] pkcs11-global.c:391:C_GetSlotList: C_GetSlotList(token=0, plug-n-play)
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:1102:pcsc_detect_readers: called
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:1116:pcsc_detect_readers: Probing PC/SC readers
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:1268:pcsc_detect_readers: returning with: 0 (Success)
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:338:card_detect_all: Detect all cards
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:203:card_detect: Gemalto PC Twin Reader 00 00: Detecting smart card
0x801807400 21:12:41.489 [opensc-pkcs11] sc.c:251:sc_detect_card_presence: called
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:393:pcsc_detect_card_presence: called
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:303:refresh_attributes: Gemalto PC Twin Reader 00 00 check
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:322:refresh_attributes: returning with: 0 (Success)
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:398:pcsc_detect_card_presence: returning with: 1
0x801807400 21:12:41.489 [opensc-pkcs11] sc.c:256:sc_detect_card_presence: returning with: 1
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:328:card_detect: Gemalto PC Twin Reader 00 00: Detection ended
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:357:card_detect_all: All cards detected
0x801807400 21:12:41.489 [opensc-pkcs11] pkcs11-global.c:423:C_GetSlotList: was only a size inquiry (1)
0x801807400 21:12:41.489 [opensc-pkcs11] pkcs11-global.c:391:C_GetSlotList: C_GetSlotList(token=0, refresh)
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:338:card_detect_all: Detect all cards
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:203:card_detect: Gemalto PC Twin Reader 00 00: Detecting smart card
0x801807400 21:12:41.489 [opensc-pkcs11] sc.c:251:sc_detect_card_presence: called
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:393:pcsc_detect_card_presence: called
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:303:refresh_attributes: Gemalto PC Twin Reader 00 00 check
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:322:refresh_attributes: returning with: 0 (Success)
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:398:pcsc_detect_card_presence: returning with: 1
0x801807400 21:12:41.489 [opensc-pkcs11] sc.c:256:sc_detect_card_presence: returning with: 1
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:328:card_detect: Gemalto PC Twin Reader 00 00: Detection ended
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:357:card_detect_all: All cards detected
0x801807400 21:12:41.489 [opensc-pkcs11] pkcs11-global.c:440:C_GetSlotList: returned 1 slots
0x801807400 21:12:41.489 [opensc-pkcs11] pkcs11-global.c:491:C_GetSlotInfo: C_GetSlotInfo(0x0)
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:338:card_detect_all: Detect all cards
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:203:card_detect: Gemalto PC Twin Reader 00 00: Detecting smart card
0x801807400 21:12:41.489 [opensc-pkcs11] sc.c:251:sc_detect_card_presence: called
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:393:pcsc_detect_card_presence: called
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:303:refresh_attributes: Gemalto PC Twin Reader 00 00 check
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:322:refresh_attributes: returning with: 0 (Success)
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:398:pcsc_detect_card_presence: returning with: 1
0x801807400 21:12:41.489 [opensc-pkcs11] sc.c:256:sc_detect_card_presence: returning with: 1
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:328:card_detect: Gemalto PC Twin Reader 00 00: Detection ended
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:357:card_detect_all: All cards detected
0x801807400 21:12:41.489 [opensc-pkcs11] pkcs11-global.c:503:C_GetSlotInfo: C_GetSlotInfo() get slot rv 0
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:203:card_detect: Gemalto PC Twin Reader 00 00: Detecting smart card
0x801807400 21:12:41.489 [opensc-pkcs11] sc.c:251:sc_detect_card_presence: called
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:393:pcsc_detect_card_presence: called
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:303:refresh_attributes: Gemalto PC Twin Reader 00 00 check
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:322:refresh_attributes: returning with: 0 (Success)
0x801807400 21:12:41.489 [opensc-pkcs11] reader-pcsc.c:398:pcsc_detect_card_presence: returning with: 1
0x801807400 21:12:41.489 [opensc-pkcs11] sc.c:256:sc_detect_card_presence: returning with: 1
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:328:card_detect: Gemalto PC Twin Reader 00 00: Detection ended
0x801807400 21:12:41.489 [opensc-pkcs11] pkcs11-global.c:513:C_GetSlotInfo: C_GetSlotInfo() card detect rv 0x0
0x801807400 21:12:41.489 [opensc-pkcs11] pkcs11-global.c:530:C_GetSlotInfo: C_GetSlotInfo() flags 0x7
0x801807400 21:12:41.489 [opensc-pkcs11] pkcs11-global.c:531:C_GetSlotInfo: C_GetSlotInfo(0x0) = CKR_OK
0x801807400 21:12:41.489 [opensc-pkcs11] framework-pkcs15.c:475:C_GetTokenInfo: C_GetTokenInfo(0)
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:397:slot_get_token: Slot(id=0x0): get token
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:415:slot_get_token: Slot-get-token returns OK
0x801807400 21:12:41.489 [opensc-pkcs11] framework-pkcs15.c:492:C_GetTokenInfo: C_GetTokenInfo() auth. object 0x8018d0b00, token-info flags 0x40D
0x801807400 21:12:41.489 [opensc-pkcs11] sec.c:159:sc_pin_cmd: called
0x801807400 21:12:41.489 [opensc-pkcs11] card-starcos.c:1709:starcos_pin_cmd: only supported for STARCOS 3.4 cards
0x801807400 21:12:41.489 [opensc-pkcs11] sec.c:206:sc_pin_cmd: returning with: -1408 (Not supported)
0x801807400 21:12:41.489 [opensc-pkcs11] framework-pkcs15.c:527:C_GetTokenInfo: C_GetTokenInfo(0) returns 0x0
0x801807400 21:12:41.489 [opensc-pkcs11] pkcs11-session.c:57:C_OpenSession: C_OpenSession(0x0)
0x801807400 21:12:41.489 [opensc-pkcs11] slot.c:397:slot_get_token: Slot(id=0x0): get token
0x801807400 21:12:41.490 [opensc-pkcs11] slot.c:415:slot_get_token: Slot-get-token returns OK
0x801807400 21:12:41.490 [opensc-pkcs11] pkcs11-session.c:83:C_OpenSession: C_OpenSession handle: 0x80182e520
0x801807400 21:12:41.490 [opensc-pkcs11] pkcs11-session.c:86:C_OpenSession: C_OpenSession() = CKR_OK
0x801807400 21:12:41.490 [opensc-pkcs11] framework-pkcs15.c:475:C_GetTokenInfo: C_GetTokenInfo(0)
0x801807400 21:12:41.490 [opensc-pkcs11] slot.c:397:slot_get_token: Slot(id=0x0): get token
0x801807400 21:12:41.490 [opensc-pkcs11] slot.c:415:slot_get_token: Slot-get-token returns OK
0x801807400 21:12:41.490 [opensc-pkcs11] framework-pkcs15.c:492:C_GetTokenInfo: C_GetTokenInfo() auth. object 0x8018d0b00, token-info flags 0x40D
0x801807400 21:12:41.490 [opensc-pkcs11] sec.c:159:sc_pin_cmd: called
0x801807400 21:12:41.490 [opensc-pkcs11] card-starcos.c:1709:starcos_pin_cmd: only supported for STARCOS 3.4 cards
0x801807400 21:12:41.490 [opensc-pkcs11] sec.c:206:sc_pin_cmd: returning with: -1408 (Not supported)
0x801807400 21:12:41.490 [opensc-pkcs11] framework-pkcs15.c:527:C_GetTokenInfo: C_GetTokenInfo(0) returns 0x0
0x801807400 21:12:44.062 [opensc-pkcs11] pkcs11-session.c:263:C_Login: C_Login(0x80182e520, 1)
0x801807400 21:12:44.062 [opensc-pkcs11] pkcs11-session.c:285:C_Login: C_Login() slot->login_user 38654705663
0x801807400 21:12:44.062 [opensc-pkcs11] pkcs11-session.c:296:C_Login: C_Login() userType 1
0x801807400 21:12:44.062 [opensc-pkcs11] framework-pkcs15.c:1386:pkcs15_login: pkcs15-login: userType 0x1, PIN length 6
0x801807400 21:12:44.062 [opensc-pkcs11] pkcs15-pin.c:295:sc_pkcs15_verify_pin: called
0x801807400 21:12:44.062 [opensc-pkcs11] pkcs15-pin.c:296:sc_pkcs15_verify_pin: PIN(type:0;method:1;len:)
0x801807400 21:12:44.062 [opensc-pkcs11] card.c:397:sc_lock: called
0x801807400 21:12:44.062 [opensc-pkcs11] reader-pcsc.c:543:pcsc_lock: called
0x801807400 21:12:44.062 [opensc-pkcs11] card.c:709:sc_select_file: called; type=2, path=3f005015
0x801807400 21:12:44.062 [opensc-pkcs11] card-starcos.c:623:starcos_select_file: called
0x801807400 21:12:44.062 [opensc-pkcs11] card-starcos.c:633:starcos_select_file: current path (path, valid): 3f005015 (len: 4)
0x801807400 21:12:44.062 [opensc-pkcs11] card-starcos.c:737:starcos_select_file: cache hit
0x801807400 21:12:44.062 [opensc-pkcs11] card.c:744:sc_select_file: returning with: 0 (Success)
0x801807400 21:12:44.062 [opensc-pkcs11] sec.c:159:sc_pin_cmd: called
0x801807400 21:12:44.062 [opensc-pkcs11] card-starcos.c:1709:starcos_pin_cmd: only supported for STARCOS 3.4 cards
0x801807400 21:12:44.062 [opensc-pkcs11] sec.c:206:sc_pin_cmd: returning with: -1408 (Not supported)
0x801807400 21:12:44.062 [opensc-pkcs11] pkcs15-pin.c:368:sc_pkcs15_verify_pin: PIN cmd result -1408
0x801807400 21:12:44.062 [opensc-pkcs11] card.c:437:sc_unlock: called
0x801807400 21:12:44.062 [opensc-pkcs11] reader-pcsc.c:583:pcsc_unlock: called
0x801807400 21:12:44.065 [opensc-pkcs11] pkcs15-pin.c:373:sc_pkcs15_verify_pin: returning with: -1408 (Not supported)
0x801807400 21:12:44.065 [opensc-pkcs11] framework-pkcs15.c:1490:pkcs15_login: PKCS15 verify PIN returned -1408
0x801807400 21:12:44.065 [opensc-pkcs11] misc.c:61:sc_to_cryptoki_error_common: libopensc return value: -1408 (Not supported)
0x801807400 21:12:44.065 [opensc-pkcs11] pkcs11-session.c:298:C_Login: fLogin() rv 84
0x801807400 21:12:44.065 [opensc-pkcs11] pkcs11-global.c:304:C_Finalize: C_Finalize()
0x801807400 21:12:44.065 [opensc-pkcs11] ctx.c:795:sc_cancel: called
0x801807400 21:12:44.065 [opensc-pkcs11] reader-pcsc.c:633:pcsc_cancel: called
0x801807400 21:12:44.065 [opensc-pkcs11] slot.c:163:card_removed: Gemalto PC Twin Reader 00 00: card removed
0x801807400 21:12:44.065 [opensc-pkcs11] slot.c:425:slot_token_removed: slot_token_removed(0x0)
0x801807400 21:12:44.065 [opensc-pkcs11] pkcs11-session.c:129:sc_pkcs11_close_all_sessions: real C_CloseAllSessions(0x0) 1
0x801807400 21:12:44.065 [opensc-pkcs11] pkcs11-session.c:98:sc_pkcs11_close_session: real C_CloseSession(0x80182e520)
0x801807400 21:12:44.065 [opensc-pkcs11] framework-pkcs15.c:1364:pkcs15_release_token: pkcs15_release_token() not implemented
0x801807400 21:12:44.065 [opensc-pkcs11] slot.c:425:slot_token_removed: slot_token_removed(0x1)
0x801807400 21:12:44.065 [opensc-pkcs11] pkcs11-session.c:129:sc_pkcs11_close_all_sessions: real C_CloseAllSessions(0x1) 0
0x801807400 21:12:44.065 [opensc-pkcs11] slot.c:425:slot_token_removed: slot_token_removed(0x2)
0x801807400 21:12:44.065 [opensc-pkcs11] pkcs11-session.c:129:sc_pkcs11_close_all_sessions: real C_CloseAllSessions(0x2) 0
0x801807400 21:12:44.065 [opensc-pkcs11] slot.c:425:slot_token_removed: slot_token_removed(0x3)
0x801807400 21:12:44.065 [opensc-pkcs11] pkcs11-session.c:129:sc_pkcs11_close_all_sessions: real C_CloseAllSessions(0x3) 0
0x801807400 21:12:44.065 [opensc-pkcs11] pkcs15.c:1261:sc_pkcs15_unbind: called
0x801807400 21:12:44.065 [opensc-pkcs11] pkcs15-pin.c:690:sc_pkcs15_pincache_clear: called
0x801807400 21:12:44.065 [opensc-pkcs11] misc.c:61:sc_to_cryptoki_error_common: libopensc return value: 0 (Success)
0x801807400 21:12:44.065 [opensc-pkcs11] card.c:339:sc_disconnect_card: called
0x801807400 21:12:44.065 [opensc-pkcs11] reader-pcsc.c:529:pcsc_disconnect: called
0x801807400 21:12:44.121 [opensc-pkcs11] card.c:360:sc_disconnect_card: returning with: 0 (Success)
0x801807400 21:12:44.121 [opensc-pkcs11] ctx.c:818:sc_release_context: called
0x801807400 21:12:44.121 [opensc-pkcs11] reader-pcsc.c:788:pcsc_finish: called