Skip to content

Instantly share code, notes, and snippets.

@kousu
Created August 8, 2018 17:42
Show Gist options
  • Save kousu/af4391e88442811d6d2ebf893958b4de to your computer and use it in GitHub Desktop.
Save kousu/af4391e88442811d6d2ebf893958b4de to your computer and use it in GitHub Desktop.
$ OPENSC_DEBUG=10 pkcs11-tool --keypairgen -v
0x7f0cb5988780 13:07:16.819 [opensc-pkcs11] ctx.c:703:process_config_file: Used configuration file '/etc/opensc.conf'
0x7f0cb5988780 13:07:16.820 [opensc-pkcs11] ctx.c:825:sc_context_create: ===================================
0x7f0cb5988780 13:07:16.820 [opensc-pkcs11] ctx.c:826:sc_context_create: opensc version: 0.18.0
0x7f0cb5988780 13:07:16.820 [opensc-pkcs11] reader-pcsc.c:815:pcsc_init: PC/SC options: connect_exclusive=0 disconnect_action=0 transaction_end_action=0 reconnect_action=0 enable_pinpad=1 enable_pace=1
0x7f0cb5988780 13:07:16.821 [opensc-pkcs11] reader-pcsc.c:1282:pcsc_detect_readers: called
0x7f0cb5988780 13:07:16.821 [opensc-pkcs11] reader-pcsc.c:1301:pcsc_detect_readers: Probing PC/SC readers
0x7f0cb5988780 13:07:16.822 [opensc-pkcs11] reader-pcsc.c:1329:pcsc_detect_readers: Establish PC/SC context
0x7f0cb5988780 13:07:16.822 [opensc-pkcs11] reader-pcsc.c:1241:pcsc_add_reader: Adding new PC/SC reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.823 [opensc-pkcs11] reader-pcsc.c:319:refresh_attributes: Yubico Yubikey 4 CCID 00 00 check
0x7f0cb5988780 13:07:16.823 [opensc-pkcs11] reader-pcsc.c:347:refresh_attributes: current state: 0x00000022
0x7f0cb5988780 13:07:16.823 [opensc-pkcs11] reader-pcsc.c:348:refresh_attributes: previous state: 0x00000000
0x7f0cb5988780 13:07:16.823 [opensc-pkcs11] reader-pcsc.c:403:refresh_attributes: card present, changed
0x7f0cb5988780 13:07:16.823 [opensc-pkcs11] reader-pcsc.c:1407:pcsc_detect_readers: Yubico Yubikey 4 CCID 00 00:SCardConnect(SHARED): 0x00000000
0x7f0cb5988780 13:07:16.823 [opensc-pkcs11] reader-pcsc.c:1063:detect_reader_features: called
0x7f0cb5988780 13:07:16.823 [opensc-pkcs11] reader-pcsc.c:1065:detect_reader_features: Requesting reader features ...
0x7f0cb5988780 13:07:16.823 [opensc-pkcs11] reader-pcsc.c:1086:detect_reader_features: Reader feature 12 found
0x7f0cb5988780 13:07:16.823 [opensc-pkcs11] reader-pcsc.c:1004:part10_detect_max_data: get dwMaxAPDUDataSize property returned 65536
0x7f0cb5988780 13:07:16.824 [opensc-pkcs11] reader-pcsc.c:1192:detect_reader_features: Reader supports transceiving 65536 bytes of data
0x7f0cb5988780 13:07:16.824 [opensc-pkcs11] reader-pcsc.c:1197:detect_reader_features: Sending is limited to 255 bytes of data in configuration file
0x7f0cb5988780 13:07:16.824 [opensc-pkcs11] reader-pcsc.c:1043:part10_get_vendor_product: id_vendor=1050 id_product=0404
0x7f0cb5988780 13:07:16.824 [opensc-pkcs11] reader-pcsc.c:1422:pcsc_detect_readers: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.824 [opensc-pkcs11] misc.c:509:load_pkcs11_parameters: PKCS#11 options: max_virtual_slots=16 slots_per_card=4 hide_empty_tokens=1 lock_login=0 atomic=0 pin_unblock_style=0 zero_ckaid_for_ca_certs=0 create_slots_flags=0x8
0x7f0cb5988780 13:07:16.824 [opensc-pkcs11] slot.c:120:create_slot: Initializing slot with id 0x0
0x7f0cb5988780 13:07:16.825 [opensc-pkcs11] slot.c:120:create_slot: Initializing slot with id 0x1
0x7f0cb5988780 13:07:16.825 [opensc-pkcs11] slot.c:120:create_slot: Initializing slot with id 0x2
0x7f0cb5988780 13:07:16.825 [opensc-pkcs11] slot.c:120:create_slot: Initializing slot with id 0x3
0x7f0cb5988780 13:07:16.825 [opensc-pkcs11] slot.c:179:initialize_reader: Initialize reader 'Yubico Yubikey 4 CCID 00 00': detect SC card presence
0x7f0cb5988780 13:07:16.825 [opensc-pkcs11] sc.c:275:sc_detect_card_presence: called
0x7f0cb5988780 13:07:16.825 [opensc-pkcs11] reader-pcsc.c:411:pcsc_detect_card_presence: called
0x7f0cb5988780 13:07:16.825 [opensc-pkcs11] reader-pcsc.c:319:refresh_attributes: Yubico Yubikey 4 CCID 00 00 check
0x7f0cb5988780 13:07:16.825 [opensc-pkcs11] reader-pcsc.c:339:refresh_attributes: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.825 [opensc-pkcs11] reader-pcsc.c:416:pcsc_detect_card_presence: returning with: 1
0x7f0cb5988780 13:07:16.825 [opensc-pkcs11] sc.c:280:sc_detect_card_presence: returning with: 1
0x7f0cb5988780 13:07:16.825 [opensc-pkcs11] slot.c:181:initialize_reader: Initialize reader 'Yubico Yubikey 4 CCID 00 00': detect PKCS11 card presence
0x7f0cb5988780 13:07:16.826 [opensc-pkcs11] slot.c:233:card_detect: Yubico Yubikey 4 CCID 00 00: Detecting smart card
0x7f0cb5988780 13:07:16.826 [opensc-pkcs11] sc.c:275:sc_detect_card_presence: called
0x7f0cb5988780 13:07:16.826 [opensc-pkcs11] reader-pcsc.c:411:pcsc_detect_card_presence: called
0x7f0cb5988780 13:07:16.826 [opensc-pkcs11] reader-pcsc.c:319:refresh_attributes: Yubico Yubikey 4 CCID 00 00 check
0x7f0cb5988780 13:07:16.826 [opensc-pkcs11] reader-pcsc.c:339:refresh_attributes: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.826 [opensc-pkcs11] reader-pcsc.c:416:pcsc_detect_card_presence: returning with: 1
0x7f0cb5988780 13:07:16.826 [opensc-pkcs11] sc.c:280:sc_detect_card_presence: returning with: 1
0x7f0cb5988780 13:07:16.826 [opensc-pkcs11] slot.c:270:card_detect: Yubico Yubikey 4 CCID 00 00: First seen the card
0x7f0cb5988780 13:07:16.826 [opensc-pkcs11] slot.c:278:card_detect: Yubico Yubikey 4 CCID 00 00: Connecting ...
0x7f0cb5988780 13:07:16.826 [opensc-pkcs11] card.c:196:sc_connect_card: called
0x7f0cb5988780 13:07:16.826 [opensc-pkcs11] reader-pcsc.c:533:pcsc_connect: called
0x7f0cb5988780 13:07:16.826 [opensc-pkcs11] reader-pcsc.c:319:refresh_attributes: Yubico Yubikey 4 CCID 00 00 check
0x7f0cb5988780 13:07:16.828 [opensc-pkcs11] reader-pcsc.c:339:refresh_attributes: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.828 [opensc-pkcs11] reader-pcsc.c:565:pcsc_connect: Initial protocol: T=1
0x7f0cb5988780 13:07:16.828 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.828 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.828 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.828 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.828 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8E:80:01:80:31:81:54:48:53:4D:31:73:80:21:40:81:07:18
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:84:80:01:47:6f:49:44:00
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:85:80:01:47:6f:49:44:00:00
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:86:80:01:47:6f:49:44:00:00:00
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:87:80:01:47:6f:49:44:00:00:00:00
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.829 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:88:80:01:47:6f:49:44:00:00:00:00:00
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:89:80:01:47:6f:49:44:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8A:80:01:47:6f:49:44:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8B:80:01:47:6f:49:44:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8C:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8D:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1067:match_atr_table: ATR mask: FF:FF:FF:FF:FF:FF:FF:FF:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8E:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8F:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:221:sc_connect_card: matching configured ATRs
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:230:sc_connect_card: trying driver 'authentic'
0x7f0cb5988780 13:07:16.830 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:230:sc_connect_card: trying driver 'iasecc'
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:230:sc_connect_card: trying driver 'sc-hsm'
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8E:80:01:80:31:81:54:48:53:4D:31:73:80:21:40:81:07:18
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:84:80:01:47:6f:49:44:00
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.831 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:85:80:01:47:6f:49:44:00:00
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:86:80:01:47:6f:49:44:00:00:00
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:87:80:01:47:6f:49:44:00:00:00:00
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:88:80:01:47:6f:49:44:00:00:00:00:00
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:89:80:01:47:6f:49:44:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8A:80:01:47:6f:49:44:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8B:80:01:47:6f:49:44:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8C:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8D:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1067:match_atr_table: ATR mask: FF:FF:FF:FF:FF:FF:FF:FF:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8E:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.832 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8F:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card.c:230:sc_connect_card: trying driver 'PIV-II'
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card.c:235:sc_connect_card: matched driver 'Personal Identity Verification Card'
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] reader-pcsc.c:612:pcsc_lock: called
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card-piv.c:3576:piv_card_reader_lock_obtained: called
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card-piv.c:3581:piv_card_reader_lock_obtained: PIV_STATE_MATCH
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card-piv.c:3622:piv_card_reader_lock_obtained: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card-piv.c:2681:piv_find_discovery: called
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card-piv.c:998:piv_get_cached_data: called
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card-piv.c:999:piv_get_cached_data: #10
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card-piv.c:1039:piv_get_cached_data: get #10
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card-piv.c:927:piv_get_data: called
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card-piv.c:928:piv_get_data: #10
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card-piv.c:949:piv_get_data: get len of #10
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card-piv.c:494:piv_general_io: called
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card-piv.c:499:piv_general_io: cb 3f ff 3 : 0 0
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.833 [opensc-pkcs11] card-piv.c:540:piv_general_io: calling sc_transmit_apdu flags=3 le=8, resplen=8, resp=0x7ffea929cf20
0x7f0cb5988780 13:07:16.834 [opensc-pkcs11] apdu.c:554:sc_transmit_apdu: called
0x7f0cb5988780 13:07:16.834 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.834 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.834 [opensc-pkcs11] apdu.c:521:sc_transmit: called
0x7f0cb5988780 13:07:16.834 [opensc-pkcs11] apdu.c:371:sc_single_transmit: called
0x7f0cb5988780 13:07:16.834 [opensc-pkcs11] apdu.c:378:sc_single_transmit: CLA:0, INS:CB, P1:3F, P2:FF, data(3) 0x7ffea929cf18
0x7f0cb5988780 13:07:16.834 [opensc-pkcs11] reader-pcsc.c:283:pcsc_transmit: reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.834 [opensc-pkcs11] reader-pcsc.c:284:pcsc_transmit:
Outgoing APDU (9 bytes):
00 CB 3F FF 03 5C 01 7E 08 ..?..\.~.
0x7f0cb5988780 13:07:16.834 [opensc-pkcs11] reader-pcsc.c:212:pcsc_internal_transmit: called
0x7f0cb5988780 13:07:16.835 [opensc-pkcs11] reader-pcsc.c:293:pcsc_transmit:
Incoming APDU (10 bytes):
7E 12 4F 0B A0 00 00 03 61 0C ~.O.....a.
0x7f0cb5988780 13:07:16.835 [opensc-pkcs11] apdu.c:390:sc_single_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.835 [opensc-pkcs11] apdu.c:543:sc_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.835 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] card-piv.c:547:piv_general_io: DEE r=0 apdu.resplen=8 sw1=61 sw2=0c
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] card-piv.c:609:piv_general_io: returning with: 20
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] card-piv.c:972:piv_get_data: buffer for #10 *buf=0x(nil) len=20
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] card-piv.c:494:piv_general_io: called
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] card-piv.c:499:piv_general_io: cb 3f ff 3 : 0 0
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] card-piv.c:540:piv_general_io: calling sc_transmit_apdu flags=1 le=20, resplen=20, resp=0x562af20eb0d0
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] apdu.c:554:sc_transmit_apdu: called
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] apdu.c:521:sc_transmit: called
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] apdu.c:371:sc_single_transmit: called
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] apdu.c:378:sc_single_transmit: CLA:0, INS:CB, P1:3F, P2:FF, data(3) 0x7ffea929cf18
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] reader-pcsc.c:283:pcsc_transmit: reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] reader-pcsc.c:284:pcsc_transmit:
Outgoing APDU (9 bytes):
00 CB 3F FF 03 5C 01 7E 14 ..?..\.~.
0x7f0cb5988780 13:07:16.836 [opensc-pkcs11] reader-pcsc.c:212:pcsc_internal_transmit: called
0x7f0cb5988780 13:07:16.837 [opensc-pkcs11] reader-pcsc.c:293:pcsc_transmit:
Incoming APDU (22 bytes):
7E 12 4F 0B A0 00 00 03 08 00 00 10 00 01 00 5F ~.O............_
2F 02 40 00 90 00 /.@...
0x7f0cb5988780 13:07:16.837 [opensc-pkcs11] apdu.c:390:sc_single_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.837 [opensc-pkcs11] apdu.c:543:sc_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:547:piv_general_io: DEE r=0 apdu.resplen=20 sw1=90 sw2=00
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:609:piv_general_io: returning with: 20
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:985:piv_get_data: returning with: 20
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:1055:piv_get_cached_data: added #10 0x562af20eb0d0:20 (nil):0
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:1067:piv_get_cached_data: returning with: 20
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:2664:piv_process_discovery: Discovery = 0x562af20eb0d0:20
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:2617:piv_parse_discovery: Discovery 0x60 0x1e 0x562af20eb0d2:18
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:2622:piv_parse_discovery: Discovery aid=0x562af20eb0d4:11
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:2633:piv_parse_discovery: Discovery pinp=0x562af20eb0e2:2
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:2635:piv_parse_discovery: Discovery pinp flags=0x40 0x00
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:2647:piv_parse_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:2669:piv_process_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:2700:piv_find_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:2681:piv_find_discovery: called
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:927:piv_get_data: called
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:928:piv_get_data: #10
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:972:piv_get_data: buffer for #10 *buf=0x0x7ffea929d040 len=256
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:494:piv_general_io: called
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:499:piv_general_io: cb 3f ff 3 : 0 0
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.838 [opensc-pkcs11] card-piv.c:540:piv_general_io: calling sc_transmit_apdu flags=1 le=256, resplen=256, resp=0x7ffea929d040
0x7f0cb5988780 13:07:16.839 [opensc-pkcs11] apdu.c:554:sc_transmit_apdu: called
0x7f0cb5988780 13:07:16.839 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.839 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.839 [opensc-pkcs11] apdu.c:521:sc_transmit: called
0x7f0cb5988780 13:07:16.839 [opensc-pkcs11] apdu.c:371:sc_single_transmit: called
0x7f0cb5988780 13:07:16.839 [opensc-pkcs11] apdu.c:378:sc_single_transmit: CLA:0, INS:CB, P1:3F, P2:FF, data(3) 0x7ffea929cfd8
0x7f0cb5988780 13:07:16.839 [opensc-pkcs11] reader-pcsc.c:283:pcsc_transmit: reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.839 [opensc-pkcs11] reader-pcsc.c:284:pcsc_transmit:
Outgoing APDU (9 bytes):
00 CB 3F FF 03 5C 01 7E 00 ..?..\.~.
0x7f0cb5988780 13:07:16.839 [opensc-pkcs11] reader-pcsc.c:212:pcsc_internal_transmit: called
0x7f0cb5988780 13:07:16.840 [opensc-pkcs11] reader-pcsc.c:293:pcsc_transmit:
Incoming APDU (22 bytes):
7E 12 4F 0B A0 00 00 03 08 00 00 10 00 01 00 5F ~.O............_
2F 02 40 00 90 00 /.@...
0x7f0cb5988780 13:07:16.840 [opensc-pkcs11] apdu.c:390:sc_single_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.840 [opensc-pkcs11] apdu.c:543:sc_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.840 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.840 [opensc-pkcs11] card-piv.c:547:piv_general_io: DEE r=0 apdu.resplen=20 sw1=90 sw2=00
0x7f0cb5988780 13:07:16.840 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.841 [opensc-pkcs11] card-piv.c:609:piv_general_io: returning with: 20
0x7f0cb5988780 13:07:16.841 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.841 [opensc-pkcs11] card-piv.c:985:piv_get_data: returning with: 20
0x7f0cb5988780 13:07:16.841 [opensc-pkcs11] card-piv.c:2617:piv_parse_discovery: Discovery 0x60 0x1e 0x7ffea929d042:18
0x7f0cb5988780 13:07:16.841 [opensc-pkcs11] card-piv.c:2622:piv_parse_discovery: Discovery aid=0x7ffea929d044:11
0x7f0cb5988780 13:07:16.841 [opensc-pkcs11] card-piv.c:2647:piv_parse_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.841 [opensc-pkcs11] card-piv.c:2700:piv_find_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.841 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.841 [opensc-pkcs11] reader-pcsc.c:662:pcsc_unlock: called
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2938:piv_finish: called
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #0, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #1, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #2, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #3, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #4, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #5, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #6, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #7, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #8, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #9, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #10, 0x01 0x562af20eb0d0:20 (nil):0
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #11, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #12, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #13, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #14, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.851 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #15, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.852 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #16, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.852 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #17, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.852 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #18, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.852 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #19, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.852 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #20, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.852 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #21, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.852 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #22, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.852 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #23, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.852 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #24, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.852 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #25, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.852 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #26, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.852 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #27, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.852 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #28, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.852 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #29, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.852 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #30, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #31, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #32, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #33, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #34, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #35, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #36, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #37, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #38, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #39, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #40, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #41, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #42, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #43, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #44, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #45, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #46, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #47, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.853 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #48, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.854 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #49, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.854 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #50, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.854 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #51, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.854 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #52, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.854 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #53, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.854 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #54, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.854 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #55, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.854 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #56, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.854 [opensc-pkcs11] card-piv.c:3162:piv_init: called
0x7f0cb5988780 13:07:16.854 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.854 [opensc-pkcs11] reader-pcsc.c:612:pcsc_lock: called
0x7f0cb5988780 13:07:16.855 [opensc-pkcs11] card-piv.c:3576:piv_card_reader_lock_obtained: called
0x7f0cb5988780 13:07:16.855 [opensc-pkcs11] card-piv.c:3581:piv_card_reader_lock_obtained: PIV_STATE_MATCH
0x7f0cb5988780 13:07:16.855 [opensc-pkcs11] card-piv.c:3622:piv_card_reader_lock_obtained: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.855 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.855 [opensc-pkcs11] card-piv.c:2681:piv_find_discovery: called
0x7f0cb5988780 13:07:16.855 [opensc-pkcs11] card-piv.c:998:piv_get_cached_data: called
0x7f0cb5988780 13:07:16.855 [opensc-pkcs11] card-piv.c:999:piv_get_cached_data: #10
0x7f0cb5988780 13:07:16.855 [opensc-pkcs11] card-piv.c:1039:piv_get_cached_data: get #10
0x7f0cb5988780 13:07:16.855 [opensc-pkcs11] card-piv.c:927:piv_get_data: called
0x7f0cb5988780 13:07:16.855 [opensc-pkcs11] card-piv.c:928:piv_get_data: #10
0x7f0cb5988780 13:07:16.855 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.855 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.855 [opensc-pkcs11] card-piv.c:949:piv_get_data: get len of #10
0x7f0cb5988780 13:07:16.855 [opensc-pkcs11] card-piv.c:494:piv_general_io: called
0x7f0cb5988780 13:07:16.856 [opensc-pkcs11] card-piv.c:499:piv_general_io: cb 3f ff 3 : 0 0
0x7f0cb5988780 13:07:16.856 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.856 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.856 [opensc-pkcs11] card-piv.c:540:piv_general_io: calling sc_transmit_apdu flags=3 le=8, resplen=8, resp=0x7ffea929cea0
0x7f0cb5988780 13:07:16.856 [opensc-pkcs11] apdu.c:554:sc_transmit_apdu: called
0x7f0cb5988780 13:07:16.856 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.856 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.856 [opensc-pkcs11] apdu.c:521:sc_transmit: called
0x7f0cb5988780 13:07:16.856 [opensc-pkcs11] apdu.c:371:sc_single_transmit: called
0x7f0cb5988780 13:07:16.856 [opensc-pkcs11] apdu.c:378:sc_single_transmit: CLA:0, INS:CB, P1:3F, P2:FF, data(3) 0x7ffea929ce98
0x7f0cb5988780 13:07:16.856 [opensc-pkcs11] reader-pcsc.c:283:pcsc_transmit: reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.856 [opensc-pkcs11] reader-pcsc.c:284:pcsc_transmit:
Outgoing APDU (9 bytes):
00 CB 3F FF 03 5C 01 7E 08 ..?..\.~.
0x7f0cb5988780 13:07:16.856 [opensc-pkcs11] reader-pcsc.c:212:pcsc_internal_transmit: called
0x7f0cb5988780 13:07:16.858 [opensc-pkcs11] reader-pcsc.c:293:pcsc_transmit:
Incoming APDU (10 bytes):
7E 12 4F 0B A0 00 00 03 61 0C ~.O.....a.
0x7f0cb5988780 13:07:16.858 [opensc-pkcs11] apdu.c:390:sc_single_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.858 [opensc-pkcs11] apdu.c:543:sc_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.858 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.858 [opensc-pkcs11] card-piv.c:547:piv_general_io: DEE r=0 apdu.resplen=8 sw1=61 sw2=0c
0x7f0cb5988780 13:07:16.858 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] card-piv.c:609:piv_general_io: returning with: 20
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] card-piv.c:972:piv_get_data: buffer for #10 *buf=0x(nil) len=20
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] card-piv.c:494:piv_general_io: called
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] card-piv.c:499:piv_general_io: cb 3f ff 3 : 0 0
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] card-piv.c:540:piv_general_io: calling sc_transmit_apdu flags=1 le=20, resplen=20, resp=0x562af20eb0d0
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] apdu.c:554:sc_transmit_apdu: called
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] apdu.c:521:sc_transmit: called
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] apdu.c:371:sc_single_transmit: called
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] apdu.c:378:sc_single_transmit: CLA:0, INS:CB, P1:3F, P2:FF, data(3) 0x7ffea929ce98
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] reader-pcsc.c:283:pcsc_transmit: reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] reader-pcsc.c:284:pcsc_transmit:
Outgoing APDU (9 bytes):
00 CB 3F FF 03 5C 01 7E 14 ..?..\.~.
0x7f0cb5988780 13:07:16.859 [opensc-pkcs11] reader-pcsc.c:212:pcsc_internal_transmit: called
0x7f0cb5988780 13:07:16.861 [opensc-pkcs11] reader-pcsc.c:293:pcsc_transmit:
Incoming APDU (22 bytes):
7E 12 4F 0B A0 00 00 03 08 00 00 10 00 01 00 5F ~.O............_
2F 02 40 00 90 00 /.@...
0x7f0cb5988780 13:07:16.861 [opensc-pkcs11] apdu.c:390:sc_single_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.861 [opensc-pkcs11] apdu.c:543:sc_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.861 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.861 [opensc-pkcs11] card-piv.c:547:piv_general_io: DEE r=0 apdu.resplen=20 sw1=90 sw2=00
0x7f0cb5988780 13:07:16.861 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.861 [opensc-pkcs11] card-piv.c:609:piv_general_io: returning with: 20
0x7f0cb5988780 13:07:16.861 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.861 [opensc-pkcs11] card-piv.c:985:piv_get_data: returning with: 20
0x7f0cb5988780 13:07:16.861 [opensc-pkcs11] card-piv.c:1055:piv_get_cached_data: added #10 0x562af20eb0d0:20 (nil):0
0x7f0cb5988780 13:07:16.861 [opensc-pkcs11] card-piv.c:1067:piv_get_cached_data: returning with: 20
0x7f0cb5988780 13:07:16.861 [opensc-pkcs11] card-piv.c:2664:piv_process_discovery: Discovery = 0x562af20eb0d0:20
0x7f0cb5988780 13:07:16.861 [opensc-pkcs11] card-piv.c:2617:piv_parse_discovery: Discovery 0x60 0x1e 0x562af20eb0d2:18
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card-piv.c:2622:piv_parse_discovery: Discovery aid=0x562af20eb0d4:11
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card-piv.c:2633:piv_parse_discovery: Discovery pinp=0x562af20eb0e2:2
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card-piv.c:2635:piv_parse_discovery: Discovery pinp flags=0x40 0x00
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card-piv.c:2647:piv_parse_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card-piv.c:2669:piv_process_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card-piv.c:2700:piv_find_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card-piv.c:2681:piv_find_discovery: called
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card-piv.c:927:piv_get_data: called
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card-piv.c:928:piv_get_data: #10
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card-piv.c:972:piv_get_data: buffer for #10 *buf=0x0x7ffea929cfc0 len=256
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card-piv.c:494:piv_general_io: called
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card-piv.c:499:piv_general_io: cb 3f ff 3 : 0 0
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card-piv.c:540:piv_general_io: calling sc_transmit_apdu flags=1 le=256, resplen=256, resp=0x7ffea929cfc0
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] apdu.c:554:sc_transmit_apdu: called
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] apdu.c:521:sc_transmit: called
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] apdu.c:371:sc_single_transmit: called
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] apdu.c:378:sc_single_transmit: CLA:0, INS:CB, P1:3F, P2:FF, data(3) 0x7ffea929cf58
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] reader-pcsc.c:283:pcsc_transmit: reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.862 [opensc-pkcs11] reader-pcsc.c:284:pcsc_transmit:
Outgoing APDU (9 bytes):
00 CB 3F FF 03 5C 01 7E 00 ..?..\.~.
0x7f0cb5988780 13:07:16.863 [opensc-pkcs11] reader-pcsc.c:212:pcsc_internal_transmit: called
0x7f0cb5988780 13:07:16.865 [opensc-pkcs11] reader-pcsc.c:293:pcsc_transmit:
Incoming APDU (22 bytes):
7E 12 4F 0B A0 00 00 03 08 00 00 10 00 01 00 5F ~.O............_
2F 02 40 00 90 00 /.@...
0x7f0cb5988780 13:07:16.865 [opensc-pkcs11] apdu.c:390:sc_single_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.865 [opensc-pkcs11] apdu.c:543:sc_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.865 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.865 [opensc-pkcs11] card-piv.c:547:piv_general_io: DEE r=0 apdu.resplen=20 sw1=90 sw2=00
0x7f0cb5988780 13:07:16.865 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.865 [opensc-pkcs11] card-piv.c:609:piv_general_io: returning with: 20
0x7f0cb5988780 13:07:16.865 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.865 [opensc-pkcs11] card-piv.c:985:piv_get_data: returning with: 20
0x7f0cb5988780 13:07:16.865 [opensc-pkcs11] card-piv.c:2617:piv_parse_discovery: Discovery 0x60 0x1e 0x7ffea929cfc2:18
0x7f0cb5988780 13:07:16.865 [opensc-pkcs11] card-piv.c:2622:piv_parse_discovery: Discovery aid=0x7ffea929cfc4:11
0x7f0cb5988780 13:07:16.865 [opensc-pkcs11] card-piv.c:2647:piv_parse_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.866 [opensc-pkcs11] card-piv.c:2700:piv_find_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.866 [opensc-pkcs11] card-piv.c:3181:piv_init: Max send = 0 recv = 0 card->type = 14004
0x7f0cb5988780 13:07:16.866 [opensc-pkcs11] apdu.c:554:sc_transmit_apdu: called
0x7f0cb5988780 13:07:16.866 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.866 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.866 [opensc-pkcs11] apdu.c:521:sc_transmit: called
0x7f0cb5988780 13:07:16.866 [opensc-pkcs11] apdu.c:371:sc_single_transmit: called
0x7f0cb5988780 13:07:16.866 [opensc-pkcs11] apdu.c:378:sc_single_transmit: CLA:0, INS:FD, P1:0, P2:0, data(0) (nil)
0x7f0cb5988780 13:07:16.866 [opensc-pkcs11] reader-pcsc.c:283:pcsc_transmit: reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.866 [opensc-pkcs11] reader-pcsc.c:284:pcsc_transmit:
Outgoing APDU (5 bytes):
00 FD 00 00 03 .....
0x7f0cb5988780 13:07:16.866 [opensc-pkcs11] reader-pcsc.c:212:pcsc_internal_transmit: called
0x7f0cb5988780 13:07:16.868 [opensc-pkcs11] reader-pcsc.c:293:pcsc_transmit:
Incoming APDU (5 bytes):
04 03 07 90 00 .....
0x7f0cb5988780 13:07:16.868 [opensc-pkcs11] apdu.c:390:sc_single_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.868 [opensc-pkcs11] apdu.c:543:sc_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.868 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card-piv.c:3202:piv_init: Yubico card->type=14004, r=0x00000000 version=0x00040307
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card-piv.c:3261:piv_init: PIV card-type=14004 card_issues=0x00000110
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card-piv.c:2742:piv_process_history: called
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card-piv.c:998:piv_get_cached_data: called
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card-piv.c:999:piv_get_cached_data: #11
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card-piv.c:1039:piv_get_cached_data: get #11
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card-piv.c:927:piv_get_data: called
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card-piv.c:928:piv_get_data: #11
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card-piv.c:949:piv_get_data: get len of #11
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card-piv.c:494:piv_general_io: called
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card-piv.c:499:piv_general_io: cb 3f ff 5 : 0 0
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card-piv.c:540:piv_general_io: calling sc_transmit_apdu flags=3 le=8, resplen=8, resp=0x7ffea929c100
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] apdu.c:554:sc_transmit_apdu: called
0x7f0cb5988780 13:07:16.869 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.870 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.870 [opensc-pkcs11] apdu.c:521:sc_transmit: called
0x7f0cb5988780 13:07:16.870 [opensc-pkcs11] apdu.c:371:sc_single_transmit: called
0x7f0cb5988780 13:07:16.870 [opensc-pkcs11] apdu.c:378:sc_single_transmit: CLA:0, INS:CB, P1:3F, P2:FF, data(5) 0x7ffea929c0f8
0x7f0cb5988780 13:07:16.870 [opensc-pkcs11] reader-pcsc.c:283:pcsc_transmit: reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.870 [opensc-pkcs11] reader-pcsc.c:284:pcsc_transmit:
Outgoing APDU (11 bytes):
00 CB 3F FF 05 5C 03 5F C1 0C 08 ..?..\._...
0x7f0cb5988780 13:07:16.870 [opensc-pkcs11] reader-pcsc.c:212:pcsc_internal_transmit: called
0x7f0cb5988780 13:07:16.872 [opensc-pkcs11] reader-pcsc.c:293:pcsc_transmit:
Incoming APDU (2 bytes):
6A 82 j.
0x7f0cb5988780 13:07:16.872 [opensc-pkcs11] apdu.c:390:sc_single_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.872 [opensc-pkcs11] apdu.c:543:sc_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card-piv.c:547:piv_general_io: DEE r=0 apdu.resplen=0 sw1=6a sw2=82
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] iso7816.c:124:iso7816_check_sw: File not found
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card-piv.c:558:piv_general_io: Card returned error
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card-piv.c:609:piv_general_io: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card-piv.c:985:piv_get_data: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card-piv.c:1067:piv_get_cached_data: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card-piv.c:2928:piv_process_history: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card-piv.c:998:piv_get_cached_data: called
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card-piv.c:999:piv_get_cached_data: #10
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card-piv.c:1012:piv_get_cached_data: found #10 0x562af20eb0d0:20 (nil):0
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card-piv.c:1067:piv_get_cached_data: returning with: 20
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card-piv.c:2664:piv_process_discovery: Discovery = 0x562af20eb0d0:20
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card-piv.c:2617:piv_parse_discovery: Discovery 0x60 0x1e 0x562af20eb0d2:18
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card-piv.c:2622:piv_parse_discovery: Discovery aid=0x562af20eb0d4:11
0x7f0cb5988780 13:07:16.873 [opensc-pkcs11] card-piv.c:2633:piv_parse_discovery: Discovery pinp=0x562af20eb0e2:2
0x7f0cb5988780 13:07:16.874 [opensc-pkcs11] card-piv.c:2635:piv_parse_discovery: Discovery pinp flags=0x40 0x00
0x7f0cb5988780 13:07:16.874 [opensc-pkcs11] card-piv.c:2647:piv_parse_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.874 [opensc-pkcs11] card-piv.c:2669:piv_process_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.874 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.874 [opensc-pkcs11] reader-pcsc.c:662:pcsc_unlock: called
0x7f0cb5988780 13:07:16.879 [opensc-pkcs11] card-piv.c:3302:piv_init: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.879 [opensc-pkcs11] card.c:313:sc_connect_card: card info name:'Yubikey 4', type:14004, flags:0x4, max_send/recv_size:255/256
0x7f0cb5988780 13:07:16.879 [opensc-pkcs11] card.c:1415:sc_card_sm_check: called
0x7f0cb5988780 13:07:16.879 [opensc-pkcs11] card.c:1416:sc_card_sm_check: card->sm_ctx.ops.open (nil)
0x7f0cb5988780 13:07:16.879 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.879 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.879 [opensc-pkcs11] card.c:1424:sc_card_sm_check: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.879 [opensc-pkcs11] card.c:325:sc_connect_card: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.879 [opensc-pkcs11] slot.c:297:card_detect: Yubico Yubikey 4 CCID 00 00: Connected SC card 0x562af21120f0
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] dir.c:163:sc_enum_apps: called
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] card.c:740:sc_select_file: called; type=2, path=3f002f00
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] card-piv.c:2518:piv_select_file: called
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x2F00
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] card-piv.c:421:piv_find_obj_by_containerid: returning with: -1 (Unknown error)
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] card-piv.c:2542:piv_select_file: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] card.c:762:sc_select_file: 'SELECT' error: -1201 (File not found)
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] dir.c:171:sc_enum_apps: Cannot select EF.DIR file: -1201 (File not found)
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] slot.c:304:card_detect: Yubico Yubikey 4 CCID 00 00: Detecting Framework. 0 on-card applications
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] slot.c:305:card_detect: Yubico Yubikey 4 CCID 00 00: generic application <none>
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] slot.c:317:card_detect: Yubico Yubikey 4 CCID 00 00: Detected framework 0. Creating tokens.
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.880 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8E:80:01:80:31:81:54:48:53:4D:31:73:80:21:40:81:07:18
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:84:80:01:47:6f:49:44:00
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:85:80:01:47:6f:49:44:00:00
0x7f0cb5988780 13:07:16.881 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:86:80:01:47:6f:49:44:00:00:00
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:87:80:01:47:6f:49:44:00:00:00:00
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:88:80:01:47:6f:49:44:00:00:00:00:00
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:89:80:01:47:6f:49:44:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8A:80:01:47:6f:49:44:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8B:80:01:47:6f:49:44:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8C:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8D:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.882 [opensc-pkcs11] card.c:1067:match_atr_table: ATR mask: FF:FF:FF:FF:FF:FF:FF:FF:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.883 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8E:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.883 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.883 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8F:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.883 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.883 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.883 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.883 [opensc-pkcs11] slot.c:327:card_detect: Yubico Yubikey 4 CCID 00 00: Try to bind 'generic' token.
0x7f0cb5988780 13:07:16.883 [opensc-pkcs11] framework-pkcs15.c:306:pkcs15_bind: Bind PKCS#15 '<anonymous>' application
0x7f0cb5988780 13:07:16.883 [opensc-pkcs11] pkcs15.c:1234:sc_pkcs15_bind: called
0x7f0cb5988780 13:07:16.883 [opensc-pkcs11] pkcs15.c:1235:sc_pkcs15_bind: application(aid:'empty')
0x7f0cb5988780 13:07:16.883 [opensc-pkcs11] pkcs15.c:1261:sc_pkcs15_bind: PKCS#15 options: use_file_cache=0 use_pin_cache=1 pin_cache_counter=10 pin_cache_ignore_user_consent=0
0x7f0cb5988780 13:07:16.883 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.883 [opensc-pkcs11] reader-pcsc.c:612:pcsc_lock: called
0x7f0cb5988780 13:07:16.884 [opensc-pkcs11] card-piv.c:3576:piv_card_reader_lock_obtained: called
0x7f0cb5988780 13:07:16.884 [opensc-pkcs11] card-piv.c:2681:piv_find_discovery: called
0x7f0cb5988780 13:07:16.884 [opensc-pkcs11] card-piv.c:927:piv_get_data: called
0x7f0cb5988780 13:07:16.884 [opensc-pkcs11] card-piv.c:928:piv_get_data: #10
0x7f0cb5988780 13:07:16.884 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.884 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.884 [opensc-pkcs11] card-piv.c:972:piv_get_data: buffer for #10 *buf=0x0x7ffea929d090 len=256
0x7f0cb5988780 13:07:16.884 [opensc-pkcs11] card-piv.c:494:piv_general_io: called
0x7f0cb5988780 13:07:16.885 [opensc-pkcs11] card-piv.c:499:piv_general_io: cb 3f ff 3 : 255 256
0x7f0cb5988780 13:07:16.885 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.885 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.885 [opensc-pkcs11] card-piv.c:540:piv_general_io: calling sc_transmit_apdu flags=1 le=256, resplen=256, resp=0x7ffea929d090
0x7f0cb5988780 13:07:16.885 [opensc-pkcs11] apdu.c:554:sc_transmit_apdu: called
0x7f0cb5988780 13:07:16.885 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.885 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.885 [opensc-pkcs11] apdu.c:521:sc_transmit: called
0x7f0cb5988780 13:07:16.885 [opensc-pkcs11] apdu.c:371:sc_single_transmit: called
0x7f0cb5988780 13:07:16.885 [opensc-pkcs11] apdu.c:378:sc_single_transmit: CLA:0, INS:CB, P1:3F, P2:FF, data(3) 0x7ffea929d028
0x7f0cb5988780 13:07:16.885 [opensc-pkcs11] reader-pcsc.c:283:pcsc_transmit: reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.885 [opensc-pkcs11] reader-pcsc.c:284:pcsc_transmit:
Outgoing APDU (9 bytes):
00 CB 3F FF 03 5C 01 7E 00 ..?..\.~.
0x7f0cb5988780 13:07:16.885 [opensc-pkcs11] reader-pcsc.c:212:pcsc_internal_transmit: called
0x7f0cb5988780 13:07:16.887 [opensc-pkcs11] reader-pcsc.c:293:pcsc_transmit:
Incoming APDU (22 bytes):
7E 12 4F 0B A0 00 00 03 08 00 00 10 00 01 00 5F ~.O............_
2F 02 40 00 90 00 /.@...
0x7f0cb5988780 13:07:16.887 [opensc-pkcs11] apdu.c:390:sc_single_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.887 [opensc-pkcs11] apdu.c:543:sc_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.887 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.887 [opensc-pkcs11] card-piv.c:547:piv_general_io: DEE r=0 apdu.resplen=20 sw1=90 sw2=00
0x7f0cb5988780 13:07:16.887 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.887 [opensc-pkcs11] card-piv.c:609:piv_general_io: returning with: 20
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] card-piv.c:985:piv_get_data: returning with: 20
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] card-piv.c:2617:piv_parse_discovery: Discovery 0x60 0x1e 0x7ffea929d092:18
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] card-piv.c:2622:piv_parse_discovery: Discovery aid=0x7ffea929d094:11
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] card-piv.c:2647:piv_parse_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] card-piv.c:2700:piv_find_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] card-piv.c:3622:piv_card_reader_lock_obtained: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] pkcs15.c:1272:sc_pkcs15_bind: PKCS#15 emulation enabled
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] pkcs15-syn.c:113:sc_pkcs15_bind_synthetic: called
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] pkcs15-syn.c:154:sc_pkcs15_bind_synthetic: no emulator list in config file, trying all builtin emulators
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] pkcs15-syn.c:156:sc_pkcs15_bind_synthetic: trying westcos
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] pkcs15-westcos.c:255:sc_pkcs15emu_westcos_init_ex: sc_pkcs15_init_func_ex westcos
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] pkcs15-westcos.c:241:westcos_detect_card: westcos_detect_card (Yubikey 4)
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] pkcs15-syn.c:156:sc_pkcs15_bind_synthetic: trying openpgp
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] pkcs15-syn.c:156:sc_pkcs15_bind_synthetic: trying infocamere
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] pkcs15-syn.c:156:sc_pkcs15_bind_synthetic: trying starcert
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] pkcs15-syn.c:156:sc_pkcs15_bind_synthetic: trying tcos
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] pkcs15-syn.c:156:sc_pkcs15_bind_synthetic: trying esteid
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] pkcs15-syn.c:156:sc_pkcs15_bind_synthetic: trying itacns
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] pkcs15-itacns.c:865:sc_pkcs15emu_itacns_init_ex: called
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] pkcs15-syn.c:156:sc_pkcs15_bind_synthetic: trying postecert
0x7f0cb5988780 13:07:16.888 [opensc-pkcs11] pkcs15-syn.c:156:sc_pkcs15_bind_synthetic: trying PIV-II
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] pkcs15-piv.c:1205:sc_pkcs15emu_piv_init_ex: called
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] pkcs15-piv.c:238:piv_detect_card: called
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] pkcs15-piv.c:618:sc_pkcs15emu_piv_init: called
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=5 ptr=0x7ffea929beb0
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card-piv.c:2095:piv_get_serial_nr_from_CHUI: called
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card-piv.c:998:piv_get_cached_data: called
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card-piv.c:999:piv_get_cached_data: #1
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card-piv.c:1039:piv_get_cached_data: get #1
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card-piv.c:927:piv_get_data: called
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card-piv.c:928:piv_get_data: #1
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card-piv.c:949:piv_get_data: get len of #1
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card-piv.c:494:piv_general_io: called
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card-piv.c:499:piv_general_io: cb 3f ff 5 : 255 256
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card-piv.c:540:piv_general_io: calling sc_transmit_apdu flags=3 le=8, resplen=8, resp=0x7ffea929bca0
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] apdu.c:554:sc_transmit_apdu: called
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] apdu.c:521:sc_transmit: called
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] apdu.c:371:sc_single_transmit: called
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] apdu.c:378:sc_single_transmit: CLA:0, INS:CB, P1:3F, P2:FF, data(5) 0x7ffea929bc98
0x7f0cb5988780 13:07:16.889 [opensc-pkcs11] reader-pcsc.c:283:pcsc_transmit: reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.890 [opensc-pkcs11] reader-pcsc.c:284:pcsc_transmit:
Outgoing APDU (11 bytes):
00 CB 3F FF 05 5C 03 5F C1 02 08 ..?..\._...
0x7f0cb5988780 13:07:16.890 [opensc-pkcs11] reader-pcsc.c:212:pcsc_internal_transmit: called
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] reader-pcsc.c:293:pcsc_transmit:
Incoming APDU (2 bytes):
6A 82 j.
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] apdu.c:390:sc_single_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] apdu.c:543:sc_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] card-piv.c:547:piv_general_io: DEE r=0 apdu.resplen=0 sw1=6a sw2=82
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] iso7816.c:124:iso7816_check_sw: File not found
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] card-piv.c:558:piv_general_io: Card returned error
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] card-piv.c:609:piv_general_io: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] card-piv.c:985:piv_get_data: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] card-piv.c:1067:piv_get_cached_data: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] card-piv.c:2109:piv_get_serial_nr_from_CHUI: Failure retrieving CHUI: -1201 (File not found)
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] pkcs15-piv.c:637:sc_pkcs15emu_piv_init: sc_card_ctl rc=-1201
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] pkcs15-piv.c:648:sc_pkcs15emu_piv_init: PIV-II adding objects...
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.892 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0xDB00
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x3000
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 1
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x3010
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:421:piv_find_obj_by_containerid: returning with: -1 (Unknown error)
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x0101
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 2
0x7f0cb5988780 13:07:16.893 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x6010
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 3
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x3001
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 4
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x6030
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 5
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.894 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x0100
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 6
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x0102
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 7
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x0500
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 8
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.895 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x9000
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 9
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x6050
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 10
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x6060
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 11
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1015
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 32
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.896 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1001
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 12
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1002
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 13
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1003
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 14
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1004
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 15
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1005
0x7f0cb5988780 13:07:16.897 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 16
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1006
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 17
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1007
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 18
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1008
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 19
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1009
0x7f0cb5988780 13:07:16.898 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 20
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x100A
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 21
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x100B
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 22
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x100C
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 23
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x100D
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 24
0x7f0cb5988780 13:07:16.899 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x100E
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 25
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x100F
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 26
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1010
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 27
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1011
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 28
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.900 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1012
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 29
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1013
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 30
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c3f8
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1014
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 31
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] pkcs15-piv.c:708:sc_pkcs15emu_piv_init: PIV-II adding certs...
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x0101
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 2
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.901 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] pkcs15.c:2348:sc_pkcs15_read_file: called
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] pkcs15.c:2349:sc_pkcs15_read_file: path=0101cece, index=0, count=-1
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card.c:740:sc_select_file: called; type=2, path=0101cece
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card-piv.c:2518:piv_select_file: called
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x0101
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 2
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card-piv.c:998:piv_get_cached_data: called
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card-piv.c:999:piv_get_cached_data: #2
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card-piv.c:1039:piv_get_cached_data: get #2
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card-piv.c:927:piv_get_data: called
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card-piv.c:928:piv_get_data: #2
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card-piv.c:949:piv_get_data: get len of #2
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card-piv.c:494:piv_general_io: called
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card-piv.c:499:piv_general_io: cb 3f ff 5 : 255 256
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card-piv.c:540:piv_general_io: calling sc_transmit_apdu flags=3 le=8, resplen=8, resp=0x7ffea929bbb0
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] apdu.c:554:sc_transmit_apdu: called
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] apdu.c:521:sc_transmit: called
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] apdu.c:371:sc_single_transmit: called
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] apdu.c:378:sc_single_transmit: CLA:0, INS:CB, P1:3F, P2:FF, data(5) 0x7ffea929bba8
0x7f0cb5988780 13:07:16.902 [opensc-pkcs11] reader-pcsc.c:283:pcsc_transmit: reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.903 [opensc-pkcs11] reader-pcsc.c:284:pcsc_transmit:
Outgoing APDU (11 bytes):
00 CB 3F FF 05 5C 03 5F C1 05 08 ..?..\._...
0x7f0cb5988780 13:07:16.903 [opensc-pkcs11] reader-pcsc.c:212:pcsc_internal_transmit: called
0x7f0cb5988780 13:07:16.905 [opensc-pkcs11] reader-pcsc.c:293:pcsc_transmit:
Incoming APDU (2 bytes):
6A 82 j.
0x7f0cb5988780 13:07:16.905 [opensc-pkcs11] apdu.c:390:sc_single_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.905 [opensc-pkcs11] apdu.c:543:sc_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.905 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.905 [opensc-pkcs11] card-piv.c:547:piv_general_io: DEE r=0 apdu.resplen=0 sw1=6a sw2=82
0x7f0cb5988780 13:07:16.905 [opensc-pkcs11] iso7816.c:124:iso7816_check_sw: File not found
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:558:piv_general_io: Card returned error
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:609:piv_general_io: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:985:piv_get_data: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:1067:piv_get_cached_data: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:2562:piv_select_file: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card.c:762:sc_select_file: 'SELECT' error: -1201 (File not found)
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] pkcs15.c:2451:sc_pkcs15_read_file: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] pkcs15-piv.c:746:sc_pkcs15emu_piv_init: No cert found,i=0
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x0100
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 6
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] pkcs15.c:2348:sc_pkcs15_read_file: called
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] pkcs15.c:2349:sc_pkcs15_read_file: path=0100cece, index=0, count=-1
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card.c:740:sc_select_file: called; type=2, path=0100cece
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:2518:piv_select_file: called
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x0100
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 6
0x7f0cb5988780 13:07:16.906 [opensc-pkcs11] card-piv.c:998:piv_get_cached_data: called
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] card-piv.c:999:piv_get_cached_data: #6
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] card-piv.c:1039:piv_get_cached_data: get #6
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] card-piv.c:927:piv_get_data: called
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] card-piv.c:928:piv_get_data: #6
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] card-piv.c:949:piv_get_data: get len of #6
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] card-piv.c:494:piv_general_io: called
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] card-piv.c:499:piv_general_io: cb 3f ff 5 : 255 256
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] card-piv.c:540:piv_general_io: calling sc_transmit_apdu flags=3 le=8, resplen=8, resp=0x7ffea929bbb0
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] apdu.c:554:sc_transmit_apdu: called
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] apdu.c:521:sc_transmit: called
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] apdu.c:371:sc_single_transmit: called
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] apdu.c:378:sc_single_transmit: CLA:0, INS:CB, P1:3F, P2:FF, data(5) 0x7ffea929bba8
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] reader-pcsc.c:283:pcsc_transmit: reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] reader-pcsc.c:284:pcsc_transmit:
Outgoing APDU (11 bytes):
00 CB 3F FF 05 5C 03 5F C1 0A 08 ..?..\._...
0x7f0cb5988780 13:07:16.907 [opensc-pkcs11] reader-pcsc.c:212:pcsc_internal_transmit: called
0x7f0cb5988780 13:07:16.909 [opensc-pkcs11] reader-pcsc.c:293:pcsc_transmit:
Incoming APDU (2 bytes):
6A 82 j.
0x7f0cb5988780 13:07:16.909 [opensc-pkcs11] apdu.c:390:sc_single_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.909 [opensc-pkcs11] apdu.c:543:sc_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.909 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.909 [opensc-pkcs11] card-piv.c:547:piv_general_io: DEE r=0 apdu.resplen=0 sw1=6a sw2=82
0x7f0cb5988780 13:07:16.909 [opensc-pkcs11] iso7816.c:124:iso7816_check_sw: File not found
0x7f0cb5988780 13:07:16.909 [opensc-pkcs11] card-piv.c:558:piv_general_io: Card returned error
0x7f0cb5988780 13:07:16.909 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.909 [opensc-pkcs11] card-piv.c:609:piv_general_io: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:985:piv_get_data: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:1067:piv_get_cached_data: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:2562:piv_select_file: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card.c:762:sc_select_file: 'SELECT' error: -1201 (File not found)
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] pkcs15.c:2451:sc_pkcs15_read_file: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] pkcs15-piv.c:746:sc_pkcs15emu_piv_init: No cert found,i=1
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x0102
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 7
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] pkcs15.c:2348:sc_pkcs15_read_file: called
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] pkcs15.c:2349:sc_pkcs15_read_file: path=0102cece, index=0, count=-1
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card.c:740:sc_select_file: called; type=2, path=0102cece
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:2518:piv_select_file: called
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x0102
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 7
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:998:piv_get_cached_data: called
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:999:piv_get_cached_data: #7
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:1039:piv_get_cached_data: get #7
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:927:piv_get_data: called
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:928:piv_get_data: #7
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:949:piv_get_data: get len of #7
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:494:piv_general_io: called
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:499:piv_general_io: cb 3f ff 5 : 255 256
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.910 [opensc-pkcs11] card-piv.c:540:piv_general_io: calling sc_transmit_apdu flags=3 le=8, resplen=8, resp=0x7ffea929bbb0
0x7f0cb5988780 13:07:16.911 [opensc-pkcs11] apdu.c:554:sc_transmit_apdu: called
0x7f0cb5988780 13:07:16.911 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.911 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.911 [opensc-pkcs11] apdu.c:521:sc_transmit: called
0x7f0cb5988780 13:07:16.911 [opensc-pkcs11] apdu.c:371:sc_single_transmit: called
0x7f0cb5988780 13:07:16.911 [opensc-pkcs11] apdu.c:378:sc_single_transmit: CLA:0, INS:CB, P1:3F, P2:FF, data(5) 0x7ffea929bba8
0x7f0cb5988780 13:07:16.911 [opensc-pkcs11] reader-pcsc.c:283:pcsc_transmit: reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.911 [opensc-pkcs11] reader-pcsc.c:284:pcsc_transmit:
Outgoing APDU (11 bytes):
00 CB 3F FF 05 5C 03 5F C1 0B 08 ..?..\._...
0x7f0cb5988780 13:07:16.911 [opensc-pkcs11] reader-pcsc.c:212:pcsc_internal_transmit: called
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] reader-pcsc.c:293:pcsc_transmit:
Incoming APDU (2 bytes):
6A 82 j.
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] apdu.c:390:sc_single_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] apdu.c:543:sc_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card-piv.c:547:piv_general_io: DEE r=0 apdu.resplen=0 sw1=6a sw2=82
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] iso7816.c:124:iso7816_check_sw: File not found
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card-piv.c:558:piv_general_io: Card returned error
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card-piv.c:609:piv_general_io: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card-piv.c:985:piv_get_data: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card-piv.c:1067:piv_get_cached_data: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card-piv.c:2562:piv_select_file: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card.c:762:sc_select_file: 'SELECT' error: -1201 (File not found)
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] pkcs15.c:2451:sc_pkcs15_read_file: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] pkcs15-piv.c:746:sc_pkcs15emu_piv_init: No cert found,i=2
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x0500
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 8
0x7f0cb5988780 13:07:16.913 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] pkcs15.c:2348:sc_pkcs15_read_file: called
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] pkcs15.c:2349:sc_pkcs15_read_file: path=0500cece, index=0, count=-1
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card.c:740:sc_select_file: called; type=2, path=0500cece
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card-piv.c:2518:piv_select_file: called
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x0500
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 8
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card-piv.c:998:piv_get_cached_data: called
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card-piv.c:999:piv_get_cached_data: #8
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card-piv.c:1039:piv_get_cached_data: get #8
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card-piv.c:927:piv_get_data: called
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card-piv.c:928:piv_get_data: #8
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card-piv.c:949:piv_get_data: get len of #8
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card-piv.c:494:piv_general_io: called
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card-piv.c:499:piv_general_io: cb 3f ff 5 : 255 256
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card-piv.c:540:piv_general_io: calling sc_transmit_apdu flags=3 le=8, resplen=8, resp=0x7ffea929bbb0
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] apdu.c:554:sc_transmit_apdu: called
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] apdu.c:521:sc_transmit: called
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] apdu.c:371:sc_single_transmit: called
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] apdu.c:378:sc_single_transmit: CLA:0, INS:CB, P1:3F, P2:FF, data(5) 0x7ffea929bba8
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] reader-pcsc.c:283:pcsc_transmit: reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] reader-pcsc.c:284:pcsc_transmit:
Outgoing APDU (11 bytes):
00 CB 3F FF 05 5C 03 5F C1 01 08 ..?..\._...
0x7f0cb5988780 13:07:16.914 [opensc-pkcs11] reader-pcsc.c:212:pcsc_internal_transmit: called
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] reader-pcsc.c:293:pcsc_transmit:
Incoming APDU (2 bytes):
6A 82 j.
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] apdu.c:390:sc_single_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] apdu.c:543:sc_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card-piv.c:547:piv_general_io: DEE r=0 apdu.resplen=0 sw1=6a sw2=82
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] iso7816.c:124:iso7816_check_sw: File not found
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card-piv.c:558:piv_general_io: Card returned error
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card-piv.c:609:piv_general_io: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card-piv.c:985:piv_get_data: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card-piv.c:1067:piv_get_cached_data: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card-piv.c:2562:piv_select_file: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card.c:762:sc_select_file: 'SELECT' error: -1201 (File not found)
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] pkcs15.c:2451:sc_pkcs15_read_file: returning with: -1201 (File not found)
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] pkcs15-piv.c:746:sc_pkcs15emu_piv_init: No cert found,i=3
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.916 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1001
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 12
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=4
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1002
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 13
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=5
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1003
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 14
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=6
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1004
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 15
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=7
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.917 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1005
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 16
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=8
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1006
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 17
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=9
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1007
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 18
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=10
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1008
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 19
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=11
0x7f0cb5988780 13:07:16.918 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1009
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 20
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=12
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x100A
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 21
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=13
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x100B
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 22
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=14
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x100C
0x7f0cb5988780 13:07:16.919 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 23
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=15
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x100D
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 24
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=16
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x100E
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 25
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=17
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x100F
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 26
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=18
0x7f0cb5988780 13:07:16.920 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1010
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 27
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=19
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1011
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 28
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=20
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1012
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 29
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=21
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1013
0x7f0cb5988780 13:07:16.921 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 30
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=22
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983428 ptr=0x7ffea929c040
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] card-piv.c:413:piv_find_obj_by_containerid: called
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] card-piv.c:414:piv_find_obj_by_containerid: str=0x1014
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] card-piv.c:418:piv_find_obj_by_containerid: returning with: 31
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] card-piv.c:2171:piv_is_object_present: returning with: 1
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 1
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] pkcs15-piv.c:739:sc_pkcs15emu_piv_init: Cert can not be present,i=23
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] pkcs15-piv.c:927:sc_pkcs15emu_piv_init: PIV-II adding pins...
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=1346983427 ptr=0x7ffea929bea0
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] card-piv.c:2184:piv_get_pin_preference: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] card.c:922:sc_card_ctl: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] pkcs15-piv.c:958:sc_pkcs15emu_piv_init: DEE Adding pin 0 label=PIN
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] pkcs15-piv.c:958:sc_pkcs15emu_piv_init: DEE Adding pin 1 label=PIV PUK
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] pkcs15-piv.c:982:sc_pkcs15emu_piv_init: PIV-II adding pub keys...
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=0
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env PIV_9A_KEY
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] pkcs15-piv.c:1033:sc_pkcs15emu_piv_init: DEE look for file NULL
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=1
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env PIV_9C_KEY
0x7f0cb5988780 13:07:16.922 [opensc-pkcs11] pkcs15-piv.c:1033:sc_pkcs15emu_piv_init: DEE look for file NULL
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=2
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env PIV_9D_KEY
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1033:sc_pkcs15emu_piv_init: DEE look for file NULL
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=3
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env PIV_9E_KEY
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1033:sc_pkcs15emu_piv_init: DEE look for file NULL
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=4
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=5
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=6
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=7
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=8
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=9
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=10
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=11
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=12
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.923 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=13
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=14
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=15
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=16
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=17
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=18
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=19
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=20
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=21
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=22
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1015:sc_pkcs15emu_piv_init: No cert for this pub key i=23
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1027:sc_pkcs15emu_piv_init: DEE look for env NULL
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1127:sc_pkcs15emu_piv_init: PIV-II adding private keys...
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-piv.c:1196:sc_pkcs15emu_piv_init: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] pkcs15-syn.c:190:sc_pkcs15_bind_synthetic: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.924 [opensc-pkcs11] reader-pcsc.c:662:pcsc_unlock: called
0x7f0cb5988780 13:07:16.933 [opensc-pkcs11] pkcs15.c:1300:sc_pkcs15_bind: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8E:80:01:80:31:81:54:48:53:4D:31:73:80:21:40:81:07:18
0x7f0cb5988780 13:07:16.934 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:84:80:01:47:6f:49:44:00
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:85:80:01:47:6f:49:44:00:00
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:86:80:01:47:6f:49:44:00:00:00
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:87:80:01:47:6f:49:44:00:00:00:00
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:88:80:01:47:6f:49:44:00:00:00:00:00
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:89:80:01:47:6f:49:44:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8A:80:01:47:6f:49:44:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8B:80:01:47:6f:49:44:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8C:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8D:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1067:match_atr_table: ATR mask: FF:FF:FF:FF:FF:FF:FF:FF:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8E:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8F:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.935 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1060: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
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8E:80:01:80:31:81:54:48:53:4D:31:73:80:21:40:81:07:18
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:84:80:01:47:6f:49:44:00
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:85:80:01:47:6f:49:44:00:00
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:86:80:01:47:6f:49:44:00:00:00
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.936 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:87:80:01:47:6f:49:44:00:00:00:00
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:88:80:01:47:6f:49:44:00:00:00:00:00
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:89:80:01:47:6f:49:44:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8A:80:01:47:6f:49:44:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8B:80:01:47:6f:49:44:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8C:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8D:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1067:match_atr_table: ATR mask: FF:FF:FF:FF:FF:FF:FF:FF:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8E:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3B:8F:80:01:47:6f:49:44:00:00:00:00:00:00:00:00:00:00:00:00
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1063:match_atr_table: ignored - wrong length
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1049:match_atr_table: ATR : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.937 [opensc-pkcs11] card.c:1060:match_atr_table: ATR try : 3b:f8:13:00:00:81:31:fe:15:59:75:62:69:6b:65:79:34:d4
0x7f0cb5988780 13:07:16.940 [opensc-pkcs11] slot.c:340:card_detect: Yubico Yubikey 4 CCID 00 00: Creating 'generic' token.
0x7f0cb5988780 13:07:16.940 [opensc-pkcs11] framework-pkcs15.c:1391:pkcs15_create_tokens: create PKCS#15 tokens; fws:0x562af2113730,(nil),(nil)
0x7f0cb5988780 13:07:16.940 [opensc-pkcs11] framework-pkcs15.c:1392:pkcs15_create_tokens: create slots flags 0x8
0x7f0cb5988780 13:07:16.940 [opensc-pkcs11] framework-pkcs15.c:1401:pkcs15_create_tokens: Use FW data with index 0; fw_data->p15_card 0x562af2113990
0x7f0cb5988780 13:07:16.940 [opensc-pkcs11] pkcs15.c:1741:sc_pkcs15_find_pin_by_flags: called
0x7f0cb5988780 13:07:16.940 [opensc-pkcs11] pkcs15.c:1742:sc_pkcs15_find_pin_by_flags: Find PIN flags:0x10, mask:0xD2, index:-1
0x7f0cb5988780 13:07:16.940 [opensc-pkcs11] pkcs15.c:1768:sc_pkcs15_find_pin_by_flags: returning with: -1407 (Requested object not found)
0x7f0cb5988780 13:07:16.940 [opensc-pkcs11] pkcs15.c:1741:sc_pkcs15_find_pin_by_flags: called
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] pkcs15.c:1742:sc_pkcs15_find_pin_by_flags: Find PIN flags:0x12, mask:0xD2, index:-1
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] pkcs15.c:1765:sc_pkcs15_find_pin_by_flags: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] framework-pkcs15.c:1407:pkcs15_create_tokens: Flags:0x8; Auth User/Sign PINs 0x562af211ef80/(nil)
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] framework-pkcs15.c:826:pkcs15_create_pkcs11_objects: Found 0 RSA private keys
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] framework-pkcs15.c:826:pkcs15_create_pkcs11_objects: Found 0 RSA public keys
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] framework-pkcs15.c:826:pkcs15_create_pkcs11_objects: Found 0 EC private keys
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] framework-pkcs15.c:826:pkcs15_create_pkcs11_objects: Found 0 EC public keys
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] framework-pkcs15.c:826:pkcs15_create_pkcs11_objects: Found 0 GOSTR3410 private keys
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] framework-pkcs15.c:826:pkcs15_create_pkcs11_objects: Found 0 GOSTR3410 public keys
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] framework-pkcs15.c:826:pkcs15_create_pkcs11_objects: Found 0 certificates
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] framework-pkcs15.c:826:pkcs15_create_pkcs11_objects: Found 13 data objects
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] framework-pkcs15.c:936:pkcs15_bind_related_objects: Looking for objects related to object 0
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] framework-pkcs15.c:936:pkcs15_bind_related_objects: Looking for objects related to object 1
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] framework-pkcs15.c:936:pkcs15_bind_related_objects: Looking for objects related to object 2
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] framework-pkcs15.c:936:pkcs15_bind_related_objects: Looking for objects related to object 3
0x7f0cb5988780 13:07:16.941 [opensc-pkcs11] framework-pkcs15.c:936:pkcs15_bind_related_objects: Looking for objects related to object 4
0x7f0cb5988780 13:07:16.942 [opensc-pkcs11] framework-pkcs15.c:936:pkcs15_bind_related_objects: Looking for objects related to object 5
0x7f0cb5988780 13:07:16.942 [opensc-pkcs11] framework-pkcs15.c:936:pkcs15_bind_related_objects: Looking for objects related to object 6
0x7f0cb5988780 13:07:16.942 [opensc-pkcs11] framework-pkcs15.c:936:pkcs15_bind_related_objects: Looking for objects related to object 7
0x7f0cb5988780 13:07:16.942 [opensc-pkcs11] framework-pkcs15.c:936:pkcs15_bind_related_objects: Looking for objects related to object 8
0x7f0cb5988780 13:07:16.942 [opensc-pkcs11] framework-pkcs15.c:936:pkcs15_bind_related_objects: Looking for objects related to object 9
0x7f0cb5988780 13:07:16.942 [opensc-pkcs11] framework-pkcs15.c:936:pkcs15_bind_related_objects: Looking for objects related to object 10
0x7f0cb5988780 13:07:16.942 [opensc-pkcs11] framework-pkcs15.c:936:pkcs15_bind_related_objects: Looking for objects related to object 11
0x7f0cb5988780 13:07:16.942 [opensc-pkcs11] framework-pkcs15.c:936:pkcs15_bind_related_objects: Looking for objects related to object 12
0x7f0cb5988780 13:07:16.942 [opensc-pkcs11] framework-pkcs15.c:1176:_pkcs15_create_typed_objects: found 13 FW objects
0x7f0cb5988780 13:07:16.942 [opensc-pkcs11] framework-pkcs15.c:1413:pkcs15_create_tokens: Found 13 FW objects objects
0x7f0cb5988780 13:07:16.942 [opensc-pkcs11] framework-pkcs15.c:1429:pkcs15_create_tokens: Found 2 authentication objects
0x7f0cb5988780 13:07:16.942 [opensc-pkcs11] framework-pkcs15.c:1438:pkcs15_create_tokens: Found authentication object 'PIN'
0x7f0cb5988780 13:07:16.942 [opensc-pkcs11] framework-pkcs15.c:1112:pkcs15_create_slot: Create slot (p11card 0x562af21120a0, fw_data 0x562af2113730, auth 0x562af211ef80, app_info (nil))
0x7f0cb5988780 13:07:16.942 [opensc-pkcs11] slot.c:424:slot_allocate: Allocated slot 0x0 for card in reader Yubico Yubikey 4 CCID 00 00
0x7f0cb5988780 13:07:16.942 [opensc-pkcs11] framework-pkcs15.c:1049:pkcs15_init_slot: Called
0x7f0cb5988780 13:07:16.943 [opensc-pkcs11] framework-pkcs15.c:1100:pkcs15_init_slot: Initialized token 'PIV_II' in slot 0x0
0x7f0cb5988780 13:07:16.943 [opensc-pkcs11] framework-pkcs15.c:1299:_add_pin_related_objects: Add objects related to PIN('PIN',ID:01)
0x7f0cb5988780 13:07:16.943 [opensc-pkcs11] framework-pkcs15.c:1311:_add_pin_related_objects: ObjID(0x562af212d2c0,Cardholder Fingerprints,500):01
0x7f0cb5988780 13:07:16.943 [opensc-pkcs11] framework-pkcs15.c:1322:_add_pin_related_objects: Slot:0x562af21114e0 Adding data object 4 to PIN 'PIN'
0x7f0cb5988780 13:07:16.943 [opensc-pkcs11] framework-pkcs15.c:999:pkcs15_add_object: Slot:0 Setting object handle of 0x0 to 0x562af212d2c0
0x7f0cb5988780 13:07:16.943 [opensc-pkcs11] framework-pkcs15.c:1311:_add_pin_related_objects: ObjID(0x562af212d320,Printed Information,500):01
0x7f0cb5988780 13:07:16.943 [opensc-pkcs11] framework-pkcs15.c:1322:_add_pin_related_objects: Slot:0x562af21114e0 Adding data object 5 to PIN 'PIN'
0x7f0cb5988780 13:07:16.943 [opensc-pkcs11] framework-pkcs15.c:999:pkcs15_add_object: Slot:0 Setting object handle of 0x0 to 0x562af212d320
0x7f0cb5988780 13:07:16.943 [opensc-pkcs11] framework-pkcs15.c:1311:_add_pin_related_objects: ObjID(0x562af212d380,Cardholder Facial Image,500):01
0x7f0cb5988780 13:07:16.943 [opensc-pkcs11] framework-pkcs15.c:1322:_add_pin_related_objects: Slot:0x562af21114e0 Adding data object 6 to PIN 'PIN'
0x7f0cb5988780 13:07:16.943 [opensc-pkcs11] framework-pkcs15.c:999:pkcs15_add_object: Slot:0 Setting object handle of 0x0 to 0x562af212d380
0x7f0cb5988780 13:07:16.943 [opensc-pkcs11] framework-pkcs15.c:1311:_add_pin_related_objects: ObjID(0x562af212d5c0,Cardholder Iris Image,500):
0x7f0cb5988780 13:07:16.943 [opensc-pkcs11] framework-pkcs15.c:1313:_add_pin_related_objects: Ignoring object 12
0x7f0cb5988780 13:07:16.943 [opensc-pkcs11] framework-pkcs15.c:1487:pkcs15_create_tokens: Add public objects to slot 0x562af21114e0
0x7f0cb5988780 13:07:16.943 [opensc-pkcs11] framework-pkcs15.c:1355:_add_public_objects: 13 public objects to process
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:1376:_add_public_objects: Add public object(0x562af212d140,Card Capability Container,500)
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:999:pkcs15_add_object: Slot:0 Setting object handle of 0x0 to 0x562af212d140
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:1376:_add_public_objects: Add public object(0x562af212d1a0,Card Holder Unique Identifier,500)
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:999:pkcs15_add_object: Slot:0 Setting object handle of 0x0 to 0x562af212d1a0
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:1376:_add_public_objects: Add public object(0x562af212d200,Unsigned Card Holder Unique Identifier,500)
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:999:pkcs15_add_object: Slot:0 Setting object handle of 0x0 to 0x562af212d200
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:1376:_add_public_objects: Add public object(0x562af212d260,X.509 Certificate for PIV Authentication,500)
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:999:pkcs15_add_object: Slot:0 Setting object handle of 0x0 to 0x562af212d260
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:1376:_add_public_objects: Add public object(0x562af212d3e0,X.509 Certificate for Digital Signature,500)
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:999:pkcs15_add_object: Slot:0 Setting object handle of 0x0 to 0x562af212d3e0
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:1376:_add_public_objects: Add public object(0x562af212d440,X.509 Certificate for Key Management,500)
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:999:pkcs15_add_object: Slot:0 Setting object handle of 0x0 to 0x562af212d440
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:1376:_add_public_objects: Add public object(0x562af212d4a0,X.509 Certificate for Card Authentication,500)
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:999:pkcs15_add_object: Slot:0 Setting object handle of 0x0 to 0x562af212d4a0
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:1376:_add_public_objects: Add public object(0x562af212d500,Security Object,500)
0x7f0cb5988780 13:07:16.944 [opensc-pkcs11] framework-pkcs15.c:999:pkcs15_add_object: Slot:0 Setting object handle of 0x0 to 0x562af212d500
0x7f0cb5988780 13:07:16.945 [opensc-pkcs11] framework-pkcs15.c:1376:_add_public_objects: Add public object(0x562af212d560,Discovery Object,500)
0x7f0cb5988780 13:07:16.945 [opensc-pkcs11] framework-pkcs15.c:999:pkcs15_add_object: Slot:0 Setting object handle of 0x0 to 0x562af212d560
0x7f0cb5988780 13:07:16.945 [opensc-pkcs11] framework-pkcs15.c:1491:pkcs15_create_tokens: All tokens created
0x7f0cb5988780 13:07:16.945 [opensc-pkcs11] slot.c:377:card_detect: Yubico Yubikey 4 CCID 00 00: Detection ended
0x7f0cb5988780 13:07:16.945 [opensc-pkcs11] slot.c:185:initialize_reader: Reader 'Yubico Yubikey 4 CCID 00 00' initialized
0x7f0cb5988780 13:07:16.945 [opensc-pkcs11] pkcs11-global.c:282:C_Initialize: C_Initialize() = CKR_OK
0x7f0cb5988780 13:07:16.945 [opensc-pkcs11] pkcs11-global.c:401:C_GetSlotList: C_GetSlotList(token=0, plug-n-play)
0x7f0cb5988780 13:07:16.945 [opensc-pkcs11] reader-pcsc.c:1282:pcsc_detect_readers: called
0x7f0cb5988780 13:07:16.945 [opensc-pkcs11] reader-pcsc.c:1301:pcsc_detect_readers: Probing PC/SC readers
0x7f0cb5988780 13:07:16.945 [opensc-pkcs11] reader-pcsc.c:1422:pcsc_detect_readers: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.945 [opensc-pkcs11] slot.c:387:card_detect_all: Detect all cards
0x7f0cb5988780 13:07:16.945 [opensc-pkcs11] slot.c:233:card_detect: Yubico Yubikey 4 CCID 00 00: Detecting smart card
0x7f0cb5988780 13:07:16.945 [opensc-pkcs11] sc.c:275:sc_detect_card_presence: called
0x7f0cb5988780 13:07:16.945 [opensc-pkcs11] reader-pcsc.c:411:pcsc_detect_card_presence: called
0x7f0cb5988780 13:07:16.945 [opensc-pkcs11] reader-pcsc.c:319:refresh_attributes: Yubico Yubikey 4 CCID 00 00 check
0x7f0cb5988780 13:07:16.947 [opensc-pkcs11] reader-pcsc.c:339:refresh_attributes: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.947 [opensc-pkcs11] reader-pcsc.c:416:pcsc_detect_card_presence: returning with: 1
0x7f0cb5988780 13:07:16.947 [opensc-pkcs11] sc.c:280:sc_detect_card_presence: returning with: 1
0x7f0cb5988780 13:07:16.947 [opensc-pkcs11] slot.c:377:card_detect: Yubico Yubikey 4 CCID 00 00: Detection ended
0x7f0cb5988780 13:07:16.947 [opensc-pkcs11] slot.c:406:card_detect_all: All cards detected
0x7f0cb5988780 13:07:16.947 [opensc-pkcs11] pkcs11-global.c:437:C_GetSlotList: was only a size inquiry (1)
0x7f0cb5988780 13:07:16.948 [opensc-pkcs11] pkcs11-global.c:401:C_GetSlotList: C_GetSlotList(token=0, refresh)
0x7f0cb5988780 13:07:16.948 [opensc-pkcs11] slot.c:387:card_detect_all: Detect all cards
0x7f0cb5988780 13:07:16.948 [opensc-pkcs11] slot.c:233:card_detect: Yubico Yubikey 4 CCID 00 00: Detecting smart card
0x7f0cb5988780 13:07:16.948 [opensc-pkcs11] sc.c:275:sc_detect_card_presence: called
0x7f0cb5988780 13:07:16.948 [opensc-pkcs11] reader-pcsc.c:411:pcsc_detect_card_presence: called
0x7f0cb5988780 13:07:16.948 [opensc-pkcs11] reader-pcsc.c:319:refresh_attributes: Yubico Yubikey 4 CCID 00 00 check
0x7f0cb5988780 13:07:16.950 [opensc-pkcs11] reader-pcsc.c:339:refresh_attributes: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.950 [opensc-pkcs11] reader-pcsc.c:416:pcsc_detect_card_presence: returning with: 1
0x7f0cb5988780 13:07:16.950 [opensc-pkcs11] sc.c:280:sc_detect_card_presence: returning with: 1
0x7f0cb5988780 13:07:16.950 [opensc-pkcs11] slot.c:377:card_detect: Yubico Yubikey 4 CCID 00 00: Detection ended
0x7f0cb5988780 13:07:16.950 [opensc-pkcs11] slot.c:406:card_detect_all: All cards detected
0x7f0cb5988780 13:07:16.950 [opensc-pkcs11] pkcs11-global.c:454:C_GetSlotList: returned 1 slots
0x7f0cb5988780 13:07:16.950 [opensc-pkcs11] pkcs11-global.c:505:C_GetSlotInfo: C_GetSlotInfo(0x0)
0x7f0cb5988780 13:07:16.950 [opensc-pkcs11] slot.c:387:card_detect_all: Detect all cards
0x7f0cb5988780 13:07:16.950 [opensc-pkcs11] slot.c:233:card_detect: Yubico Yubikey 4 CCID 00 00: Detecting smart card
0x7f0cb5988780 13:07:16.950 [opensc-pkcs11] sc.c:275:sc_detect_card_presence: called
0x7f0cb5988780 13:07:16.950 [opensc-pkcs11] reader-pcsc.c:411:pcsc_detect_card_presence: called
0x7f0cb5988780 13:07:16.950 [opensc-pkcs11] reader-pcsc.c:319:refresh_attributes: Yubico Yubikey 4 CCID 00 00 check
0x7f0cb5988780 13:07:16.952 [opensc-pkcs11] reader-pcsc.c:339:refresh_attributes: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.952 [opensc-pkcs11] reader-pcsc.c:416:pcsc_detect_card_presence: returning with: 1
0x7f0cb5988780 13:07:16.952 [opensc-pkcs11] sc.c:280:sc_detect_card_presence: returning with: 1
0x7f0cb5988780 13:07:16.952 [opensc-pkcs11] slot.c:377:card_detect: Yubico Yubikey 4 CCID 00 00: Detection ended
0x7f0cb5988780 13:07:16.952 [opensc-pkcs11] slot.c:406:card_detect_all: All cards detected
0x7f0cb5988780 13:07:16.952 [opensc-pkcs11] pkcs11-global.c:517:C_GetSlotInfo: C_GetSlotInfo() get slot rv 0
0x7f0cb5988780 13:07:16.952 [opensc-pkcs11] slot.c:233:card_detect: Yubico Yubikey 4 CCID 00 00: Detecting smart card
0x7f0cb5988780 13:07:16.952 [opensc-pkcs11] sc.c:275:sc_detect_card_presence: called
0x7f0cb5988780 13:07:16.953 [opensc-pkcs11] reader-pcsc.c:411:pcsc_detect_card_presence: called
0x7f0cb5988780 13:07:16.953 [opensc-pkcs11] reader-pcsc.c:319:refresh_attributes: Yubico Yubikey 4 CCID 00 00 check
0x7f0cb5988780 13:07:16.954 [opensc-pkcs11] reader-pcsc.c:339:refresh_attributes: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.954 [opensc-pkcs11] reader-pcsc.c:416:pcsc_detect_card_presence: returning with: 1
0x7f0cb5988780 13:07:16.954 [opensc-pkcs11] sc.c:280:sc_detect_card_presence: returning with: 1
0x7f0cb5988780 13:07:16.954 [opensc-pkcs11] slot.c:377:card_detect: Yubico Yubikey 4 CCID 00 00: Detection ended
0x7f0cb5988780 13:07:16.954 [opensc-pkcs11] pkcs11-global.c:527:C_GetSlotInfo: C_GetSlotInfo() card detect rv 0x0
0x7f0cb5988780 13:07:16.954 [opensc-pkcs11] pkcs11-global.c:544:C_GetSlotInfo: C_GetSlotInfo() flags 0x7
0x7f0cb5988780 13:07:16.954 [opensc-pkcs11] pkcs11-global.c:545:C_GetSlotInfo: C_GetSlotInfo(0x0) = CKR_OK
Using slot 0 with a present token (0x0)
0x7f0cb5988780 13:07:16.955 [opensc-pkcs11] pkcs11-session.c:58:C_OpenSession: C_OpenSession(0x0)
0x7f0cb5988780 13:07:16.955 [opensc-pkcs11] slot.c:446:slot_get_token: Slot(id=0x0): get token
0x7f0cb5988780 13:07:16.955 [opensc-pkcs11] slot.c:464:slot_get_token: Slot-get-token returns OK
0x7f0cb5988780 13:07:16.955 [opensc-pkcs11] pkcs11-session.c:94:C_OpenSession: C_OpenSession handle: 0x562af212d620
0x7f0cb5988780 13:07:16.955 [opensc-pkcs11] pkcs11-session.c:97:C_OpenSession: C_OpenSession() = CKR_OK
0x7f0cb5988780 13:07:16.955 [opensc-pkcs11] pkcs11-object.c:991:C_GenerateKeyPair: C_GenerateKeyPair(), PrivKey attrs: CKA_CLASS = CKO_PRIVATE_KEY
0x7f0cb5988780 13:07:16.955 [opensc-pkcs11] pkcs11-object.c:991:C_GenerateKeyPair: C_GenerateKeyPair(), PrivKey attrs: CKA_TOKEN = TRUE
0x7f0cb5988780 13:07:16.955 [opensc-pkcs11] pkcs11-object.c:991:C_GenerateKeyPair: C_GenerateKeyPair(), PrivKey attrs: CKA_PRIVATE = TRUE
0x7f0cb5988780 13:07:16.955 [opensc-pkcs11] pkcs11-object.c:991:C_GenerateKeyPair: C_GenerateKeyPair(), PrivKey attrs: CKA_SENSITIVE = TRUE
0x7f0cb5988780 13:07:16.955 [opensc-pkcs11] pkcs11-object.c:992:C_GenerateKeyPair: C_GenerateKeyPair(), PubKey attrs: CKA_CLASS = CKO_PUBLIC_KEY
0x7f0cb5988780 13:07:16.955 [opensc-pkcs11] pkcs11-object.c:992:C_GenerateKeyPair: C_GenerateKeyPair(), PubKey attrs: CKA_TOKEN = TRUE
0x7f0cb5988780 13:07:16.955 [opensc-pkcs11] pkcs11-object.c:992:C_GenerateKeyPair: C_GenerateKeyPair(), PubKey attrs: CKA_PRIVATE = FALSE
0x7f0cb5988780 13:07:16.955 [opensc-pkcs11] framework-pkcs15.c:2872:pkcs15_gen_keypair: Keypair generation, mech = 0x0
0x7f0cb5988780 13:07:16.955 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.955 [opensc-pkcs11] reader-pcsc.c:612:pcsc_lock: called
0x7f0cb5988780 13:07:16.956 [opensc-pkcs11] card-piv.c:3576:piv_card_reader_lock_obtained: called
0x7f0cb5988780 13:07:16.956 [opensc-pkcs11] card-piv.c:2681:piv_find_discovery: called
0x7f0cb5988780 13:07:16.956 [opensc-pkcs11] card-piv.c:927:piv_get_data: called
0x7f0cb5988780 13:07:16.956 [opensc-pkcs11] card-piv.c:928:piv_get_data: #10
0x7f0cb5988780 13:07:16.956 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.956 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.956 [opensc-pkcs11] card-piv.c:972:piv_get_data: buffer for #10 *buf=0x0x7ffea929c300 len=256
0x7f0cb5988780 13:07:16.956 [opensc-pkcs11] card-piv.c:494:piv_general_io: called
0x7f0cb5988780 13:07:16.956 [opensc-pkcs11] card-piv.c:499:piv_general_io: cb 3f ff 3 : 255 256
0x7f0cb5988780 13:07:16.956 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.956 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.957 [opensc-pkcs11] card-piv.c:540:piv_general_io: calling sc_transmit_apdu flags=1 le=256, resplen=256, resp=0x7ffea929c300
0x7f0cb5988780 13:07:16.957 [opensc-pkcs11] apdu.c:554:sc_transmit_apdu: called
0x7f0cb5988780 13:07:16.957 [opensc-pkcs11] card.c:401:sc_lock: called
0x7f0cb5988780 13:07:16.957 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.957 [opensc-pkcs11] apdu.c:521:sc_transmit: called
0x7f0cb5988780 13:07:16.957 [opensc-pkcs11] apdu.c:371:sc_single_transmit: called
0x7f0cb5988780 13:07:16.957 [opensc-pkcs11] apdu.c:378:sc_single_transmit: CLA:0, INS:CB, P1:3F, P2:FF, data(3) 0x7ffea929c298
0x7f0cb5988780 13:07:16.957 [opensc-pkcs11] reader-pcsc.c:283:pcsc_transmit: reader 'Yubico Yubikey 4 CCID 00 00'
0x7f0cb5988780 13:07:16.957 [opensc-pkcs11] reader-pcsc.c:284:pcsc_transmit:
Outgoing APDU (9 bytes):
00 CB 3F FF 03 5C 01 7E 00 ..?..\.~.
0x7f0cb5988780 13:07:16.957 [opensc-pkcs11] reader-pcsc.c:212:pcsc_internal_transmit: called
0x7f0cb5988780 13:07:16.959 [opensc-pkcs11] reader-pcsc.c:293:pcsc_transmit:
Incoming APDU (22 bytes):
7E 12 4F 0B A0 00 00 03 08 00 00 10 00 01 00 5F ~.O............_
2F 02 40 00 90 00 /.@...
0x7f0cb5988780 13:07:16.959 [opensc-pkcs11] apdu.c:390:sc_single_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.959 [opensc-pkcs11] apdu.c:543:sc_transmit: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.959 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.959 [opensc-pkcs11] card-piv.c:547:piv_general_io: DEE r=0 apdu.resplen=20 sw1=90 sw2=00
0x7f0cb5988780 13:07:16.959 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.959 [opensc-pkcs11] card-piv.c:609:piv_general_io: returning with: 20
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] card-piv.c:985:piv_get_data: returning with: 20
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] card-piv.c:2617:piv_parse_discovery: Discovery 0x60 0x1e 0x7ffea929c302:18
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] card-piv.c:2622:piv_parse_discovery: Discovery aid=0x7ffea929c304:11
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] card-piv.c:2647:piv_parse_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] card-piv.c:2700:piv_find_discovery: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] card-piv.c:3622:piv_card_reader_lock_obtained: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] card.c:441:sc_lock: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] pkcs15-lib.c:313:sc_pkcs15init_bind: called
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] card.c:912:sc_card_ctl: called
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] card-piv.c:2192:piv_card_ctl: called
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] card-piv.c:2193:piv_card_ctl: cmd=4 ptr=0x7ffea929b4ac
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] card-piv.c:2227:piv_card_ctl: returning with: -1408 (Not supported)
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] card.c:919:sc_card_ctl: card_ctl(4) not supported
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] pkcs15-lib.c:253:find_library: unable to locate pkcs15init driver for 'PIV-II'
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] pkcs15-lib.c:337:sc_pkcs15init_bind: Unsupported card driver PIV-II
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] pkcs15-lib.c:339:sc_pkcs15init_bind: Unsupported card driver: -1408 (Not supported)
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] card.c:451:sc_unlock: called
0x7f0cb5988780 13:07:16.960 [opensc-pkcs11] reader-pcsc.c:662:pcsc_unlock: called
0x7f0cb5988780 13:07:16.970 [opensc-pkcs11] misc.c:61:sc_to_cryptoki_error_common: libopensc return value: -1408 (Not supported)
0x7f0cb5988780 13:07:16.971 [opensc-pkcs11] pkcs11-global.c:315:C_Finalize: C_Finalize()
0x7f0cb5988780 13:07:16.971 [opensc-pkcs11] ctx.c:878:sc_cancel: called
0x7f0cb5988780 13:07:16.971 [opensc-pkcs11] reader-pcsc.c:712:pcsc_cancel: called
0x7f0cb5988780 13:07:16.971 [opensc-pkcs11] slot.c:195:card_removed: Yubico Yubikey 4 CCID 00 00: card removed
0x7f0cb5988780 13:07:16.971 [opensc-pkcs11] slot.c:474:slot_token_removed: slot_token_removed(0x0)
0x7f0cb5988780 13:07:16.971 [opensc-pkcs11] pkcs11-session.c:140:sc_pkcs11_close_all_sessions: real C_CloseAllSessions(0x0) 1
0x7f0cb5988780 13:07:16.971 [opensc-pkcs11] pkcs11-session.c:109:sc_pkcs11_close_session: real C_CloseSession(0x562af212d620)
0x7f0cb5988780 13:07:16.972 [opensc-pkcs11] framework-pkcs15.c:1499:pkcs15_release_token: pkcs15_release_token() not implemented
0x7f0cb5988780 13:07:16.972 [opensc-pkcs11] slot.c:474:slot_token_removed: slot_token_removed(0x1)
0x7f0cb5988780 13:07:16.972 [opensc-pkcs11] pkcs11-session.c:140:sc_pkcs11_close_all_sessions: real C_CloseAllSessions(0x1) 0
0x7f0cb5988780 13:07:16.972 [opensc-pkcs11] slot.c:474:slot_token_removed: slot_token_removed(0x2)
0x7f0cb5988780 13:07:16.972 [opensc-pkcs11] pkcs11-session.c:140:sc_pkcs11_close_all_sessions: real C_CloseAllSessions(0x2) 0
0x7f0cb5988780 13:07:16.972 [opensc-pkcs11] slot.c:474:slot_token_removed: slot_token_removed(0x3)
0x7f0cb5988780 13:07:16.972 [opensc-pkcs11] pkcs11-session.c:140:sc_pkcs11_close_all_sessions: real C_CloseAllSessions(0x3) 0
0x7f0cb5988780 13:07:16.972 [opensc-pkcs11] sc.c:275:sc_detect_card_presence: called
0x7f0cb5988780 13:07:16.972 [opensc-pkcs11] reader-pcsc.c:411:pcsc_detect_card_presence: called
0x7f0cb5988780 13:07:16.973 [opensc-pkcs11] reader-pcsc.c:319:refresh_attributes: Yubico Yubikey 4 CCID 00 00 check
0x7f0cb5988780 13:07:16.974 [opensc-pkcs11] reader-pcsc.c:339:refresh_attributes: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.975 [opensc-pkcs11] reader-pcsc.c:416:pcsc_detect_card_presence: returning with: 1
0x7f0cb5988780 13:07:16.975 [opensc-pkcs11] sc.c:280:sc_detect_card_presence: returning with: 1
0x7f0cb5988780 13:07:16.975 [opensc-pkcs11] pkcs15.c:1315:sc_pkcs15_unbind: called
0x7f0cb5988780 13:07:16.975 [opensc-pkcs11] pkcs15-pin.c:838:sc_pkcs15_pincache_clear: called
0x7f0cb5988780 13:07:16.975 [opensc-pkcs11] misc.c:61:sc_to_cryptoki_error_common: libopensc return value: 0 (Success)
0x7f0cb5988780 13:07:16.975 [opensc-pkcs11] card.c:342:sc_disconnect_card: called
0x7f0cb5988780 13:07:16.975 [opensc-pkcs11] card-piv.c:2938:piv_finish: called
0x7f0cb5988780 13:07:16.975 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #0, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.975 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #1, 0x01 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.975 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #2, 0x01 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.976 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #3, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.976 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #4, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.976 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #5, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.976 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #6, 0x01 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.976 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #7, 0x01 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.976 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #8, 0x01 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.976 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #9, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.976 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #10, 0x01 0x562af20eb0d0:20 (nil):0
0x7f0cb5988780 13:07:16.976 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #11, 0x09 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.976 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #12, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.976 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #13, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.977 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #14, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.977 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #15, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.977 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #16, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.977 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #17, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.977 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #18, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.977 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #19, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.977 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #20, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.977 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #21, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.977 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #22, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.977 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #23, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.978 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #24, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.978 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #25, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.978 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #26, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.978 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #27, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.978 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #28, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.978 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #29, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.978 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #30, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.978 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #31, 0x08 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.978 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #32, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.978 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #33, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.979 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #34, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.979 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #35, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.979 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #36, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.979 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #37, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.979 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #38, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.979 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #39, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.979 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #40, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.979 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #41, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.979 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #42, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.979 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #43, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.979 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #44, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.980 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #45, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.980 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #46, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.980 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #47, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.980 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #48, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.980 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #49, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.980 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #50, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.980 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #51, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.980 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #52, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.980 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #53, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.980 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #54, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.980 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #55, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.981 [opensc-pkcs11] card-piv.c:2952:piv_finish: DEE freeing #56, 0x00 (nil):0 (nil):0
0x7f0cb5988780 13:07:16.982 [opensc-pkcs11] reader-pcsc.c:597:pcsc_disconnect: Yubico Yubikey 4 CCID 00 00:SCardDisconnect returned: 0x00000000
0x7f0cb5988780 13:07:16.983 [opensc-pkcs11] card.c:364:sc_disconnect_card: returning with: 0 (Success)
0x7f0cb5988780 13:07:16.983 [opensc-pkcs11] ctx.c:903:sc_release_context: called
0x7f0cb5988780 13:07:16.983 [opensc-pkcs11] reader-pcsc.c:896:pcsc_finish: called
error: PKCS11 function C_GenerateKeyPair failed: rv = CKR_FUNCTION_NOT_SUPPORTED (0x54)
Aborting.
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment