Attachment 1273958 Details for Bug 1445430 – pkcs15-init -E output

pkcs15-init -E output

pkcs15 (text/plain), 124.97 KB, created by Roshni on 2017-04-25 16:12:38 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Roshni

Created: 2017-04-25 16:12:38 UTC

Size: 124.97 KB

patch

obsolete

>[root@dhcp129-184 ~]# pkcs15-init -E
>0x7fb9af7b7740 10:07:25.515 [pkcs15-init] ctx.c:790:sc_context_create: ===================================
>0x7fb9af7b7740 10:07:25.515 [pkcs15-init] ctx.c:791:sc_context_create: opensc version: 0.16.0
>0x7fb9af7b7740 10:07:25.515 [pkcs15-init] reader-pcsc.c:754:pcsc_init: PC/SC options: connect_exclusive=0 disconnect_action=1 transaction_end_action=0 reconnect_action=0 enable_pinpad=1 enable_pace=1
>0x7fb9af7b7740 10:07:25.515 [pkcs15-init] reader-pcsc.c:1154:pcsc_detect_readers: called
>0x7fb9af7b7740 10:07:25.515 [pkcs15-init] reader-pcsc.c:1168:pcsc_detect_readers: Probing PC/SC readers
>0x7fb9af7b7740 10:07:25.515 [pkcs15-init] reader-pcsc.c:1196:pcsc_detect_readers: Establish PC/SC context
>0x7fb9af7b7740 10:07:25.516 [pkcs15-init] reader-pcsc.c:1243:pcsc_detect_readers: Found new PC/SC reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.516 [pkcs15-init] reader-pcsc.c:303:refresh_attributes: OMNIKEY AG CardMan 3021 00 00 check
>0x7fb9af7b7740 10:07:25.516 [pkcs15-init] reader-pcsc.c:331:refresh_attributes: current  state: 0x00B30122
>0x7fb9af7b7740 10:07:25.516 [pkcs15-init] reader-pcsc.c:332:refresh_attributes: previous state: 0x00000000
>0x7fb9af7b7740 10:07:25.516 [pkcs15-init] reader-pcsc.c:389:refresh_attributes: card present, changed
>0x7fb9af7b7740 10:07:25.516 [pkcs15-init] reader-pcsc.c:1276:pcsc_detect_readers: Requesting reader features ... 
>0x7fb9af7b7740 10:07:25.526 [pkcs15-init] reader-pcsc.c:1290:pcsc_detect_readers: OMNIKEY AG CardMan 3021 00 00:SCardConnect(SHARED): 0x00000000
>0x7fb9af7b7740 10:07:25.526 [pkcs15-init] reader-pcsc.c:999:detect_reader_features: called
>0x7fb9af7b7740 10:07:25.526 [pkcs15-init] reader-pcsc.c:1020:detect_reader_features: Reader feature 0a found
>0x7fb9af7b7740 10:07:25.526 [pkcs15-init] reader-pcsc.c:1020:detect_reader_features: Reader feature 12 found
>0x7fb9af7b7740 10:07:25.526 [pkcs15-init] reader-pcsc.c:1087:detect_reader_features: Reader does not have a display.
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:940:part10_detect_max_data: get dwMaxAPDUDataSize property returned 65536
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:979:part10_get_vendor_product: id_vendor=076b id_product=3021
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:1311:pcsc_detect_readers: reader's max-send-size: 65536, max-recv-size: 65536
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:1337:pcsc_detect_readers: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] sc.c:271:sc_detect_card_presence: called
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:397:pcsc_detect_card_presence: called
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:303:refresh_attributes: OMNIKEY AG CardMan 3021 00 00 check
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:323:refresh_attributes: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:402:pcsc_detect_card_presence: returning with: 5
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] sc.c:276:sc_detect_card_presence: returning with: 5
>Using reader with a card: OMNIKEY AG CardMan 3021 00 00
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] sc.c:271:sc_detect_card_presence: called
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:397:pcsc_detect_card_presence: called
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:303:refresh_attributes: OMNIKEY AG CardMan 3021 00 00 check
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:323:refresh_attributes: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:402:pcsc_detect_card_presence: returning with: 5
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] sc.c:276:sc_detect_card_presence: returning with: 5
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:192:sc_connect_card: called
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:509:pcsc_connect: called
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:303:refresh_attributes: OMNIKEY AG CardMan 3021 00 00 check
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:323:refresh_attributes: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:538:pcsc_connect: Initial protocol: T=1
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:989:match_atr_table: ATR     : 3b:d6:18:00:81:b1:80:7d:1f:03:80:51:00:61:10:30:8f
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:DD:18:00:81:31:FE:45:80:F9:A0:00:00:00:77:01:00:70:0A:90:00:8B
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:989:match_atr_table: ATR     : 3b:d6:18:00:81:b1:80:7d:1f:03:80:51:00:61:10:30:8f
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:7F:96:00:00:00:31:B9:64:40:70:14:10:73:94:01:80:82:90:00
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:7F:96:00:00:00:31:B8:64:40:70:14:10:73:94:01:80:82:90:00
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:DF:18:FF:81:91:FE:1F:C3:00:31:B8:64:0C:01:EC:C1:73:94:01:80:82:90:00:B3
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:DC:18:FF:81:91:FE:1F:C3:80:73:C8:21:13:66:01:0B:03:52:00:05:38
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:989:match_atr_table: ATR     : 3b:d6:18:00:81:b1:80:7d:1f:03:80:51:00:61:10:30:8f
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:FE:18:00:00:81:31:FE:45:80:31:81:54:48:53:4D:31:73:80:21:40:81:07:FA
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:8E:80:01:80:31:81:54:48:53:4D:31:73:80:21:40:81:07:18
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:989:match_atr_table: ATR     : 3b:d6:18:00:81:b1:80:7d:1f:03:80:51:00:61:10:30:8f
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3b:5e:11:ff:45:73:74:45:49:44:20:76:65:72:20:31:2e:30
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3b:de:18:ff:c0:80:b1:fe:45:1f:03:45:73:74:45:49:44:20:76:65:72:20:31:2e:30:2b
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3b:6e:00:00:45:73:74:45:49:44:20:76:65:72:20:31:2e:30
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>FF CA 00 00 00 .....
>0x7fb9af7b7740 10:07:25.527 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (2 bytes):
>6E 00 n.
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] reader-pcsc.c:497:initialize_uid: unable to get UID
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:214:sc_connect_card: matching configured ATRs
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:223:sc_connect_card: trying driver 'authentic'
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:989:match_atr_table: ATR     : 3b:d6:18:00:81:b1:80:7d:1f:03:80:51:00:61:10:30:8f
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:DD:18:00:81:31:FE:45:80:F9:A0:00:00:00:77:01:00:70:0A:90:00:8B
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:223:sc_connect_card: trying driver 'iasecc'
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:989:match_atr_table: ATR     : 3b:d6:18:00:81:b1:80:7d:1f:03:80:51:00:61:10:30:8f
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:7F:96:00:00:00:31:B9:64:40:70:14:10:73:94:01:80:82:90:00
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:7F:96:00:00:00:31:B8:64:40:70:14:10:73:94:01:80:82:90:00
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:DF:18:FF:81:91:FE:1F:C3:00:31:B8:64:0C:01:EC:C1:73:94:01:80:82:90:00:B3
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:DC:18:FF:81:91:FE:1F:C3:80:73:C8:21:13:66:01:0B:03:52:00:05:38
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:223:sc_connect_card: trying driver 'sc-hsm'
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:989:match_atr_table: ATR     : 3b:d6:18:00:81:b1:80:7d:1f:03:80:51:00:61:10:30:8f
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:FE:18:00:00:81:31:FE:45:80:31:81:54:48:53:4D:31:73:80:21:40:81:07:FA
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:8E:80:01:80:31:81:54:48:53:4D:31:73:80:21:40:81:07:18
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:257:sc_connect_card: matching built-in ATRs
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:262:sc_connect_card: trying driver 'cardos'
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:989:match_atr_table: ATR     : 3b:d6:18:00:81:b1:80:7d:1f:03:80:51:00:61:10:30:8f
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3b:e2:00:ff:c1:10:31:fe:55:c8:02:9c
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3b:f4:98:00:ff:c1:10:31:fe:55:4d:34:63:76:b4
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3b:f2:18:00:ff:c1:0a:31:fe:55:c8:06:8a
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3b:d2:18:02:c1:0a:31:fe:58:c8:0d:51
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3b:d2:18:00:81:31:fe:58:c9:01:14
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3b:d2:18:00:81:31:fe:58:c9:03:16
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:262:sc_connect_card: trying driver 'flex'
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:989:match_atr_table: ATR     : 3b:d6:18:00:81:b1:80:7d:1f:03:80:51:00:61:10:30:8f
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3b:95:15:40:20:68:01:02:00:00
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.629 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:15:40:FF:68:01:02:02:01
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:15:40:FF:68:01:02:02:04
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:85:40:20:68:01:01:05:01
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:94:40:FF:63:01:01:02:01
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:15:40:FF:63:01:01:02:01
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:64:02:01:01:02
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:62:01:01:00:00
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:62:01:02:01:04
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:62:04:01:01:05
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3b:95:15:40:ff:68:01:02:45:47
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:E2:00:00:40:20:49:06
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:E2:00:00:40:20:49:05
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:E2:00:00:40:20:49:07
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:85:40:20:68:01:01:03:05
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:02:14:50
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:19:14:55:90:01:02:01:00:05:04:B0
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:32:15:00:06:80
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:32:15:00:06:95
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:19:14:59:01:01:0F:01:00:05:08:B0
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:19:14:55:90:01:01:01:00:05:08:B0
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:16:94:81:10:06:01:81:3F
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:16:94:81:10:06:01:81:2F
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:262:sc_connect_card: trying driver 'cyberflex'
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:989:match_atr_table: ATR     : 3b:d6:18:00:81:b1:80:7d:1f:03:80:51:00:61:10:30:8f
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3b:95:15:40:20:68:01:02:00:00
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:15:40:FF:68:01:02:02:01
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:15:40:FF:68:01:02:02:04
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:85:40:20:68:01:01:05:01
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:94:40:FF:63:01:01:02:01
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:15:40:FF:63:01:01:02:01
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:64:02:01:01:02
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:62:01:01:00:00
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:62:01:02:01:04
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:95:18:40:FF:62:04:01:01:05
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3b:95:15:40:ff:68:01:02:45:47
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:E2:00:00:40:20:49:06
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:E2:00:00:40:20:49:05
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:E2:00:00:40:20:49:07
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:85:40:20:68:01:01:03:05
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:02:14:50
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:19:14:55:90:01:02:01:00:05:04:B0
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:32:15:00:06:80
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:32:15:00:06:95
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:19:14:59:01:01:0F:01:00:05:08:B0
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:19:14:55:90:01:01:01:00:05:08:B0
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:16:94:81:10:06:01:81:3F
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:16:94:81:10:06:01:81:2F
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:262:sc_connect_card: trying driver 'gpk'
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:989:match_atr_table: ATR     : 3b:d6:18:00:81:b1:80:7d:1f:03:80:51:00:61:10:30:8f
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:27:00:80:65:A2:04:01:01:37
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:27:00:80:65:A2:05:01:01:37
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:27:00:80:65:A2:0C:01:01:37
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:A7:00:40:14:80:65:A2:14:01:01:37
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:A7:00:40:18:80:65:A2:08:01:01:52
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:A7:00:40:18:80:65:A2:09:01:01:52
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:A7:00:40:18:80:65:A2:09:01:02:52
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:A7:00:40:18:80:65:A2:09:01:03:52
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:262:sc_connect_card: trying driver 'gemsafeV1'
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:989:match_atr_table: ATR     : 3b:d6:18:00:81:b1:80:7d:1f:03:80:51:00:61:10:30:8f
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:7B:94:00:00:80:65:B0:83:01:01:74:83:00:90:00
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:6B:00:00:80:65:B0:83:01:01:74:83:00:90:00
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:6B:00:00:80:65:B0:83:01:03:74:83:00:90:00
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:7A:94:00:00:80:65:A2:01:01:01:3D:72:D6:43
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:7D:95:00:00:80:31:80:65:B0:83:11:C0:A9:83:00
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.630 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:1000:match_atr_table: ATR try : 3B:7D:95:00:00:80:31:80:65:B0:83:11:00:C8:83:00
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:262:sc_connect_card: trying driver 'miocos'
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:989:match_atr_table: ATR     : 3b:d6:18:00:81:b1:80:7d:1f:03:80:51:00:61:10:30:8f
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:1003:match_atr_table: ignored - wrong length
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:262:sc_connect_card: trying driver 'asepcos'
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:989:match_atr_table: ATR     : 3b:d6:18:00:81:b1:80:7d:1f:03:80:51:00:61:10:30:8f
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] 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
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:276:sc_connect_card: matched: Athena ASEPCOS
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:304:sc_connect_card: card info name:'Athena ASEPCOS', type:17001, flags:0x0, max_send/recv_size:65535/65536
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:1341:sc_card_sm_check: called
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:1342:sc_card_sm_check: card->sm_ctx.ops.open (nil)
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:1347:sc_card_sm_check: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:316:sc_connect_card: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] pkcs15-lib.c:304:sc_pkcs15init_bind: called
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:867:sc_card_ctl: called
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:874:sc_card_ctl: card_ctl(4) not supported
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:709:sc_select_file: called; type=2, path=3f0050154946
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card-asepcos.c:270:asepcos_select_file: called
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] reader-pcsc.c:582:pcsc_lock: called
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:CA, P1:1, P2:83, data(0) (nil)
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 CA 01 83 00 .....
>0x7fb9af7b7740 10:07:25.631 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.634 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (6 bytes):
>8B 02 3F 00 90 00 ..?...
>0x7fb9af7b7740 10:07:25.634 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.634 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.634 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.634 [pkcs15-init] reader-pcsc.c:627:pcsc_unlock: called
>0x7fb9af7b7740 10:07:25.636 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.637 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.637 [pkcs15-init] reader-pcsc.c:582:pcsc_lock: called
>0x7fb9af7b7740 10:07:25.637 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.637 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.637 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.637 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:A4, P1:8, P2:0, data(4) 0x7ffd28be5d90
>0x7fb9af7b7740 10:07:25.637 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.637 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (10 bytes):
>00 A4 08 00 04 50 15 49 46 00 .....P.IF.
>0x7fb9af7b7740 10:07:25.637 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.648 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (53 bytes):
>6F 31 80 02 00 80 81 02 00 9C 82 01 00 83 02 49 o1.............I
>46 88 00 A5 02 50 32 8A 01 05 86 81 16 80 01 01 F....P2.........
>90 00 80 01 78 97 00 80 01 02 A0 01 02 80 01 04 ....x...........
>A0 01 02 90 00                                  .....
>0x7fb9af7b7740 10:07:25.648 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.648 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.648 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.648 [pkcs15-init] reader-pcsc.c:627:pcsc_unlock: called
>0x7fb9af7b7740 10:07:25.657 [pkcs15-init] iso7816.c:338:iso7816_process_fci: processing FCI bytes
>0x7fb9af7b7740 10:07:25.657 [pkcs15-init] iso7816.c:342:iso7816_process_fci:   file identifier: 0x4946
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] iso7816.c:362:iso7816_process_fci:   bytes in file: 128
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] iso7816.c:373:iso7816_process_fci:   shareable: no
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] iso7816.c:392:iso7816_process_fci:   type: working EF
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] iso7816.c:393:iso7816_process_fci:   EF structure: 0
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] iso7816.c:394:iso7816_process_fci:   tag 0x82: 0x00
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] card-asepcos.c:316:asepcos_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] card.c:744:sc_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] card.c:538:sc_read_binary: called; 128 bytes at index 0
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] reader-pcsc.c:582:pcsc_lock: called
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) (nil)
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 B0 00 00 80 .....
>0x7fb9af7b7740 10:07:25.658 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.680 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (130 bytes):
>01 06 70 6B 63 73 31 35 00 00 00 00 00 00 00 00 ..pkcs15........
>00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
>00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
>00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
>00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
>00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
>00 00 00 00 00 00 00 00 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                                           ..
>0x7fb9af7b7740 10:07:25.680 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.680 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.680 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.680 [pkcs15-init] reader-pcsc.c:627:pcsc_unlock: called
>0x7fb9af7b7740 10:07:25.688 [pkcs15-init] iso7816.c:168:iso7816_read_binary: returning with: 128
>0x7fb9af7b7740 10:07:25.688 [pkcs15-init] card.c:578:sc_read_binary: returning with: 128
>0x7fb9af7b7740 10:07:25.688 [pkcs15-init] profile.c:336:sc_profile_load: called
>0x7fb9af7b7740 10:07:25.688 [pkcs15-init] profile.c:355:sc_profile_load: Using profile directory '/usr/share/opensc'.
>0x7fb9af7b7740 10:07:25.688 [pkcs15-init] profile.c:363:sc_profile_load: Trying profile file /usr/share/opensc/pkcs15.profile
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] profile.c:368:sc_profile_load: profile /usr/share/opensc/pkcs15.profile loaded ok
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] profile.c:382:sc_profile_load: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] profile.c:336:sc_profile_load: called
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] profile.c:355:sc_profile_load: Using profile directory '/usr/share/opensc'.
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] profile.c:363:sc_profile_load: Trying profile file /usr/share/opensc/asepcos.profile
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] profile.c:368:sc_profile_load: profile /usr/share/opensc/asepcos.profile loaded ok
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] profile.c:382:sc_profile_load: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] profile.c:394:sc_profile_finish: called
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] profile.c:437:sc_profile_finish: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] pkcs15-lib.c:411:sc_pkcs15init_bind: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] reader-pcsc.c:582:pcsc_lock: called
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] pkcs15-lib.c:502:sc_pkcs15init_erase_card: called
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] pkcs15.c:1189:sc_pkcs15_bind: called
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] pkcs15.c:1190:sc_pkcs15_bind: application(aid:'empty')
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] pkcs15.c:1214:sc_pkcs15_bind: PKCS#15 options: use_file_cache=0 use_pin_cache=1 pin_cache_counter=10 pin_cache_ignore_user_consent=0
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] pkcs15.c:1225:sc_pkcs15_bind: PKCS#15 emulation enabled
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] pkcs15.c:969:sc_pkcs15_bind_internal: called
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] dir.c:163:sc_enum_apps: called
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] card.c:709:sc_select_file: called; type=2, path=3f002f00
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] card-asepcos.c:270:asepcos_select_file: called
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:CA, P1:1, P2:83, data(0) (nil)
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 CA 01 83 00 .....
>0x7fb9af7b7740 10:07:25.689 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.693 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (10 bytes):
>8B 02 3F 00 8B 02 50 15 90 00 ..?...P...
>0x7fb9af7b7740 10:07:25.693 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.693 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.693 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.693 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.693 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.693 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.693 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.693 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.693 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:A4, P1:8, P2:0, data(2) 0x7ffd28be66a2
>0x7fb9af7b7740 10:07:25.693 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.693 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (8 bytes):
>00 A4 08 00 02 2F 00 00 ...../..
>0x7fb9af7b7740 10:07:25.693 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (2 bytes):
>6A 82 j.
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] iso7816.c:121:iso7816_check_sw: File not found
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] iso7816.c:555:iso7816_select_file: returning with: -1201 (File not found)
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] card-asepcos.c:316:asepcos_select_file: returning with: -1201 (File not found)
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] card.c:731:sc_select_file: 'SELECT' error: -1201 (File not found)
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] dir.c:171:sc_enum_apps: Cannot select EF.DIR file: -1201 (File not found)
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] pkcs15.c:974:sc_pkcs15_bind_internal: unable to enumerate apps: File not found
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] pkcs15.c:1005:sc_pkcs15_bind_internal: application path '3f005015'
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] card.c:709:sc_select_file: called; type=2, path=3f005015
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] card-asepcos.c:270:asepcos_select_file: called
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.697 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:CA, P1:1, P2:83, data(0) (nil)
>0x7fb9af7b7740 10:07:25.698 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.698 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 CA 01 83 00 .....
>0x7fb9af7b7740 10:07:25.698 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.701 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (6 bytes):
>8B 02 3F 00 90 00 ..?...
>0x7fb9af7b7740 10:07:25.701 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.701 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.701 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.701 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.701 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.701 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.701 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.701 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.701 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:C, data(2) 0x7ffd28be6880
>0x7fb9af7b7740 10:07:25.701 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.701 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (7 bytes):
>00 A4 00 0C 02 50 15 .....P.
>0x7fb9af7b7740 10:07:25.701 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (2 bytes):
>90 00 ..
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] iso7816.c:550:iso7816_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] card-asepcos.c:316:asepcos_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] card.c:744:sc_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] pkcs15.c:1031:sc_pkcs15_bind_internal: absolute path to EF(ODF) 3f0050155031
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] card.c:709:sc_select_file: called; type=2, path=3f0050155031
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] card-asepcos.c:270:asepcos_select_file: called
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:CA, P1:1, P2:83, data(0) (nil)
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 CA 01 83 00 .....
>0x7fb9af7b7740 10:07:25.705 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.709 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (10 bytes):
>8B 02 3F 00 8B 02 50 15 90 00 ..?...P...
>0x7fb9af7b7740 10:07:25.709 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.709 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.709 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.709 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.709 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.709 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.709 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.709 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.709 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:0, data(2) 0x7ffd28be6880
>0x7fb9af7b7740 10:07:25.709 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.709 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (8 bytes):
>00 A4 00 00 02 50 31 00 .....P1.
>0x7fb9af7b7740 10:07:25.709 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.718 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (41 bytes):
>6F 25 80 02 01 00 81 02 01 1C 82 01 00 83 02 50 o%.............P
>31 88 00 A5 02 44 01 8A 01 05 86 81 0A 80 01 07 1....D..........
>90 00 80 01 78 97 00 90 00                      ....x....
>0x7fb9af7b7740 10:07:25.718 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.718 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.718 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.718 [pkcs15-init] iso7816.c:338:iso7816_process_fci: processing FCI bytes
>0x7fb9af7b7740 10:07:25.718 [pkcs15-init] iso7816.c:342:iso7816_process_fci:   file identifier: 0x5031
>0x7fb9af7b7740 10:07:25.718 [pkcs15-init] iso7816.c:362:iso7816_process_fci:   bytes in file: 256
>0x7fb9af7b7740 10:07:25.718 [pkcs15-init] iso7816.c:373:iso7816_process_fci:   shareable: no
>0x7fb9af7b7740 10:07:25.718 [pkcs15-init] iso7816.c:392:iso7816_process_fci:   type: working EF
>0x7fb9af7b7740 10:07:25.718 [pkcs15-init] iso7816.c:393:iso7816_process_fci:   EF structure: 0
>0x7fb9af7b7740 10:07:25.718 [pkcs15-init] iso7816.c:394:iso7816_process_fci:   tag 0x82: 0x00
>0x7fb9af7b7740 10:07:25.718 [pkcs15-init] card-asepcos.c:316:asepcos_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.718 [pkcs15-init] card.c:744:sc_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.719 [pkcs15-init] card.c:538:sc_read_binary: called; 256 bytes at index 0
>0x7fb9af7b7740 10:07:25.719 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.719 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.719 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.719 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.719 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.719 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) (nil)
>0x7fb9af7b7740 10:07:25.719 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.719 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 B0 00 00 00 .....
>0x7fb9af7b7740 10:07:25.719 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.759 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (258 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 A4 0A 30 08 04 06 3F 00 50 15 44 04 P.D...0...?.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 ................
>00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
>00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
>00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
>00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
>00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
>00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
>00 00 00 00 00 00 00 00 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                                           ..
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] iso7816.c:168:iso7816_read_binary: returning with: 256
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] card.c:578:sc_read_binary: returning with: 256
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1450:asn1_decode: called, left=256, depth 0, choice
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'privateKeys', tag 0x21000000, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'privateKeys' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'publicKeys', tag 0x21000001, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'publicKeys' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'trustedPublicKeys', tag 0x21000002, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'trustedPublicKeys' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'secretKeys', tag 0x21000003, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'secretKeys' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'certificates', tag 0x21000004, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'certificates' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'trustedCertificates', tag 0x21000005, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'trustedCertificates' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'usefulCertificates', tag 0x21000006, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'usefulCertificates' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'dataObjects', tag 0x21000007, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'dataObjects' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'authObjects', tag 0x21000008, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1266:asn1_decode_entry: decoding 'authObjects', raw data:300804063F0050154401
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1450:asn1_decode:  called, left=10, depth 1
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'path', tag 0x1000010
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1266:asn1_decode_entry:  decoding 'path', raw data:04063F0050154401
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1450:asn1_decode:   called, left=8, depth 2
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'path', tag 0x4, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1266:asn1_decode_entry:   decoding 'path', raw data:3F0050154401
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'index', tag 0x2, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'index' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'length', tag 0x20000000, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'length' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pathExtended', tag 0x21000001, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'pathExtended' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1522:asn1_decode: returning with: 8
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1450:asn1_decode: called, left=244, depth 0, choice
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'privateKeys', tag 0x21000000, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1266:asn1_decode_entry: decoding 'privateKeys', raw data:300804063F0050154402
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1450:asn1_decode:  called, left=10, depth 1
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'path', tag 0x1000010
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1266:asn1_decode_entry:  decoding 'path', raw data:04063F0050154402
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1450:asn1_decode:   called, left=8, depth 2
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'path', tag 0x4, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1266:asn1_decode_entry:   decoding 'path', raw data:3F0050154402
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'index', tag 0x2, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'index' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'length', tag 0x20000000, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'length' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pathExtended', tag 0x21000001, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'pathExtended' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1522:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1450:asn1_decode: called, left=232, depth 0, choice
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'privateKeys', tag 0x21000000, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'privateKeys' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'publicKeys', tag 0x21000001, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1266:asn1_decode_entry: decoding 'publicKeys', raw data:300804063F0050154403
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1450:asn1_decode:  called, left=10, depth 1
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'path', tag 0x1000010
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1266:asn1_decode_entry:  decoding 'path', raw data:04063F0050154403
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1450:asn1_decode:   called, left=8, depth 2
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'path', tag 0x4, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1266:asn1_decode_entry:   decoding 'path', raw data:3F0050154403
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'index', tag 0x2, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'index' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'length', tag 0x20000000, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'length' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pathExtended', tag 0x21000001, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'pathExtended' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1522:asn1_decode: returning with: 1
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1450:asn1_decode: called, left=220, depth 0, choice
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'privateKeys', tag 0x21000000, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'privateKeys' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'publicKeys', tag 0x21000001, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'publicKeys' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'trustedPublicKeys', tag 0x21000002, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'trustedPublicKeys' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'secretKeys', tag 0x21000003, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'secretKeys' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'certificates', tag 0x21000004, CHOICE
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1266:asn1_decode_entry: decoding 'certificates', raw data:300804063F0050154404
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1450:asn1_decode:  called, left=10, depth 1
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'path', tag 0x1000010
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1266:asn1_decode_entry:  decoding 'path', raw data:04063F0050154404
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1450:asn1_decode:   called, left=8, depth 2
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'path', tag 0x4, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1266:asn1_decode_entry:   decoding 'path', raw data:3F0050154404
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'index', tag 0x2, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'index' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'length', tag 0x20000000, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'length' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pathExtended', tag 0x21000001, OPTIONAL
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1488:asn1_decode: 'pathExtended' not present
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1522:asn1_decode: returning with: 4
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] asn1.c:1450:asn1_decode: called, left=208, depth 0, choice
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] pkcs15.c:1086:sc_pkcs15_bind_internal: The following DFs were found:
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] pkcs15.c:1089:sc_pkcs15_bind_internal:   DF type 8, path 3f0050154401, index 0, count -1
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] pkcs15.c:1089:sc_pkcs15_bind_internal:   DF type 0, path 3f0050154402, index 0, count -1
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] pkcs15.c:1089:sc_pkcs15_bind_internal:   DF type 1, path 3f0050154403, index 0, count -1
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] pkcs15.c:1089:sc_pkcs15_bind_internal:   DF type 4, path 3f0050154404, index 0, count -1
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] pkcs15.c:1098:sc_pkcs15_bind_internal: absolute path to EF(TokenInfo) 3f0050155032
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] card.c:709:sc_select_file: called; type=2, path=3f0050155032
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] card-asepcos.c:270:asepcos_select_file: called
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.760 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:CA, P1:1, P2:83, data(0) (nil)
>0x7fb9af7b7740 10:07:25.761 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.761 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 CA 01 83 00 .....
>0x7fb9af7b7740 10:07:25.761 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.764 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (10 bytes):
>8B 02 3F 00 8B 02 50 15 90 00 ..?...P...
>0x7fb9af7b7740 10:07:25.764 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.764 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.764 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.764 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.764 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.764 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.764 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.764 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.764 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:0, data(2) 0x7ffd28be6880
>0x7fb9af7b7740 10:07:25.764 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.764 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (8 bytes):
>00 A4 00 00 02 50 32 00 .....P2.
>0x7fb9af7b7740 10:07:25.765 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (41 bytes):
>6F 25 80 02 00 43 81 02 00 5F 82 01 00 83 02 50 o%...C..._.....P
>32 88 00 A5 02 50 31 8A 01 05 86 81 0A 80 01 07 2....P1.........
>90 00 80 01 78 97 00 90 00                      ....x....
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] iso7816.c:338:iso7816_process_fci: processing FCI bytes
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] iso7816.c:342:iso7816_process_fci:   file identifier: 0x5032
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] iso7816.c:362:iso7816_process_fci:   bytes in file: 67
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] iso7816.c:373:iso7816_process_fci:   shareable: no
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] iso7816.c:392:iso7816_process_fci:   type: working EF
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] iso7816.c:393:iso7816_process_fci:   EF structure: 0
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] iso7816.c:394:iso7816_process_fci:   tag 0x82: 0x00
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] card-asepcos.c:316:asepcos_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] card.c:744:sc_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] card.c:538:sc_read_binary: called; 67 bytes at index 0
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) (nil)
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 B0 00 00 43 ....C
>0x7fb9af7b7740 10:07:25.774 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (69 bytes):
>30 41 02 01 00 04 08 0C 0A 54 80 21 22 02 24 0C 0A.......T.!".$.
>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....
>A5 11 18 0F 32 30 31 37 30 34 32 35 30 32 32 33 ....201704250223
>33 33 5A 90 00                                  33Z..
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] iso7816.c:168:iso7816_read_binary: returning with: 67
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] card.c:578:sc_read_binary: returning with: 67
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1450:asn1_decode: called, left=67, depth 0
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'TokenInfo', tag 0x1000010
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1266:asn1_decode_entry: decoding 'TokenInfo', raw data:02010004080C0A5480212202240C0E4F...
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1450:asn1_decode:  called, left=65, depth 1
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'version', tag 0x2
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1266:asn1_decode_entry:  decoding 'version', raw data:00
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1290:asn1_decode_entry:  decoding 'version' returned 0
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'serialNumber', tag 0x4, OPTIONAL
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1266:asn1_decode_entry:  decoding 'serialNumber', raw data:0C0A548021220224
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'manufacturerID', tag 0xc, OPTIONAL
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1266:asn1_decode_entry:  decoding 'manufacturerID', raw data:4F70656E53432050726F6A656374
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'label', tag 0x20000000, OPTIONAL
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1266:asn1_decode_entry:  decoding 'label', raw data:4F70656E53432043617264
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'label-tw', tag 0x21000000, OPTIONAL
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1488:asn1_decode: 'label-tw' not present
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'tokenflags', tag 0x3
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1266:asn1_decode_entry:  decoding 'tokenflags', raw data:0410
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'seInfo', tag 0x1000010, OPTIONAL
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1488:asn1_decode: 'seInfo' not present
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'recordInfo', tag 0x21000001, OPTIONAL
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1488:asn1_decode: 'recordInfo' not present
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'supportedAlgorithms', tag 0x21000002, OPTIONAL
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1488:asn1_decode: 'supportedAlgorithms' not present
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'issuerId', tag 0x20000003, OPTIONAL
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1488:asn1_decode: 'issuerId' not present
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'holderId', tag 0x20000004, OPTIONAL
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1488:asn1_decode: 'holderId' not present
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'lastUpdate', tag 0x21000005, OPTIONAL
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1266:asn1_decode_entry:  decoding 'lastUpdate', raw data:180F3230313730343235303232333333...
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1450:asn1_decode:   called, left=17, depth 2
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'generalizedTime', tag 0x18, OPTIONAL
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1266:asn1_decode_entry:   decoding 'generalizedTime', raw data:32303137303432353032323333335A
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'referencedTime', tag 0x1000010, OPTIONAL
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1488:asn1_decode: 'referencedTime' not present
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'preferredLanguage', tag 0x13, OPTIONAL
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1488:asn1_decode: 'preferredLanguage' not present
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'profileIndication', tag 0x21000006, OPTIONAL
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1488:asn1_decode: 'profileIndication' not present
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] pkcs15.c:206:sc_pkcs15_parse_tokeninfo: TokenInfo.serialNunmber '0C0A548021220224'
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] pkcs15.c:228:sc_pkcs15_parse_tokeninfo: LastUpdate.generalizedTime present
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] pkcs15.c:257:sc_pkcs15_parse_tokeninfo: LastUpdate.path ''
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] pkcs15.c:258:sc_pkcs15_parse_tokeninfo: ProfileIndication.name '(null)'
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] pkcs15.c:1176:sc_pkcs15_bind_internal: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] pkcs15.c:1253:sc_pkcs15_bind: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] card.c:709:sc_select_file: called; type=2, path=3f000001
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] card-asepcos.c:270:asepcos_select_file: called
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:CA, P1:1, P2:83, data(0) (nil)
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 CA 01 83 00 .....
>0x7fb9af7b7740 10:07:25.787 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.791 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (10 bytes):
>8B 02 3F 00 8B 02 50 15 90 00 ..?...P...
>0x7fb9af7b7740 10:07:25.791 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.791 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.791 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.791 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.791 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.791 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.791 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.791 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.791 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:A4, P1:8, P2:C, data(2) 0x7ffd28be6cd2
>0x7fb9af7b7740 10:07:25.791 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.791 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (7 bytes):
>00 A4 08 0C 02 00 01 .......
>0x7fb9af7b7740 10:07:25.791 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.795 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (2 bytes):
>90 00 ..
>0x7fb9af7b7740 10:07:25.795 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.795 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.795 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.795 [pkcs15-init] iso7816.c:550:iso7816_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.795 [pkcs15-init] card-asepcos.c:316:asepcos_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.795 [pkcs15-init] card.c:744:sc_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] profile.c:626:sc_profile_get_file_by_path: called
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] profile.c:630:sc_profile_get_file_by_path: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] pkcs15-lib.c:3514:sc_pkcs15init_authenticate: called
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] pkcs15-lib.c:3516:sc_pkcs15init_authenticate: path '3f00', op=7
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] pkcs15-lib.c:3527:sc_pkcs15init_authenticate: acl 0x1166220
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] pkcs15-lib.c:3541:sc_pkcs15init_authenticate: verify acl(method:8,reference:0)
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] pkcs15-lib.c:3364:sc_pkcs15init_verify_secret: called
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] pkcs15-lib.c:3368:sc_pkcs15init_verify_secret: get and verify PIN('authentication key',type:0x8,reference:0x0)
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] pkcs15-lib.c:1878:sc_pkcs15init_get_pin_reference: called
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] pkcs15.c:2029:sc_pkcs15_parse_df: called; path=3f0050154401, type=8, enum=0
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] pkcs15.c:2314:sc_pkcs15_read_file: called
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] pkcs15.c:2315:sc_pkcs15_read_file: path=3f0050154401, index=0, count=-1
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] card.c:709:sc_select_file: called; type=2, path=3f0050154401
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] card-asepcos.c:270:asepcos_select_file: called
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:CA, P1:1, P2:83, data(0) (nil)
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 CA 01 83 00 .....
>0x7fb9af7b7740 10:07:25.796 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.799 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (6 bytes):
>8B 02 3F 00 90 00 ..?...
>0x7fb9af7b7740 10:07:25.799 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.799 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.799 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.799 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.799 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.799 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.799 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.799 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.799 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:A4, P1:8, P2:0, data(4) 0x7ffd28be3ea0
>0x7fb9af7b7740 10:07:25.799 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.799 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (10 bytes):
>00 A4 08 00 04 50 15 44 01 00 .....P.D..
>0x7fb9af7b7740 10:07:25.799 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (53 bytes):
>6F 31 80 02 01 00 81 02 01 1C 82 01 00 83 02 44 o1.............D
>01 88 00 A5 02 00 01 8A 01 05 86 81 16 80 01 01 ................
>90 00 80 01 78 97 00 80 01 02 A0 01 02 80 01 04 ....x...........
>A0 01 02 90 00                                  .....
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] iso7816.c:338:iso7816_process_fci: processing FCI bytes
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] iso7816.c:342:iso7816_process_fci:   file identifier: 0x4401
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] iso7816.c:362:iso7816_process_fci:   bytes in file: 256
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] iso7816.c:373:iso7816_process_fci:   shareable: no
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] iso7816.c:392:iso7816_process_fci:   type: working EF
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] iso7816.c:393:iso7816_process_fci:   EF structure: 0
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] iso7816.c:394:iso7816_process_fci:   tag 0x82: 0x00
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] card-asepcos.c:316:asepcos_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] card.c:744:sc_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] card.c:538:sc_read_binary: called; 256 bytes at index 0
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:B0, P1:0, P2:0, data(0) (nil)
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 B0 00 00 00 .....
>0x7fb9af7b7740 10:07:25.811 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (258 bytes):
>30 43 30 1A 0C 14 53 65 63 75 72 69 74 79 20 4F 0C0...Security O
>66 66 69 63 65 72 20 50 49 4E 03 02 06 C0 30 03 fficer PIN....0.
>04 01 FF A1 20 30 1E 03 02 00 49 0A 01 01 02 01 .... 0....I.....
>04 02 01 06 02 01 10 80 01 02 04 01 00 30 06 04 .............0..
>04 3F 00 50 15 30 3A 30 11 0C 0B 69 70 61 75 73 .?.P.0:0...ipaus
>65 72 31 2D 30 31 03 02 06 C0 30 03 04 01 01 A1 er1-01....0.....
>20 30 1E 03 02 03 48 0A 01 01 02 01 04 02 01 06  0....H.........
>02 01 10 80 01 04 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 ................
>00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
>00 00 00 00 00 00 00 00 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                                           ..
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] iso7816.c:168:iso7816_read_binary: returning with: 256
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] card.c:578:sc_read_binary: returning with: 256
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] pkcs15.c:2411:sc_pkcs15_read_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] pkcs15-pin.c:100:sc_pkcs15_decode_aodf_entry: called
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1450:asn1_decode: called, left=256, depth 0
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'authType', tag 0x0
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1450:asn1_decode:  called, left=256, depth 1, choice
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pin', tag 0x1000010, CHOICE, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:  decoding 'pin', raw data:301A0C145365637572697479204F6666...
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1450:asn1_decode:   called, left=67, depth 2
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'commonObjectAttributes', tag 0x1000010
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:   decoding 'commonObjectAttributes', raw data:0C145365637572697479204F66666963...
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1450:asn1_decode:    called, left=26, depth 3
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'label', tag 0xc, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:    decoding 'label', raw data:5365637572697479204F666669636572...
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'flags', tag 0x3, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:    decoding 'flags', raw data:06C0
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'authId', tag 0x4, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1488:asn1_decode: 'authId' not present
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'userConsent', tag 0x2, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1488:asn1_decode: 'userConsent' not present
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'accessControlRules', tag 0x1000010, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1488:asn1_decode: 'accessControlRules' not present
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'classAttributes', tag 0x1000010
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:   decoding 'classAttributes', raw data:0401FF
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1450:asn1_decode:    called, left=3, depth 3
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'authId', tag 0x4
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:    decoding 'authId', raw data:FF
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'subClassAttributes', tag 0x21000000, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1488:asn1_decode: 'subClassAttributes' not present
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'typeAttributes', tag 0x21000001
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:   decoding 'typeAttributes', raw data:301E030200490A010102010402010602...
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1450:asn1_decode:    called, left=32, depth 3
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pinAttributes', tag 0x1000010
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:    decoding 'pinAttributes', raw data:030200490A0101020104020106020110...
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1450:asn1_decode:     called, left=30, depth 4
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pinFlags', tag 0x3
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'pinFlags', raw data:0049
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pinType', tag 0xa
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'pinType', raw data:01
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1290:asn1_decode_entry:     decoding 'pinType' returned 1
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'minLength', tag 0x2
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'minLength', raw data:04
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1290:asn1_decode_entry:     decoding 'minLength' returned 4
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'storedLength', tag 0x2
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'storedLength', raw data:06
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1290:asn1_decode_entry:     decoding 'storedLength' returned 6
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'maxLength', tag 0x2, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'maxLength', raw data:10
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1290:asn1_decode_entry:     decoding 'maxLength' returned 16
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pinReference', tag 0x20000000, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'pinReference', raw data:02
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1290:asn1_decode_entry:     decoding 'pinReference' returned 2
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'padChar', tag 0x4, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'padChar', raw data:00
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'lastPinChange', tag 0x18, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1488:asn1_decode: 'lastPinChange' not present
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'path', tag 0x1000010, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'path', raw data:04043F005015
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1450:asn1_decode:      called, left=6, depth 5
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'path', tag 0x4, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:      decoding 'path', raw data:3F005015
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'index', tag 0x2, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1488:asn1_decode: 'index' not present
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'length', tag 0x20000000, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1488:asn1_decode: 'length' not present
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pathExtended', tag 0x21000001, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1488:asn1_decode: 'pathExtended' not present
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1522:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] pkcs15-pin.c:148:sc_pkcs15_decode_aodf_entry: AuthType: PIN
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] pkcs15-pin.c:182:sc_pkcs15_decode_aodf_entry: decoded PIN(ref:2,path:3f005015)
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] pkcs15-pin.c:204:sc_pkcs15_decode_aodf_entry: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] pkcs15-pin.c:100:sc_pkcs15_decode_aodf_entry: called
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1450:asn1_decode: called, left=187, depth 0
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'authType', tag 0x0
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1450:asn1_decode:  called, left=187, depth 1, choice
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pin', tag 0x1000010, CHOICE, OPTIONAL
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1266:asn1_decode_entry:  decoding 'pin', raw data:30110C0B69706175736572312D303103...
>0x7fb9af7b7740 10:07:25.852 [pkcs15-init] asn1.c:1450:asn1_decode:   called, left=58, depth 2
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'commonObjectAttributes', tag 0x1000010
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:   decoding 'commonObjectAttributes', raw data:0C0B69706175736572312D3031030206...
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1450:asn1_decode:    called, left=17, depth 3
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'label', tag 0xc, OPTIONAL
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:    decoding 'label', raw data:69706175736572312D3031
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'flags', tag 0x3, OPTIONAL
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:    decoding 'flags', raw data:06C0
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'authId', tag 0x4, OPTIONAL
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1488:asn1_decode: 'authId' not present
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'userConsent', tag 0x2, OPTIONAL
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1488:asn1_decode: 'userConsent' not present
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'accessControlRules', tag 0x1000010, OPTIONAL
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1488:asn1_decode: 'accessControlRules' not present
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'classAttributes', tag 0x1000010
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:   decoding 'classAttributes', raw data:040101
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1450:asn1_decode:    called, left=3, depth 3
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'authId', tag 0x4
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:    decoding 'authId', raw data:01
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'subClassAttributes', tag 0x21000000, OPTIONAL
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1488:asn1_decode: 'subClassAttributes' not present
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'typeAttributes', tag 0x21000001
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:   decoding 'typeAttributes', raw data:301E030203480A010102010402010602...
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1450:asn1_decode:    called, left=32, depth 3
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pinAttributes', tag 0x1000010
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:    decoding 'pinAttributes', raw data:030203480A0101020104020106020110...
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1450:asn1_decode:     called, left=30, depth 4
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pinFlags', tag 0x3
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'pinFlags', raw data:0348
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pinType', tag 0xa
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'pinType', raw data:01
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1290:asn1_decode_entry:     decoding 'pinType' returned 1
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'minLength', tag 0x2
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'minLength', raw data:04
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1290:asn1_decode_entry:     decoding 'minLength' returned 4
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'storedLength', tag 0x2
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'storedLength', raw data:06
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1290:asn1_decode_entry:     decoding 'storedLength' returned 6
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'maxLength', tag 0x2, OPTIONAL
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'maxLength', raw data:10
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1290:asn1_decode_entry:     decoding 'maxLength' returned 16
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pinReference', tag 0x20000000, OPTIONAL
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'pinReference', raw data:04
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1290:asn1_decode_entry:     decoding 'pinReference' returned 4
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'padChar', tag 0x4, OPTIONAL
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'padChar', raw data:00
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'lastPinChange', tag 0x18, OPTIONAL
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1488:asn1_decode: 'lastPinChange' not present
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'path', tag 0x1000010, OPTIONAL
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:     decoding 'path', raw data:04043F005015
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1450:asn1_decode:      called, left=6, depth 5
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'path', tag 0x4, OPTIONAL
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1266:asn1_decode_entry:      decoding 'path', raw data:3F005015
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'index', tag 0x2, OPTIONAL
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1488:asn1_decode: 'index' not present
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'length', tag 0x20000000, OPTIONAL
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1488:asn1_decode: 'length' not present
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1474:asn1_decode: Looking for 'pathExtended', tag 0x21000001, OPTIONAL
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1488:asn1_decode: 'pathExtended' not present
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1522:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] asn1.c:1523:asn1_decode: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] pkcs15-pin.c:148:sc_pkcs15_decode_aodf_entry: AuthType: PIN
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] pkcs15-pin.c:182:sc_pkcs15_decode_aodf_entry: decoded PIN(ref:4,path:3f005015)
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] pkcs15-pin.c:204:sc_pkcs15_decode_aodf_entry: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] pkcs15.c:2098:sc_pkcs15_parse_df: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] pkcs15-lib.c:1888:sc_pkcs15init_get_pin_reference: found 2 auth objects; looking for AUTH object(auth_method:8,reference:0)
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] pkcs15-lib.c:1895:sc_pkcs15init_get_pin_reference: check PIN(Security Officer PIN,auth_method:1,type:1,reference:2,flags:92)
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] pkcs15-lib.c:1895:sc_pkcs15init_get_pin_reference: check PIN(ipauser1-01,auth_method:1,type:1,reference:4,flags:12)
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] pkcs15-lib.c:1942:sc_pkcs15init_get_pin_reference: PIN template not found: -1407 (Requested object not found)
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] pkcs15-lib.c:3388:sc_pkcs15init_verify_secret: found PIN reference -1407
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] pkcs15-lib.c:3304:sc_pkcs15init_get_transport_key: called
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] card.c:867:sc_card_ctl: called
>0x7fb9af7b7740 10:07:25.853 [pkcs15-init] card.c:877:sc_card_ctl: returning with: 0 (Success)
>Transport key (External authentication key #0) required.
>Please enter key in hexadecimal notation (e.g. 00:11:22:aa:bb:cc),
>or press return to accept default.
>
>To use the default transport keys without being prompted,
>specify the --use-default-transport-keys option on the
>command line (or -T for short), or press Ctrl-C to abort.
>Please enter key [41:53:45:43:41:52:44:2b]: 
>0x7fb9af7b7740 10:07:28.611 [pkcs15-init] pkcs15-pin.c:660:sc_pkcs15_pincache_add: called
>0x7fb9af7b7740 10:07:28.611 [pkcs15-init] pkcs15-pin.c:704:sc_pkcs15_pincache_add: PIN(Default transport key) cached
>0x7fb9af7b7740 10:07:28.611 [pkcs15-init] pkcs15-lib.c:3343:sc_pkcs15init_get_transport_key: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.611 [pkcs15-init] card.c:709:sc_select_file: called; type=2, path=3f00
>0x7fb9af7b7740 10:07:28.611 [pkcs15-init] card-asepcos.c:270:asepcos_select_file: called
>0x7fb9af7b7740 10:07:28.611 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:28.611 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:28.611 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.611 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:28.611 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:28.611 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:CA, P1:1, P2:83, data(0) (nil)
>0x7fb9af7b7740 10:07:28.611 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:28.611 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 CA 01 83 00 .....
>0x7fb9af7b7740 10:07:28.611 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:28.616 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (10 bytes):
>8B 02 3F 00 8B 02 50 15 90 00 ..?...P...
>0x7fb9af7b7740 10:07:28.616 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.616 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.616 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:28.616 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:28.616 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:28.616 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.616 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:28.616 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:28.616 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:C, data(2) 0x7ffd28be4420
>0x7fb9af7b7740 10:07:28.616 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:28.616 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (7 bytes):
>00 A4 00 0C 02 3F 00 .....?.
>0x7fb9af7b7740 10:07:28.616 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (2 bytes):
>90 00 ..
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] iso7816.c:550:iso7816_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] card-asepcos.c:316:asepcos_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] card.c:744:sc_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] sec.c:159:sc_pin_cmd: called
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:80, INS:28, P1:2, P2:1, data(1) 0x7ffd28be4380
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (7 bytes):
>80 28 02 01 01 00 00 .(.....
>0x7fb9af7b7740 10:07:28.621 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:28.625 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (6 bytes):
>00 00 00 01 90 00 ......
>0x7fb9af7b7740 10:07:28.625 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.625 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.625 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:28.625 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:28.625 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:28.625 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.625 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:28.625 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:28.625 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:20, P1:2, P2:80, data(12) 0x7ffd28be4560
>0x7fb9af7b7740 10:07:28.625 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:28.625 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (17 bytes):
>00 20 02 80 0C 00 00 00 01 41 53 45 43 41 52 44 . .......ASECARD
>2B                                              +
>0x7fb9af7b7740 10:07:28.626 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:28.645 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (2 bytes):
>90 00 ..
>0x7fb9af7b7740 10:07:28.645 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.645 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.646 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:28.646 [pkcs15-init] sec.c:206:sc_pin_cmd: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.646 [pkcs15-init] pkcs15-lib.c:3488:sc_pkcs15init_verify_secret: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.646 [pkcs15-init] pkcs15-lib.c:3547:sc_pkcs15init_authenticate: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.646 [pkcs15-init] card.c:709:sc_select_file: called; type=2, path=3f002f00
>0x7fb9af7b7740 10:07:28.646 [pkcs15-init] card-asepcos.c:270:asepcos_select_file: called
>0x7fb9af7b7740 10:07:28.646 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:28.646 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:28.646 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.646 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:28.646 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:28.646 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:CA, P1:1, P2:83, data(0) (nil)
>0x7fb9af7b7740 10:07:28.646 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:28.646 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 CA 01 83 00 .....
>0x7fb9af7b7740 10:07:28.646 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:28.649 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (6 bytes):
>8B 02 3F 00 90 00 ..?...
>0x7fb9af7b7740 10:07:28.649 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.649 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.649 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:28.649 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:28.649 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:28.649 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.649 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:28.649 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:28.649 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:0, data(2) 0x7ffd28be6d50
>0x7fb9af7b7740 10:07:28.649 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:28.649 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (8 bytes):
>00 A4 00 00 02 2F 00 00 ...../..
>0x7fb9af7b7740 10:07:28.650 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (2 bytes):
>6A 82 j.
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] iso7816.c:121:iso7816_check_sw: File not found
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] iso7816.c:555:iso7816_select_file: returning with: -1201 (File not found)
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] card-asepcos.c:316:asepcos_select_file: returning with: -1201 (File not found)
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] card.c:731:sc_select_file: 'SELECT' error: -1201 (File not found)
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] card.c:709:sc_select_file: called; type=2, path=3f005015
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] card-asepcos.c:270:asepcos_select_file: called
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:CA, P1:1, P2:83, data(0) (nil)
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 CA 01 83 00 .....
>0x7fb9af7b7740 10:07:28.653 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:28.657 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (6 bytes):
>8B 02 3F 00 90 00 ..?...
>0x7fb9af7b7740 10:07:28.657 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.657 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.657 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:28.657 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:28.657 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:28.657 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.657 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:28.657 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:28.657 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:A4, P1:0, P2:0, data(2) 0x7ffd28be6d50
>0x7fb9af7b7740 10:07:28.657 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:28.657 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (8 bytes):
>00 A4 00 00 02 50 15 00 .....P..
>0x7fb9af7b7740 10:07:28.657 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (88 bytes):
>6F 54 80 02 00 00 81 02 00 59 82 01 38 83 02 50 oT.......Y..8..P
>15 A5 06 00 00 00 00 44 04 84 0C A0 00 00 00 63 .......D.......c
>50 4B 43 53 2D 31 35 8A 01 05 86 81 29 80 01 20 PKCS-15.....).. 
>97 00 80 01 01 A0 01 02 80 01 02 A0 01 02 80 01 ................
>04 A0 01 02 80 01 08 A0 01 02 80 01 10 A0 01 02 ................
>80 01 40 A0 01 02 90 00                         ..@.....
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] iso7816.c:338:iso7816_process_fci: processing FCI bytes
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] iso7816.c:342:iso7816_process_fci:   file identifier: 0x5015
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] iso7816.c:362:iso7816_process_fci:   bytes in file: 0
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] iso7816.c:373:iso7816_process_fci:   shareable: no
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] iso7816.c:392:iso7816_process_fci:   type: DF
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] iso7816.c:393:iso7816_process_fci:   EF structure: 0
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] iso7816.c:394:iso7816_process_fci:   tag 0x82: 0x38
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] iso7816.c:407:iso7816_process_fci:   File name: A0 00 00 00 63 50 4B 43 53 2D 31 35 ....cPKCS-15
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] card-asepcos.c:316:asepcos_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] card.c:744:sc_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] pkcs15-lib.c:3514:sc_pkcs15init_authenticate: called
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] pkcs15-lib.c:3516:sc_pkcs15init_authenticate: path '3f005015', op=8
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] card.c:709:sc_select_file: called; type=2, path=3f005015
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] card-asepcos.c:270:asepcos_select_file: called
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:CA, P1:1, P2:83, data(0) (nil)
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 CA 01 83 00 .....
>0x7fb9af7b7740 10:07:28.674 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:28.678 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (10 bytes):
>8B 02 3F 00 8B 02 50 15 90 00 ..?...P...
>0x7fb9af7b7740 10:07:28.678 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.678 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.678 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:28.678 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:28.678 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:28.678 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.678 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:28.678 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:28.678 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:A4, P1:8, P2:0, data(2) 0x7ffd28be6ce2
>0x7fb9af7b7740 10:07:28.678 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:28.678 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (8 bytes):
>00 A4 08 00 02 50 15 00 .....P..
>0x7fb9af7b7740 10:07:28.678 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (88 bytes):
>6F 54 80 02 00 00 81 02 00 59 82 01 38 83 02 50 oT.......Y..8..P
>15 A5 06 00 00 00 00 44 04 84 0C A0 00 00 00 63 .......D.......c
>50 4B 43 53 2D 31 35 8A 01 05 86 81 29 80 01 20 PKCS-15.....).. 
>97 00 80 01 01 A0 01 02 80 01 02 A0 01 02 80 01 ................
>04 A0 01 02 80 01 08 A0 01 02 80 01 10 A0 01 02 ................
>80 01 40 A0 01 02 90 00                         ..@.....
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] iso7816.c:338:iso7816_process_fci: processing FCI bytes
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] iso7816.c:342:iso7816_process_fci:   file identifier: 0x5015
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] iso7816.c:362:iso7816_process_fci:   bytes in file: 0
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] iso7816.c:373:iso7816_process_fci:   shareable: no
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] iso7816.c:392:iso7816_process_fci:   type: DF
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] iso7816.c:393:iso7816_process_fci:   EF structure: 0
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] iso7816.c:394:iso7816_process_fci:   tag 0x82: 0x38
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] iso7816.c:407:iso7816_process_fci:   File name: A0 00 00 00 63 50 4B 43 53 2D 31 35 ....cPKCS-15
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] card-asepcos.c:316:asepcos_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] card.c:744:sc_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] pkcs15-lib.c:3527:sc_pkcs15init_authenticate: acl 0x1189590
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] pkcs15-lib.c:3541:sc_pkcs15init_authenticate: verify acl(method:1,reference:2)
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] pkcs15-lib.c:3364:sc_pkcs15init_verify_secret: called
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] pkcs15-lib.c:3368:sc_pkcs15init_verify_secret: get and verify PIN('PIN',type:0x1,reference:0x2)
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] pkcs15-lib.c:1878:sc_pkcs15init_get_pin_reference: called
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] pkcs15-lib.c:1888:sc_pkcs15init_get_pin_reference: found 3 auth objects; looking for AUTH object(auth_method:1,reference:2)
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] pkcs15-lib.c:1895:sc_pkcs15init_get_pin_reference: check PIN(Security Officer PIN,auth_method:1,type:1,reference:2,flags:92)
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] pkcs15-lib.c:1898:sc_pkcs15init_get_pin_reference: returning with: 2
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] pkcs15-lib.c:3388:sc_pkcs15init_verify_secret: found PIN reference 2
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] pkcs15-lib.c:3413:sc_pkcs15init_verify_secret: found PIN object 'Security Officer PIN'
>0x7fb9af7b7740 10:07:28.696 [pkcs15-init] pkcs15-lib.c:3417:sc_pkcs15init_verify_secret: PIN object 'Security Officer PIN'; pin_obj->content.len:0
>PIN [Security Officer PIN] required.
>Please enter PIN [Security Officer PIN]: 
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] pkcs15-lib.c:3436:sc_pkcs15init_verify_secret: 'get_pin' callback returned 0; pinsize:6
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] pkcs15-pin.c:296:sc_pkcs15_verify_pin: called
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] pkcs15-pin.c:320:_sc_pkcs15_verify_pin: called
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] pkcs15-pin.c:322:_sc_pkcs15_verify_pin: PIN(type:0; method:1; value(0x7ffd28be6d50:6)
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] card.c:709:sc_select_file: called; type=2, path=3f005015
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] card-asepcos.c:270:asepcos_select_file: called
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:CA, P1:1, P2:83, data(0) (nil)
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (5 bytes):
>00 CA 01 83 00 .....
>0x7fb9af7b7740 10:07:31.529 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:31.533 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (10 bytes):
>8B 02 3F 00 8B 02 50 15 90 00 ..?...P...
>0x7fb9af7b7740 10:07:31.534 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:31.534 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:31.534 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:31.534 [pkcs15-init] card.c:744:sc_select_file: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:31.534 [pkcs15-init] sec.c:159:sc_pin_cmd: called
>0x7fb9af7b7740 10:07:31.534 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:31.534 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:31.534 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:31.534 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:31.534 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:31.534 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:80, INS:28, P1:2, P2:1, data(1) 0x7ffd28be2040
>0x7fb9af7b7740 10:07:31.534 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:31.534 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (7 bytes):
>80 28 02 01 01 02 00 .(.....
>0x7fb9af7b7740 10:07:31.534 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:31.538 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (6 bytes):
>00 01 00 01 90 00 ......
>0x7fb9af7b7740 10:07:31.538 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:31.538 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:31.538 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:31.539 [pkcs15-init] apdu.c:550:sc_transmit_apdu: called
>0x7fb9af7b7740 10:07:31.539 [pkcs15-init] card.c:393:sc_lock: called
>0x7fb9af7b7740 10:07:31.539 [pkcs15-init] card.c:435:sc_lock: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:31.539 [pkcs15-init] apdu.c:517:sc_transmit: called
>0x7fb9af7b7740 10:07:31.539 [pkcs15-init] apdu.c:371:sc_single_transmit: called
>0x7fb9af7b7740 10:07:31.539 [pkcs15-init] apdu.c:376:sc_single_transmit: CLA:0, INS:20, P1:2, P2:80, data(10) 0x7ffd28be2220
>0x7fb9af7b7740 10:07:31.539 [pkcs15-init] reader-pcsc.c:269:pcsc_transmit: reader 'OMNIKEY AG CardMan 3021 00 00'
>0x7fb9af7b7740 10:07:31.539 [pkcs15-init] reader-pcsc.c:270:pcsc_transmit: 
>Outgoing APDU (15 bytes):
>00 20 02 80 0A 00 01 00 01 72 65 64 68 61 74 . .......redhat
>0x7fb9af7b7740 10:07:31.539 [pkcs15-init] reader-pcsc.c:199:pcsc_internal_transmit: called
>0x7fb9af7b7740 10:07:31.543 [pkcs15-init] reader-pcsc.c:279:pcsc_transmit: 
>Incoming APDU (2 bytes):
>63 C0 c.
>0x7fb9af7b7740 10:07:31.543 [pkcs15-init] apdu.c:386:sc_single_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:31.543 [pkcs15-init] apdu.c:539:sc_transmit: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:31.543 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:31.543 [pkcs15-init] sec.c:206:sc_pin_cmd: returning with: -1214 (PIN code or key incorrect)
>0x7fb9af7b7740 10:07:31.543 [pkcs15-init] pkcs15-pin.c:394:_sc_pkcs15_verify_pin: PIN cmd result -1214
>0x7fb9af7b7740 10:07:31.543 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:31.543 [pkcs15-init] pkcs15-pin.c:397:_sc_pkcs15_verify_pin: returning with: -1214 (PIN code or key incorrect)
>0x7fb9af7b7740 10:07:31.543 [pkcs15-init] pkcs15-pin.c:306:sc_pkcs15_verify_pin: returning with: -1214 (PIN code or key incorrect)
>0x7fb9af7b7740 10:07:31.543 [pkcs15-init] pkcs15-lib.c:3466:sc_pkcs15init_verify_secret: Cannot validate pkcs15 PIN: -1214 (PIN code or key incorrect)
>0x7fb9af7b7740 10:07:31.543 [pkcs15-init] pkcs15-lib.c:3547:sc_pkcs15init_authenticate: returning with: -1214 (PIN code or key incorrect)
>0x7fb9af7b7740 10:07:31.543 [pkcs15-init] pkcs15-lib.c:513:sc_pkcs15init_erase_card: returning with: -1214 (PIN code or key incorrect)
>0x7fb9af7b7740 10:07:31.543 [pkcs15-init] card.c:445:sc_unlock: called
>0x7fb9af7b7740 10:07:31.543 [pkcs15-init] reader-pcsc.c:627:pcsc_unlock: called
>Failed to erase card: PIN code or key incorrect
>0x7fb9af7b7740 10:07:31.551 [pkcs15-init] pkcs15-lib.c:421:sc_pkcs15init_unbind: called
>0x7fb9af7b7740 10:07:31.551 [pkcs15-init] pkcs15-lib.c:422:sc_pkcs15init_unbind: Pksc15init Unbind: 0:0x1163dd0:1
>0x7fb9af7b7740 10:07:31.551 [pkcs15-init] card.c:333:sc_disconnect_card: called
>0x7fb9af7b7740 10:07:31.551 [pkcs15-init] reader-pcsc.c:566:pcsc_disconnect: called
>0x7fb9af7b7740 10:07:31.581 [pkcs15-init] reader-pcsc.c:570:pcsc_disconnect: OMNIKEY AG CardMan 3021 00 00:SCardDisconnect returned: 0x00000000
>0x7fb9af7b7740 10:07:31.581 [pkcs15-init] card.c:354:sc_disconnect_card: returning with: 0 (Success)
>0x7fb9af7b7740 10:07:31.581 [pkcs15-init] ctx.c:869:sc_release_context: called
>0x7fb9af7b7740 10:07:31.581 [pkcs15-init] reader-pcsc.c:834:pcsc_finish: called
>[root@dhcp129-184 ~]# 
>

Actions: View

Attachments on bug 1445430: 1273958