2015-12-26 17:22 GMT+02:00 Martin-Éric Racine <martin-eric.rac...@iki.fi>: > 2015-12-26 16:41 GMT+02:00 Ludovic Rousseau <ludovic.rouss...@gmail.com>: >> Le 26/12/2015 14:49, Martin-Éric Racine a écrit : >>> >>> .2015-12-26 15:11 GMT+02:00 Ludovic Rousseau <ludovic.rouss...@gmail.com>: >>>> >>>> Le 26/12/2015 13:53, Martin-Éric Racine a écrit : >> >> >>>> Using git bisect would greatly help find the source of the problem. >>>> The CCID driver git repository is available from >>>> https://pcsclite.alioth.debian.org/ccid.html >>> >>> >>> Noted. This being said, can you confirm whether the most probable >>> cause would be changes in CCID or in OPENSC? >> >> >> Most probably a change in the CCID driver. >> >> What would help me a lot is a pcscd trace with a working CCID driver so I >> can compare the 2 traces. >> Can you try to install older libccid packages until you find one that works >> for you? >> >> In your initial bug report you used libccid 1.4.16-1 >> wheezy (oldstable) has version 1.4.7-1. This should be a good candidate. > > Same log generation method as above, but with an older libccid? > > Is the API/ABI the same or do I need to re-compile anything against > that 1.4.7-1 version? > > Martin-Éric
1.4.7-1 worked: 'pkcs15-tool --list-keys' correctly shows both of the RSA certificates. I visited the snapshot host ( http://snapshot.debian.org/package/ccid/ ) and gradually upgraded until I found the culprit: Setting up libccid (1.4.15-1) ... Installing new version of config file /etc/libccid_Info.plist ... Installing new version of config file /etc/reader.conf.d/libccidtwin ... This version installs a new version of libccidtwin and that is what seemingly breaks it. The log under 1.4.14-1 (last known good version) is attached. Actions performed during this trace: 1. launch the pcsd daemon in debug mode. 2. insert card. 3. execute 'pkcs15-tool --list-keys' on another terminal. 4. remove card. 5. terminate the pcsd daemon. I hope this helps. Martin-Éric
00000000 debuglog.c:292:DebugLogSetLevel() debug level=debug 00001563 debuglog.c:321:DebugLogSetCategory() Debug options: APDU 00000298 configfile.l:283:DBGetReaderListDir() Parsing conf directory: /etc/reader.conf.d 00000802 configfile.l:317:DBGetReaderListDir() Skipping non regular file: . 00000107 configfile.l:355:DBGetReaderList() Parsing conf file: /etc/reader.conf.d/libccidtwin 00000170 configfile.l:317:DBGetReaderListDir() Skipping non regular file: .. 00000108 pcscdaemon.c:569:main() pcsc-lite 1.8.13 daemon ready. 00007388 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0001, path: /dev/bus/usb/001/001 00000663 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0001, path: /dev/bus/usb/003/001 00001130 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0001, path: /dev/bus/usb/004/001 00000298 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0001, path: /dev/bus/usb/005/001 00000284 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/002/001 00001356 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/002/001 00000261 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA005, path: /dev/bus/usb/002/002 00000249 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x0B97, PID: 0x7761, path: /dev/bus/usb/002/004 00000254 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x0B97, PID: 0x7762, path: /dev/bus/usb/002/010 00000110 hotplug_libudev.c:435:HPAddDevice() Adding USB device: O2 Micro Oz776 00000197 readerfactory.c:1012:RFInitializeReader() Attempting startup of O2 Micro Oz776 00 00 using /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so 00000405 readerfactory.c:897:RFBindFunctions() Loading IFD Handler 3.0 00000153 ifdhandler.c:1851:init_driver() Driver version: 1.4.14 00002327 ifdhandler.c:1868:init_driver() LogLevel: 0x0003 00000122 ifdhandler.c:1879:init_driver() DriverOptions: 0x0000 00000340 ifdhandler.c:1892:init_driver() LogLevel from LIBCCID_ifdLogLevel: 0x000F 00000930 ifdhandler.c:83:CreateChannelByNameOrChannel() Lun: 0, device: usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 00000111 ccid_usb.c:233:OpenUSBByName() Reader index: 0, Device: usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 00000113 ccid_usb.c:265:OpenUSBByName() interface_number: 0 00000097 ccid_usb.c:281:OpenUSBByName() Using: /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist 00002664 ccid_usb.c:299:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau (ludovic.rouss...@free.fr) 00000138 ccid_usb.c:300:OpenUSBByName() ifdProductString: Generic CCID driver 00000131 ccid_usb.c:301:OpenUSBByName() Copyright: This driver is protected by terms of the GNU Lesser General Public License version 2.1, or (at your option) any later version. 00019815 ccid_usb.c:426:OpenUSBByName() Checking device: 2/10 00000852 ccid_usb.c:488:OpenUSBByName() Trying to open USB bus/device: 2/10 00000211 ccid_usb.c:589:OpenUSBByName() Found Vendor/Product: 0B97/7762 (O2 Micro Oz776) 00000036 ccid_usb.c:591:OpenUSBByName() Using USB bus/device: 2/10 00000032 ccid_usb.c:1142:ControlUSB() request: 0x03 00000457 receive: 80 25 00 00 00000043 ccid_usb.c:1122:get_data_rates() declared: 9600 bps 00001683 ccid_usb.c:1195:InterruptRead() before (0) 00104465 ccid_usb.c:1237:InterruptRead() after (0) (2) 00000031 -> 000000 65 00 00 00 00 00 00 00 00 00 00000344 <- 000000 81 10 00 00 00 00 00 42 FE 00 00000015 -> 000000 65 00 00 00 00 00 01 00 00 00 00000232 <- 000000 81 10 00 00 00 00 01 42 FE 00 00000021 ifdhandler.c:362:IFDHGetCapabilities() tag: 0xFB3, usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000008 readerfactory.c:355:RFAddReader() Using the reader polling thread 00000007 ifdhandler.c:1711:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000010 -> 000000 65 00 00 00 00 00 02 00 00 00 00000205 <- 000000 81 10 00 00 00 00 02 42 FE 00 00000010 ifdhandler.c:1832:IFDHICCPresence() Card absent 00000102 ifdhandler.c:362:IFDHGetCapabilities() tag: 0xFAE, usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000008 ifdhandler.c:450:IFDHGetCapabilities() Reader supports 1 slot(s) 00000253 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x0B97, PID: 0x7761, path: /dev/bus/usb/002/004 00000156 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA005, path: /dev/bus/usb/002/002 00000146 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/002/001 00000147 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA005, path: /dev/bus/usb/002/003 00000181 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x413C, PID: 0x9001, path: /dev/bus/usb/002/005 00000147 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA005, path: /dev/bus/usb/002/003 00000152 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x046D, PID: 0xC00E, path: /dev/bus/usb/002/006 00000144 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA005, path: /dev/bus/usb/002/003 00000151 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x03F9, PID: 0x0100, path: /dev/bus/usb/002/007 00000144 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA005, path: /dev/bus/usb/002/003 00000151 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x05E3, PID: 0x0605, path: /dev/bus/usb/002/008 00000144 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA005, path: /dev/bus/usb/002/003 00000150 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x076B, PID: 0x1021, path: /dev/bus/usb/002/009 00000010 hotplug_libudev.c:435:HPAddDevice() Adding USB device: OMNIKEY CardMan 1021 00000058 ifdhandler.c:362:IFDHGetCapabilities() tag: 0xFAF, usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000008 readerfactory.c:680:RFSetReaderName() Support 16 simultaneous readers 00000011 ifdhandler.c:362:IFDHGetCapabilities() tag: 0xFAD, usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000006 readerfactory.c:297:RFAddReader() Driver is thread safe 00000007 readerfactory.c:1012:RFInitializeReader() Attempting startup of OMNIKEY CardMan 1021 01 00 using /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so 00000007 readerfactory.c:811:RFLoadReader() Reusing already loaded driver for /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so 00000017 readerfactory.c:897:RFBindFunctions() Loading IFD Handler 3.0 00000042 ifdhandler.c:83:CreateChannelByNameOrChannel() Lun: 10000, device: usb:076b/1021:libudev:0:/dev/bus/usb/002/009 00000008 ccid_usb.c:233:OpenUSBByName() Reader index: 1, Device: usb:076b/1021:libudev:0:/dev/bus/usb/002/009 00000019 ccid_usb.c:265:OpenUSBByName() interface_number: 0 00000008 ccid_usb.c:281:OpenUSBByName() Using: /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist 00001079 ccid_usb.c:299:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau (ludovic.rouss...@free.fr) 00000011 ccid_usb.c:300:OpenUSBByName() ifdProductString: Generic CCID driver 00000009 ccid_usb.c:301:OpenUSBByName() Copyright: This driver is protected by terms of the GNU Lesser General Public License version 2.1, or (at your option) any later version. 00000137 ccid_usb.c:426:OpenUSBByName() Checking device: 2/9 00000008 ccid_usb.c:488:OpenUSBByName() Trying to open USB bus/device: 2/9 00000320 ccid_usb.c:589:OpenUSBByName() Found Vendor/Product: 076B/1021 (OMNIKEY CardMan 1021) 00002146 ccid_usb.c:591:OpenUSBByName() Using USB bus/device: 2/9 00000051 ccid_usb.c:1142:ControlUSB() request: 0x03 00001034 ifdhandler.c:1711:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000043 -> 000000 65 00 00 00 00 00 03 00 00 00 00001913 <- 000000 81 10 00 00 00 00 03 42 FE 00 00000043 ifdhandler.c:1832:IFDHICCPresence() Card absent 00000061 ifdhandler.c:1711:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000060 -> 000000 65 00 00 00 00 00 04 00 00 00 00000334 <- 000000 81 10 00 00 00 00 04 42 FE 00 00000034 ifdhandler.c:1832:IFDHICCPresence() Card absent 00000031 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 600000 ms 00000030 ccid_usb.c:1195:InterruptRead() before (0) 00018396 receive: C4 26 00 00 89 4D 00 00 12 9B 00 00 25 36 01 00 4B 6C 02 00 97 D8 04 00 38 D1 01 00 5E 07 03 00 62 13 00 00 9C E8 00 00 AF 83 01 00 2A 1C 00 00 55 38 00 00 AB 70 00 00 57 E1 00 00 AF C2 01 00 5E 85 03 00 03 52 01 00 5A 33 02 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 8E 2E 8F 2F 8C 30 8D 31 E5 31 15 31 70 02 15 30 E4 F5 34 F5 35 C3 E5 35 95 31 E5 34 95 30 40 03 02 1F 71 E5 2F 25 35 FF E5 2E 35 34 FE 74 0B 2F F5 82 74 00 3E F5 83 E0 F5 32 E4 F5 33 E5 32 C3 13 F5 32 92 09 12 3D 60 E5 32 C3 13 F5 32 92 09 12 3D 52 E5 32 C3 13 F5 32 92 09 12 3D 44 E5 32 C3 13 F5 32 30 D7 07 E5 AC 20 E0 0C 80 05 E5 AC 30 E0 05 92 0A 12 24 A7 05 33 E5 33 C3 94 02 40 BC E5 35 AE 34 78 03 CE C3 13 CE 13 D8 F9 25 2F FF E5 2E 3E FE 74 0A 2F F5 82 74 00 3E F5 83 E0 FF C3 13 F0 12 3E 20 50 06 7F 80 7D 80 80 04 7F 00 7D 00 E5 35 AE 34 78 03 CE C3 13 CE 13 D8 F9 25 2F FF E5 2E 3E FE 74 0A 2F F5 82 74 00 3E F5 83 E0 2D F0 05 35 E5 35 70 02 05 34 02 1E A7 E5 31 AE 30 78 03 CE C3 13 CE 13 D8 F9 FF E5 31 54 07 7C 00 60 04 7D 01 80 02 7D 00 EF 2D FF EE 3C FE 22 08 03 55 00 53 00 42 00 24 03 53 00 6D 00 61 00 72 00 74 00 20 00 43 00 61 00 72 00 64 00 20 00 52 00 65 00 61 00 64 00 65 00 72 00 12 01 00 02 00 00 00 08 6B 07 22 A0 00 01 01 02 00 01 10 03 4F 00 4D 00 4E 00 49 00 4B 00 45 00 59 00 2C 03 53 00 6D 00 61 00 72 00 74 00 20 00 43 00 61 00 72 00 64 00 20 00 52 00 65 00 61 00 64 00 65 00 72 00 20 00 55 00 53 00 42 00 04 03 09 04 0A 03 43 00 43 00 49 00 44 00 12 01 00 02 00 00 00 08 6B 07 21 10 00 01 01 02 00 01 09 02 5D 00 01 01 03 A0 32 09 04 00 00 03 0B 00 00 00 36 21 00 01 00 07 03 00 00 00 6C 0E 00 00 6C 0E 00 00 01 C4 26 00 00 97 D8 04 00 13 FE 00 00 00 07 00 00 00 00 00 00 00 B1 03 01 00 0F 01 00 00 FF FF 00 00 00 01 07 05 83 03 08 00 18 07 05 84 02 40 00 00 07 05 05 02 40 00 00 8E 2E 8F 2F E4 F5 32 F5 33 C2 0A 12 24 A7 7F 01 12 3A DC 53 AB A0 12 3A F1 43 AB 01 53 AE 40 53 B6 F7 12 3A F1 53 B6 CF 12 3A F1 43 B6 30 53 AB FE 53 AC FB 12 3A F1 53 AC 7F D2 0A 12 24 A7 40 02 80 15 D2 09 AF 33 12 39 36 D2 09 AF 33 12 39 0D AF 33 12 3B 20 40 10 74 0A 25 2F F5 82 74 00 35 2E F5 83 E4 F0 FF 22 7F 01 12 3A DC 74 0A 25 2F F5 82 74 00 35 2E F5 83 E0 F5 31 E4 F5 30 C2 09 AF 33 12 39 36 7F 04 12 3A ED 74 0A 25 2F F5 82 74 00 35 2E F5 83 E0 54 FE F5 6D D2 3F E5 33 44 01 FF 12 2E 13 C2 09 AF 33 12 39 36 D2 09 AF 33 12 39 0D 7F 04 12 3A ED D2 09 AF 33 12 39 36 30 3F 02 05 32 05 30 E5 30 C3 94 03 40 B1 74 0A 25 2F F5 82 74 00 35 2E F5 83 E5 32 F0 A2 3F E4 33 FF 22 8C 30 8D 31 8E 18 8F 19 85 30 1A 85 31 1B 78 86 E6 FF 78 88 E6 FD 12 15 F9 78 86 E6 FF 12 39 FD 78 95 A6 1A 00000035 ccid_usb.c:1104:get_data_rates() Got 256 data rates but was expecting 19 00000010 ccid_usb.c:1122:get_data_rates() declared: 9924 bps 00000005 ccid_usb.c:1122:get_data_rates() declared: 19849 bps 00000006 ccid_usb.c:1122:get_data_rates() declared: 39698 bps 00000005 ccid_usb.c:1122:get_data_rates() declared: 79397 bps 00000006 ccid_usb.c:1122:get_data_rates() declared: 158795 bps 00000005 ccid_usb.c:1122:get_data_rates() declared: 317591 bps 00000005 ccid_usb.c:1122:get_data_rates() declared: 119096 bps 00000005 ccid_usb.c:1122:get_data_rates() declared: 198494 bps 00000005 ccid_usb.c:1122:get_data_rates() declared: 4962 bps 00000006 ccid_usb.c:1122:get_data_rates() declared: 59548 bps 00000005 ccid_usb.c:1122:get_data_rates() declared: 99247 bps 00000005 ccid_usb.c:1122:get_data_rates() declared: 7210 bps 00000005 ccid_usb.c:1122:get_data_rates() declared: 14421 bps 00000006 ccid_usb.c:1122:get_data_rates() declared: 28843 bps 00000005 ccid_usb.c:1122:get_data_rates() declared: 57687 bps 00000007 ccid_usb.c:1122:get_data_rates() declared: 115375 bps 00000005 ccid_usb.c:1122:get_data_rates() declared: 230750 bps 00000005 ccid_usb.c:1122:get_data_rates() declared: 86531 bps 00000005 ccid_usb.c:1122:get_data_rates() declared: 144218 bps 00002821 ccid_usb.c:1195:InterruptRead() before (1) 00101863 ccid_usb.c:1237:InterruptRead() after (1) (2) 00000033 -> 000001 65 00 00 00 00 00 00 00 00 00 00000708 <- 000001 81 00 00 00 00 00 00 02 00 01 00000016 -> 000001 65 00 00 00 00 00 01 00 00 00 00000608 <- 000001 81 00 00 00 00 00 01 02 00 01 00000017 ifdhandler.c:362:IFDHGetCapabilities() tag: 0xFB3, usb:076b/1021:libudev:0:/dev/bus/usb/002/009 (lun: 10000) 00000008 readerfactory.c:355:RFAddReader() Using the reader polling thread 00000007 ifdhandler.c:1711:IFDHICCPresence() usb:076b/1021:libudev:0:/dev/bus/usb/002/009 (lun: 10000) 00000010 -> 000001 65 00 00 00 00 00 02 00 00 00 00000582 <- 000001 81 00 00 00 00 00 02 02 00 01 00000011 ifdhandler.c:1832:IFDHICCPresence() Card absent 00000086 ifdhandler.c:362:IFDHGetCapabilities() tag: 0xFAE, usb:076b/1021:libudev:0:/dev/bus/usb/002/009 (lun: 10000) 00000008 ifdhandler.c:450:IFDHGetCapabilities() Reader supports 1 slot(s) 00000252 hotplug_libudev.c:296:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA005, path: /dev/bus/usb/002/003 00000074 readerfactory.c:1353:RFWaitForReaderInit() Waiting init for reader: OMNIKEY CardMan 1021 01 00 00005550 ifdhandler.c:1711:IFDHICCPresence() usb:076b/1021:libudev:0:/dev/bus/usb/002/009 (lun: 10000) 00000052 -> 000001 65 00 00 00 00 00 03 00 00 00 00000725 <- 000001 81 00 00 00 00 00 03 02 00 01 00000038 ifdhandler.c:1832:IFDHICCPresence() Card absent 00000033 ifdhandler.c:1711:IFDHICCPresence() usb:076b/1021:libudev:0:/dev/bus/usb/002/009 (lun: 10000) 00000035 -> 000001 65 00 00 00 00 00 04 00 00 00 00000636 <- 000001 81 00 00 00 00 00 04 02 00 01 00000033 ifdhandler.c:1832:IFDHICCPresence() Card absent 00000031 ifdhandler.c:291:IFDHPolling() usb:076b/1021:libudev:0:/dev/bus/usb/002/009 (lun: 10000) 600000 ms 00000030 ccid_usb.c:1195:InterruptRead() before (1) 03806400 ccid_usb.c:1237:InterruptRead() after (0) (0) 00000025 NotifySlotChange: 50 03 00000011 ifdhandler.c:1711:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000012 -> 000000 65 00 00 00 00 00 05 00 00 00 00000393 <- 000000 81 10 00 00 00 00 05 01 00 00 00000017 ifdhandler.c:1832:IFDHICCPresence() Card present 00000007 ifdhandler.c:1711:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000010 -> 000000 65 00 00 00 00 00 06 00 00 00 00000341 <- 000000 81 10 00 00 00 00 06 01 00 00 00000011 ifdhandler.c:1832:IFDHICCPresence() Card present 00000008 ifdhandler.c:1122:IFDHPowerICC() action: PowerUp, usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000011 -> 000000 62 00 00 00 00 00 07 01 00 00 00971913 <- 000000 80 10 00 00 00 00 07 00 00 00 3B 7B 94 00 00 80 62 12 51 56 46 69 6E 45 49 44 00000037 eventhandler.c:404:EHStatusHandlerThread() powerState: POWER_STATE_POWERED 00000007 eventhandler.c:419:EHStatusHandlerThread() Card inserted into O2 Micro Oz776 00 00 00000013 Card ATR: 3B 7B 94 00 00 80 62 12 51 56 46 69 6E 45 49 44 00000009 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 5000 ms 00000007 ccid_usb.c:1195:InterruptRead() before (0) 04116880 winscard_msg_srv.c:253:ProcessEventsServer() Common channel packet arrival 00000045 winscard_msg_srv.c:265:ProcessEventsServer() ProcessCommonChannelRequest detects: 15 00000010 pcscdaemon.c:134:SVCServiceRunLoop() A new context thread creation is requested: 15 00001798 winscard_svc.c:331:ContextThread() Authorized PC/SC client 00000113 winscard_svc.c:335:ContextThread() Thread is started: dwClientID=15, threadContext @0x833aa80 00000146 winscard_svc.c:353:ContextThread() Received command: CMD_VERSION from client 15 00000102 winscard_svc.c:365:ContextThread() Client is protocol version 4:3 00000134 winscard_svc.c:385:ContextThread() CMD_VERSION rv=0x0 for client 15 00000141 winscard_svc.c:353:ContextThread() Received command: ESTABLISH_CONTEXT from client 15 00000120 winscard.c:216:SCardEstablishContext() Establishing Context: 0x3E404AA0 00000095 winscard_svc.c:446:ContextThread() ESTABLISH_CONTEXT rv=0x0 for client 15 00000126 winscard_svc.c:353:ContextThread() Received command: CMD_GET_READERS_STATE from client 15 00000160 winscard_svc.c:353:ContextThread() Received command: CMD_GET_READERS_STATE from client 15 00000136 winscard_svc.c:353:ContextThread() Received command: CMD_GET_READERS_STATE from client 15 00000136 winscard_svc.c:353:ContextThread() Received command: CONNECT from client 15 00000102 winscard_svc.c:484:ContextThread() Authorized client for 'O2 Micro Oz776 00 00' 00000095 winscard.c:258:SCardConnect() Attempting Connect to O2 Micro Oz776 00 00 using protocol: 3 00000094 readerfactory.c:768:RFReaderInfo() RefReader() count was: 1 00000093 winscard.c:353:SCardConnect() powerState: POWER_STATE_INUSE 00002657 prothandler.c:110:PHSetProtocol() Attempting PTS to T=0 00000048 ifdhandler.c:668:IFDHSetProtocolParameters() protocol T=0, usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000037 ifdhandler.c:1971:extra_egt() Extra EGT patch applied 00000031 ifdhandler.c:2003:find_baud_rate() Card baud rate: 62500 00000030 ifdhandler.c:2012:find_baud_rate() Reader can do: 9600 00000028 ifdhandler.c:797:IFDHSetProtocolParameters() Reader does not support 62500 bauds 00000030 towitoko/atr.c:341:ATR_GetDefaultProtocol() no default protocol found in ATR. Using T=0 00000031 ifdhandler.c:1028:IFDHSetProtocolParameters() Communication timeout: 319489 ms 00000030 commands.c:2143:SetParameters() length: 5 bytes 00000037 -> 000000 61 05 00 00 00 00 08 00 00 00 11 00 02 0A 00 00000549 <- 000000 82 05 00 00 00 00 08 00 00 00 11 00 02 0A 00 00000038 winscard.c:432:SCardConnect() Active Protocol: T=0 00000032 winscard.c:452:SCardConnect() hCard Identity: 260b0eed 00000033 winscard.c:513:SCardConnect() UnrefReader() count was: 2 00000034 winscard_svc.c:498:ContextThread() CONNECT rv=0x0 for client 15 00000077 winscard_svc.c:353:ContextThread() Received command: CONTROL from client 15 00000039 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000034 ifdhandler.c:1360:IFDHControl() ControlCode: 0x42000D48, usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000029 Control TxBuffer: 00000037 Control RxBuffer: 12 04 42 33 00 12 00000030 winscard.c:1373:SCardControl() UnrefReader() count was: 2 00000030 winscard_svc.c:697:ContextThread() CONTROL rv=0x0 for client 15 00000073 winscard_svc.c:353:ContextThread() Received command: DISCONNECT from client 15 00002622 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000048 winscard.c:873:SCardDisconnect() Active Contexts: 1 00000030 winscard.c:874:SCardDisconnect() dwDisposition: 0 00000031 winscard.c:1039:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD 00000031 ifdhandler.c:362:IFDHGetCapabilities() tag: 0xFB2, usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000031 winscard.c:1053:SCardDisconnect() Stopping polling thread 00000029 ifdhandler.c:327:IFDHStopPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00002234 ccid_usb.c:1237:InterruptRead() after (0) (3) 00000026 ccid_usb.c:1252:InterruptRead() InterruptRead (2/10): Resource temporarily unavailable 00000059 winscard.c:1066:SCardDisconnect() UnrefReader() count was: 2 00000034 winscard_svc.c:535:ContextThread() DISCONNECT rv=0x0 for client 15 00000081 winscard_svc.c:353:ContextThread() Received command: CMD_GET_READERS_STATE from client 15 00000066 winscard_svc.c:353:ContextThread() Received command: CONNECT from client 15 00000036 winscard_svc.c:484:ContextThread() Authorized client for 'OMNIKEY CardMan 1021 01 00' 00000059 winscard.c:258:SCardConnect() Attempting Connect to OMNIKEY CardMan 1021 01 00 using protocol: 3 00000030 readerfactory.c:768:RFReaderInfo() RefReader() count was: 1 00000030 winscard.c:445:SCardConnect() Direct access: no protocol selected 00000031 winscard.c:452:SCardConnect() hCard Identity: 1ab80fae 00000031 winscard.c:513:SCardConnect() UnrefReader() count was: 2 00000033 winscard_svc.c:498:ContextThread() CONNECT rv=0x0 for client 15 00000058 winscard_svc.c:353:ContextThread() Received command: CONTROL from client 15 00000036 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000033 ifdhandler.c:1360:IFDHControl() ControlCode: 0x42000D48, usb:076b/1021:libudev:0:/dev/bus/usb/002/009 (lun: 10000) 00000029 Control TxBuffer: 00000032 Control RxBuffer: 12 04 42 33 00 12 00000029 winscard.c:1373:SCardControl() UnrefReader() count was: 2 00000029 winscard_svc.c:697:ContextThread() CONTROL rv=0x0 for client 15 00000067 winscard_svc.c:353:ContextThread() Received command: DISCONNECT from client 15 00000037 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000030 winscard.c:873:SCardDisconnect() Active Contexts: 1 00000028 winscard.c:874:SCardDisconnect() dwDisposition: 0 00000031 ifdhandler.c:362:IFDHGetCapabilities() tag: 0xFB2, usb:076b/1021:libudev:0:/dev/bus/usb/002/009 (lun: 10000) 00000030 winscard.c:1053:SCardDisconnect() Stopping polling thread 00000029 ifdhandler.c:327:IFDHStopPolling() usb:076b/1021:libudev:0:/dev/bus/usb/002/009 (lun: 10000) 00002196 winscard.c:1066:SCardDisconnect() UnrefReader() count was: 2 00000015 winscard_svc.c:535:ContextThread() DISCONNECT rv=0x0 for client 15 00000103 ccid_usb.c:1237:InterruptRead() after (1) (3) 00000014 ccid_usb.c:1252:InterruptRead() InterruptRead (2/9): Resource temporarily unavailable 00000040 winscard_svc.c:353:ContextThread() Received command: CMD_GET_READERS_STATE from client 15 00000095 winscard_svc.c:353:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 15 00000019 winscard_svc.c:353:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 15 00000012 winscard_svc.c:427:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 15 00000056 winscard_svc.c:353:ContextThread() Received command: CMD_GET_READERS_STATE from client 15 00000087 winscard_svc.c:353:ContextThread() Received command: CMD_GET_READERS_STATE from client 15 00000067 winscard_svc.c:353:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 15 00000018 winscard_svc.c:353:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 15 00000010 winscard_svc.c:427:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 15 00000055 winscard_svc.c:353:ContextThread() Received command: CMD_GET_READERS_STATE from client 15 00000066 winscard_svc.c:353:ContextThread() Received command: CMD_GET_READERS_STATE from client 15 00000067 winscard_svc.c:353:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 15 00000018 winscard_svc.c:353:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 15 00000010 winscard_svc.c:427:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 15 00000054 winscard_svc.c:353:ContextThread() Received command: CMD_GET_READERS_STATE from client 15 00000061 winscard_svc.c:353:ContextThread() Received command: CONNECT from client 15 00000012 winscard_svc.c:484:ContextThread() Authorized client for 'O2 Micro Oz776 00 00' 00000007 winscard.c:258:SCardConnect() Attempting Connect to O2 Micro Oz776 00 00 using protocol: 3 00000006 readerfactory.c:768:RFReaderInfo() RefReader() count was: 1 00000007 winscard.c:353:SCardConnect() powerState: POWER_STATE_INUSE 00000006 winscard.c:432:SCardConnect() Active Protocol: T=0 00000007 winscard.c:452:SCardConnect() hCard Identity: 2d7acb8a 00000007 winscard.c:513:SCardConnect() UnrefReader() count was: 2 00000008 winscard_svc.c:498:ContextThread() CONNECT rv=0x0 for client 15 00000195 winscard_svc.c:353:ContextThread() Received command: BEGIN_TRANSACTION from client 15 00000014 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000008 winscard.c:1105:SCardBeginTransaction() Status: 0x00000000 00000006 winscard.c:1108:SCardBeginTransaction() UnrefReader() count was: 2 00000006 winscard_svc.c:550:ContextThread() BEGIN_TRANSACTION rv=0x0 for client 15 00000091 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000017 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000007 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000015 APDU: 00 A4 04 00 0F D2 33 00 00 00 45 73 74 45 49 44 20 76 33 35 00000008 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000017 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 20 bytes 00000014 -> 000000 6F 05 00 00 00 00 09 00 01 00 00 A4 04 00 0F 00012297 <- 000000 80 01 00 00 00 00 09 00 00 00 A4 00000026 commands.c:1732:T0ProcACK() Enter, is_rcv = 0 00000018 -> 000000 6F 0F 00 00 00 00 0A 00 01 00 D2 33 00 00 00 45 73 74 45 49 44 20 76 33 35 00000172 commands.c:1834:T0ProcACK() Exit 00026674 <- 000000 80 01 00 00 00 00 0A 00 00 00 6A 00000033 -> 000000 6F 00 00 00 00 00 0B 00 01 00 00001307 <- 000000 80 01 00 00 00 00 0B 00 00 00 87 00000016 commands.c:1879:T0ProcSW1() Exit: SW=6A 87 00000009 SW: 6A 87 00000007 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000009 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000129 winscard_svc.c:353:ContextThread() Received command: END_TRANSACTION from client 15 00000018 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000008 winscard.c:1248:SCardEndTransaction() Status: 0x00000000 00000006 winscard.c:1251:SCardEndTransaction() UnrefReader() count was: 2 00000007 winscard_svc.c:566:ContextThread() END_TRANSACTION rv=0x0 for client 15 00007253 winscard_svc.c:353:ContextThread() Received command: BEGIN_TRANSACTION from client 15 00000035 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000011 winscard.c:1105:SCardBeginTransaction() Status: 0x00000000 00000006 winscard.c:1108:SCardBeginTransaction() UnrefReader() count was: 2 00000007 winscard_svc.c:550:ContextThread() BEGIN_TRANSACTION rv=0x0 for client 15 00000267 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000018 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000007 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000016 APDU: 00 A4 04 0C 0C A0 00 00 00 63 50 4B 43 53 2D 31 35 00000009 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000009 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 17 bytes 00000015 -> 000000 6F 05 00 00 00 00 0C 00 01 00 00 A4 04 0C 0C 00009417 <- 000000 80 01 00 00 00 00 0C 00 00 00 A4 00000044 commands.c:1732:T0ProcACK() Enter, is_rcv = 0 00000018 -> 000000 6F 0C 00 00 00 00 0D 00 01 00 A0 00 00 00 63 50 4B 43 53 2D 31 35 00000284 commands.c:1834:T0ProcACK() Exit 00023901 <- 000000 80 01 00 00 00 00 0D 00 00 00 61 00000045 -> 000000 6F 00 00 00 00 00 0E 00 01 00 00001140 <- 000000 80 01 00 00 00 00 0E 00 00 00 24 00000014 commands.c:1879:T0ProcSW1() Exit: SW=61 24 00000008 SW: 61 24 00000007 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000009 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000129 winscard_svc.c:353:ContextThread() Received command: END_TRANSACTION from client 15 00000019 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000008 winscard.c:1248:SCardEndTransaction() Status: 0x00000000 00000006 winscard.c:1251:SCardEndTransaction() UnrefReader() count was: 2 00000006 winscard_svc.c:566:ContextThread() END_TRANSACTION rv=0x0 for client 15 00010374 winscard_svc.c:353:ContextThread() Received command: BEGIN_TRANSACTION from client 15 00000030 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000010 winscard.c:1105:SCardBeginTransaction() Status: 0x00000000 00000005 winscard.c:1108:SCardBeginTransaction() UnrefReader() count was: 2 00000007 winscard_svc.c:550:ContextThread() BEGIN_TRANSACTION rv=0x0 for client 15 00000234 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000018 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000008 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000010 APDU: 00 A4 08 00 02 2F 00 00000010 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000008 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 7 bytes 00000014 -> 000000 6F 05 00 00 00 00 0F 00 01 00 00 A4 08 00 02 00011685 <- 000000 80 01 00 00 00 00 0F 00 00 00 A4 00000016 commands.c:1732:T0ProcACK() Enter, is_rcv = 0 00000012 -> 000000 6F 02 00 00 00 00 10 00 01 00 2F 00 00000090 commands.c:1834:T0ProcACK() Exit 00008130 <- 000000 80 01 00 00 00 00 10 00 00 00 6A 00000019 -> 000000 6F 00 00 00 00 00 11 00 01 00 00001097 <- 000000 80 01 00 00 00 00 11 00 00 00 82 00000013 commands.c:1879:T0ProcSW1() Exit: SW=6A 82 00000007 SW: 6A 82 00000006 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000007 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000219 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000020 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000008 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000009 APDU: 00 A4 08 0C 02 50 15 00000007 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000006 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 7 bytes 00000012 -> 000000 6F 05 00 00 00 00 12 00 01 00 00 A4 08 0C 02 00009945 <- 000000 80 01 00 00 00 00 12 00 00 00 A4 00000019 commands.c:1732:T0ProcACK() Enter, is_rcv = 0 00000013 -> 000000 6F 02 00 00 00 00 13 00 01 00 50 15 00000100 commands.c:1834:T0ProcACK() Exit 00005516 <- 000000 80 01 00 00 00 00 13 00 00 00 6A 00000030 -> 000000 6F 00 00 00 00 00 14 00 01 00 00001055 <- 000000 80 01 00 00 00 00 14 00 00 00 86 00000013 commands.c:1879:T0ProcSW1() Exit: SW=6A 86 00000009 SW: 6A 86 00000007 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000008 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000209 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000020 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000009 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000009 APDU: 00 A4 08 00 02 50 15 00000008 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000007 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 7 bytes 00000012 -> 000000 6F 05 00 00 00 00 15 00 01 00 00 A4 08 00 02 00009824 <- 000000 80 01 00 00 00 00 15 00 00 00 A4 00000019 commands.c:1732:T0ProcACK() Enter, is_rcv = 0 00000012 -> 000000 6F 02 00 00 00 00 16 00 01 00 50 15 00000194 commands.c:1834:T0ProcACK() Exit 00008007 <- 000000 80 01 00 00 00 00 16 00 00 00 6A 00000018 -> 000000 6F 00 00 00 00 00 17 00 01 00 00001104 <- 000000 80 01 00 00 00 00 17 00 00 00 82 00000013 commands.c:1879:T0ProcSW1() Exit: SW=6A 82 00000007 SW: 6A 82 00000007 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000007 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000211 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000018 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000008 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000010 APDU: 00 A4 08 00 02 50 31 00000007 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000006 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 7 bytes 00000013 -> 000000 6F 05 00 00 00 00 18 00 01 00 00 A4 08 00 02 00009951 <- 000000 80 01 00 00 00 00 18 00 00 00 A4 00000018 commands.c:1732:T0ProcACK() Enter, is_rcv = 0 00000012 -> 000000 6F 02 00 00 00 00 19 00 01 00 50 31 00000195 commands.c:1834:T0ProcACK() Exit 00008150 <- 000000 80 01 00 00 00 00 19 00 00 00 61 00000021 -> 000000 6F 00 00 00 00 00 1A 00 01 00 00001088 <- 000000 80 01 00 00 00 00 1A 00 00 00 14 00000013 commands.c:1879:T0ProcSW1() Exit: SW=61 14 00000007 SW: 61 14 00000007 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000007 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000220 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000020 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000008 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000009 APDU: 00 C0 00 00 14 00000007 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000006 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 5 bytes 00000013 -> 000000 6F 05 00 00 00 00 1B 00 01 00 00 C0 00 00 14 00010064 <- 000000 80 01 00 00 00 00 1B 00 00 00 C0 00000017 commands.c:1732:T0ProcACK() Enter, is_rcv = 1 00000012 -> 000000 6F 00 00 00 00 00 1C 00 16 00 00024633 <- 000000 80 16 00 00 00 00 1C 00 00 00 6F 12 81 02 00 60 82 01 01 83 02 50 31 86 02 01 01 8A 01 07 90 00 00000040 commands.c:1834:T0ProcACK() Exit 00000018 SW: 6F 12 81 02 00 60 82 01 01 83 02 50 31 86 02 01 01 8A 01 07 90 00 00000008 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000008 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000204 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000026 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000009 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000008 APDU: 00 B0 00 00 60 00000008 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000007 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 5 bytes 00000013 -> 000000 6F 05 00 00 00 00 1D 00 01 00 00 B0 00 00 60 00013637 <- 000000 80 01 00 00 00 00 1D 00 00 00 B0 00000029 commands.c:1732:T0ProcACK() Enter, is_rcv = 1 00000024 -> 000000 6F 00 00 00 00 00 1E 00 62 00 00109455 <- 000000 80 62 00 00 00 00 1E 00 00 00 A8 08 30 06 04 04 3F 00 44 01 A0 08 30 06 04 04 3F 00 44 02 A4 08 30 06 04 04 3F 00 44 03 A4 08 30 06 04 04 3F 00 44 04 A5 08 30 06 04 04 3F 00 44 05 A7 08 30 06 04 04 3F 00 44 06 A6 08 30 06 04 04 3F 00 44 07 FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 90 00 00000025 commands.c:1834:T0ProcACK() Exit 00000050 SW: A8 08 30 06 04 04 3F 00 44 01 A0 08 30 06 04 04 3F 00 44 02 A4 08 30 06 04 04 3F 00 44 03 A4 08 30 06 04 04 3F 00 44 04 A5 08 30 06 04 04 3F 00 44 05 A7 08 30 06 04 04 3F 00 44 06 A6 08 30 06 04 04 3F 00 44 07 FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 90 00 00000009 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000016 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000349 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000022 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000008 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000016 APDU: 00 A4 08 00 02 50 32 00000009 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000008 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 7 bytes 00000013 -> 000000 6F 05 00 00 00 00 1F 00 01 00 00 A4 08 00 02 00009855 <- 000000 80 01 00 00 00 00 1F 00 00 00 A4 00000016 commands.c:1732:T0ProcACK() Enter, is_rcv = 0 00000012 -> 000000 6F 02 00 00 00 00 20 00 01 00 50 32 00003950 commands.c:1834:T0ProcACK() Exit 00004394 <- 000000 80 01 00 00 00 00 20 00 00 00 61 00000017 -> 000000 6F 00 00 00 00 00 21 00 01 00 00001102 <- 000000 80 01 00 00 00 00 21 00 00 00 14 00000014 commands.c:1879:T0ProcSW1() Exit: SW=61 14 00000007 SW: 61 14 00000006 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000007 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000186 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000019 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000008 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000008 APDU: 00 C0 00 00 14 00000008 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000006 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 5 bytes 00000013 -> 000000 6F 05 00 00 00 00 22 00 01 00 00 C0 00 00 14 00010099 <- 000000 80 01 00 00 00 00 22 00 00 00 C0 00000016 commands.c:1732:T0ProcACK() Enter, is_rcv = 1 00000012 -> 000000 6F 00 00 00 00 00 23 00 16 00 00024467 <- 000000 80 16 00 00 00 00 23 00 00 00 6F 12 81 02 00 A0 82 01 01 83 02 50 32 86 02 01 01 8A 01 07 90 00 00000016 commands.c:1834:T0ProcACK() Exit 00000016 SW: 6F 12 81 02 00 A0 82 01 01 83 02 50 32 86 02 01 01 8A 01 07 90 00 00000007 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000007 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000270 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000020 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000007 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000009 APDU: 00 B0 00 00 A0 00000007 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000007 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 5 bytes 00000013 -> 000000 6F 05 00 00 00 00 24 00 01 00 00 B0 00 00 A0 00013778 ifdhandler.c:1711:IFDHICCPresence() usb:076b/1021:libudev:0:/dev/bus/usb/002/009 (lun: 10000) 00000025 -> 000001 65 00 00 00 00 00 05 00 00 00 00000675 <- 000001 81 00 00 00 00 00 05 02 00 01 00000012 ifdhandler.c:1832:IFDHICCPresence() Card absent 00000009 ifdhandler.c:291:IFDHPolling() usb:076b/1021:libudev:0:/dev/bus/usb/002/009 (lun: 10000) 600000 ms 00000007 ccid_usb.c:1195:InterruptRead() before (1) 00000350 <- 000000 80 01 00 00 00 00 24 00 00 00 B0 00000012 commands.c:1732:T0ProcACK() Enter, is_rcv = 1 00000012 -> 000000 6F 00 00 00 00 00 25 00 A2 00 00181038 <- 000000 80 A2 00 00 00 00 25 00 00 00 30 6C 02 01 01 04 0A 18 92 46 00 01 50 60 77 77 30 0C 0A 56 52 4B 2D 46 49 4E 45 49 44 80 0D 48 45 4E 4B 49 4C 4F 4B 4F 52 54 54 49 03 02 06 40 A2 38 30 0C 02 01 00 02 01 01 05 00 03 02 02 44 30 0C 02 01 01 02 01 03 05 00 03 02 02 44 30 0C 02 01 02 02 01 06 05 00 03 02 06 40 30 0C 02 01 03 02 01 00 05 00 03 02 00 01 13 02 66 69 FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 90 00 00000026 commands.c:1834:T0ProcACK() Exit 00000088 SW: 30 6C 02 01 01 04 0A 18 92 46 00 01 50 60 77 77 30 0C 0A 56 52 4B 2D 46 49 4E 45 49 44 80 0D 48 45 4E 4B 49 4C 4F 4B 4F 52 54 54 49 03 02 06 40 A2 38 30 0C 02 01 00 02 01 01 05 00 03 02 02 44 30 0C 02 01 01 02 01 03 05 00 03 02 02 44 30 0C 02 01 02 02 01 06 05 00 03 02 06 40 30 0C 02 01 03 02 01 00 05 00 03 02 00 01 13 02 66 69 FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 90 00 00000010 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000008 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000134 ifdhandler.c:1711:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000018 -> 000000 65 00 00 00 00 00 26 00 00 00 00000465 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000021 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000008 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000009 APDU: 00 A4 08 00 02 44 02 00000079 <- 000000 81 A2 00 00 00 00 26 00 00 00 00000011 ifdhandler.c:1832:IFDHICCPresence() Card present 00000012 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 600000 ms 00000006 ccid_usb.c:1195:InterruptRead() before (0) 00000116 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000012 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 7 bytes 00000015 -> 000000 6F 05 00 00 00 00 27 00 01 00 00 A4 08 00 02 00009834 <- 000000 80 01 00 00 00 00 27 00 00 00 A4 00000021 commands.c:1732:T0ProcACK() Enter, is_rcv = 0 00000012 -> 000000 6F 02 00 00 00 00 28 00 01 00 44 02 00004791 commands.c:1834:T0ProcACK() Exit 00003811 <- 000000 80 01 00 00 00 00 28 00 00 00 61 00000024 -> 000000 6F 00 00 00 00 00 29 00 01 00 00001066 <- 000000 80 01 00 00 00 00 29 00 00 00 14 00000013 commands.c:1879:T0ProcSW1() Exit: SW=61 14 00000009 SW: 61 14 00000007 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000008 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000125 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000019 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000015 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000020 APDU: 00 C0 00 00 14 00000008 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000007 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 5 bytes 00000013 -> 000000 6F 05 00 00 00 00 2A 00 01 00 00 C0 00 00 14 00010174 <- 000000 80 01 00 00 00 00 2A 00 00 00 C0 00000031 commands.c:1732:T0ProcACK() Enter, is_rcv = 1 00000012 -> 000000 6F 00 00 00 00 00 2B 00 16 00 00024415 <- 000000 80 16 00 00 00 00 2B 00 00 00 6F 12 81 02 01 20 82 01 01 83 02 44 02 86 02 01 01 8A 01 07 90 00 00000016 commands.c:1834:T0ProcACK() Exit 00000017 SW: 6F 12 81 02 01 20 82 01 01 83 02 44 02 86 02 01 01 8A 01 07 90 00 00000006 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000018 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000214 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000019 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000009 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000008 APDU: 00 B0 00 00 00 00000008 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000007 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 5 bytes 00000012 -> 000000 6F 05 00 00 00 00 2C 00 01 00 00 B0 00 00 00 00016820 <- 000000 80 01 00 00 00 00 2C 00 00 00 B0 00000032 commands.c:1732:T0ProcACK() Enter, is_rcv = 1 00000013 -> 000000 6F 00 00 00 00 00 2D 00 02 01 00288200 <- 000000 80 02 01 00 00 00 2D 00 00 00 30 6F 30 2E 0C 1A 74 6F 64 65 6E 74 61 6D 69 73 2D 20 6A 61 20 73 61 6C 61 75 73 61 76 61 69 6E 03 02 07 80 04 01 01 30 09 30 07 03 02 05 20 04 01 01 30 0E 04 01 45 03 02 02 64 03 02 03 B8 02 01 00 A0 1F 30 1D A0 1B 30 19 02 01 04 04 14 EA FB 5F 11 5C 38 52 B9 DB F1 76 49 3E 8A 22 20 E8 98 3D D0 A1 0C 30 0A 30 04 04 02 4B 01 02 02 04 00 30 6F 30 29 0C 12 61 6C 6C 65 6B 69 72 6A 6F 69 74 75 73 61 76 61 69 6E 03 02 07 80 04 01 02 02 01 01 30 09 30 07 03 02 05 20 04 01 02 30 0F 04 01 46 03 03 06 00 40 03 02 03 B8 02 01 00 A0 1F 30 1D A0 1B 30 19 02 01 04 04 14 53 C9 97 A9 25 64 CC 79 EB F0 B4 08 34 C5 54 8B B4 74 28 1A A1 10 30 0E 30 08 04 06 3F 00 50 16 4B 02 02 02 04 00 FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 90 00 00000035 commands.c:1834:T0ProcACK() Exit 00000117 SW: 30 6F 30 2E 0C 1A 74 6F 64 65 6E 74 61 6D 69 73 2D 20 6A 61 20 73 61 6C 61 75 73 61 76 61 69 6E 03 02 07 80 04 01 01 30 09 30 07 03 02 05 20 04 01 01 30 0E 04 01 45 03 02 02 64 03 02 03 B8 02 01 00 A0 1F 30 1D A0 1B 30 19 02 01 04 04 14 EA FB 5F 11 5C 38 52 B9 DB F1 76 49 3E 8A 22 20 E8 98 3D D0 A1 0C 30 0A 30 04 04 02 4B 01 02 02 04 00 30 6F 30 29 0C 12 61 6C 6C 65 6B 69 72 6A 6F 69 74 75 73 61 76 61 69 6E 03 02 07 80 04 01 02 02 01 01 30 09 30 07 03 02 05 20 04 01 02 30 0F 04 01 46 03 03 06 00 40 03 02 03 B8 02 01 00 A0 1F 30 1D A0 1B 30 19 02 01 04 04 14 53 C9 97 A9 25 64 CC 79 EB F0 B4 08 34 C5 54 8B B4 74 28 1A A1 10 30 0E 30 08 04 06 3F 00 50 16 4B 02 02 02 04 00 FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 90 00 00000010 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000009 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000375 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000021 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000008 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000009 APDU: 00 B0 01 00 20 00000007 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000007 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 5 bytes 00000014 -> 000000 6F 05 00 00 00 00 2E 00 01 00 00 B0 01 00 20 00012632 <- 000000 80 01 00 00 00 00 2E 00 00 00 B0 00000019 commands.c:1732:T0ProcACK() Enter, is_rcv = 1 00000012 -> 000000 6F 00 00 00 00 00 2F 00 22 00 00038010 <- 000000 80 22 00 00 00 00 2F 00 00 00 FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 90 00 00000029 commands.c:1834:T0ProcACK() Exit 00000022 SW: FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 90 00 00000017 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000008 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000595 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000021 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000008 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000010 APDU: 00 A4 08 00 02 44 01 00000007 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000008 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 7 bytes 00000014 -> 000000 6F 05 00 00 00 00 30 00 01 00 00 A4 08 00 02 00009946 <- 000000 80 01 00 00 00 00 30 00 00 00 A4 00000024 commands.c:1732:T0ProcACK() Enter, is_rcv = 0 00000013 -> 000000 6F 02 00 00 00 00 31 00 01 00 44 01 00000258 commands.c:1834:T0ProcACK() Exit 00008187 <- 000000 80 01 00 00 00 00 31 00 00 00 61 00000038 -> 000000 6F 00 00 00 00 00 32 00 01 00 00001024 <- 000000 80 01 00 00 00 00 32 00 00 00 14 00000014 commands.c:1879:T0ProcSW1() Exit: SW=61 14 00000008 SW: 61 14 00000007 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000008 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000136 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000025 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000009 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000008 APDU: 00 C0 00 00 14 00000009 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000007 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 5 bytes 00000012 -> 000000 6F 05 00 00 00 00 33 00 01 00 00 C0 00 00 14 00010220 <- 000000 80 01 00 00 00 00 33 00 00 00 C0 00000031 commands.c:1732:T0ProcACK() Enter, is_rcv = 1 00000014 -> 000000 6F 00 00 00 00 00 34 00 16 00 00024581 <- 000000 80 16 00 00 00 00 34 00 00 00 6F 12 81 02 00 A0 82 01 01 83 02 44 01 86 02 01 01 8A 01 07 90 00 00000033 commands.c:1834:T0ProcACK() Exit 00000019 SW: 6F 12 81 02 00 A0 82 01 01 83 02 44 01 86 02 01 01 8A 01 07 90 00 00000008 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000009 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000217 winscard_svc.c:353:ContextThread() Received command: TRANSMIT from client 15 00000020 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000009 winscard.c:1610:SCardTransmit() Send Protocol: T=0 00000008 APDU: 00 B0 00 00 A0 00000008 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000008 commands.c:1902:CmdXfrBlockCHAR_T0() T=0: 5 bytes 00000014 -> 000000 6F 05 00 00 00 00 35 00 01 00 00 B0 00 00 A0 00015023 <- 000000 80 01 00 00 00 00 35 00 00 00 B0 00000032 commands.c:1732:T0ProcACK() Enter, is_rcv = 1 00000014 -> 000000 6F 00 00 00 00 00 36 00 A2 00 00180945 <- 000000 80 A2 00 00 00 00 36 00 00 00 30 3A 30 15 0C 0F 70 65 72 75 73 74 75 6E 6E 75 73 6C 75 6B 75 03 02 06 C0 30 03 04 01 01 A1 1C 30 1A 03 02 02 4C 0A 01 01 02 01 04 02 01 08 80 02 00 81 04 01 00 30 04 04 02 3F 00 30 44 30 1D 0C 17 61 6C 6C 65 6B 69 72 6A 6F 69 74 75 73 74 75 6E 6E 75 73 6C 75 6B 75 03 02 06 C0 30 03 04 01 02 A1 1E 30 1C 03 02 02 4C 0A 01 01 02 01 06 02 01 08 80 02 00 82 04 01 00 30 06 04 04 3F 00 50 16 FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 90 00 00000034 commands.c:1834:T0ProcACK() Exit 00000076 SW: 30 3A 30 15 0C 0F 70 65 72 75 73 74 75 6E 6E 75 73 6C 75 6B 75 03 02 06 C0 30 03 04 01 01 A1 1C 30 1A 03 02 02 4C 0A 01 01 02 01 04 02 01 08 80 02 00 81 04 01 00 30 04 04 02 3F 00 30 44 30 1D 0C 17 61 6C 6C 65 6B 69 72 6A 6F 69 74 75 73 74 75 6E 6E 75 73 6C 75 6B 75 03 02 06 C0 30 03 04 01 02 A1 1E 30 1C 03 02 02 4C 0A 01 01 02 01 06 02 01 08 80 02 00 82 04 01 00 30 06 04 04 3F 00 50 16 FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 90 00 00000034 winscard.c:1655:SCardTransmit() UnrefReader() count was: 2 00000009 winscard_svc.c:653:ContextThread() TRANSMIT rv=0x0 for client 15 00000468 winscard_svc.c:353:ContextThread() Received command: END_TRANSACTION from client 15 00000020 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000009 winscard.c:1248:SCardEndTransaction() Status: 0x00000000 00000006 winscard.c:1251:SCardEndTransaction() UnrefReader() count was: 2 00000006 winscard_svc.c:566:ContextThread() END_TRANSACTION rv=0x0 for client 15 00005754 winscard_svc.c:353:ContextThread() Received command: DISCONNECT from client 15 00000034 readerfactory.c:795:RFReaderInfoById() RefReader() count was: 1 00000009 winscard.c:873:SCardDisconnect() Active Contexts: 1 00000006 winscard.c:874:SCardDisconnect() dwDisposition: 1 00000013 ifdhandler.c:1711:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000014 -> 000000 65 00 00 00 00 00 37 00 00 00 00000552 <- 000000 81 A2 00 00 00 00 37 00 00 00 00000012 ifdhandler.c:1832:IFDHICCPresence() Card present 00000008 ifdhandler.c:1122:IFDHPowerICC() action: Reset, usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000011 -> 000000 62 00 00 00 00 00 38 01 00 00 00078772 <- 000000 80 10 00 00 00 00 38 00 00 00 3B 7B 94 00 00 80 62 12 51 56 46 69 6E 45 49 44 00000031 winscard.c:940:SCardDisconnect() Reset complete. 00000013 Card ATR: 3B 7B 94 00 00 80 62 12 51 56 46 69 6E 45 49 44 00000010 winscard.c:1039:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD 00000009 ifdhandler.c:362:IFDHGetCapabilities() tag: 0xFB2, usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000007 winscard.c:1053:SCardDisconnect() Stopping polling thread 00000007 ifdhandler.c:327:IFDHStopPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00002168 winscard.c:1066:SCardDisconnect() UnrefReader() count was: 2 00000016 winscard_svc.c:535:ContextThread() DISCONNECT rv=0x0 for client 15 00000241 ccid_usb.c:1237:InterruptRead() after (0) (3) 00000020 ccid_usb.c:1252:InterruptRead() InterruptRead (2/10): Resource temporarily unavailable 00000107 winscard_svc.c:353:ContextThread() Received command: RELEASE_CONTEXT from client 15 00000015 winscard.c:227:SCardReleaseContext() Releasing Context: 0x3E404AA0 00000009 winscard_svc.c:461:ContextThread() RELEASE_CONTEXT rv=0x0 for client 15 00001443 winscard_svc.c:345:ContextThread() Client die: 15 00000029 winscard_svc.c:978:MSGCleanupClient() Thread is stopping: dwClientID=15, threadContext @0x833aa80 00000007 winscard_svc.c:984:MSGCleanupClient() Freeing SCONTEXT @0x833aa80 00398476 eventhandler.c:490:EHStatusHandlerThread() powerState: POWER_STATE_POWERED 00000025 ifdhandler.c:1711:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000017 -> 000000 65 00 00 00 00 00 39 00 00 00 00000668 <- 000000 81 10 00 00 00 00 39 00 00 00 00000012 ifdhandler.c:1832:IFDHICCPresence() Card present 00000010 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 5000 ms 00000006 ccid_usb.c:1195:InterruptRead() before (0) 05001475 ccid_usb.c:1237:InterruptRead() after (0) (2) 00000025 ifdhandler.c:1711:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000017 -> 000000 65 00 00 00 00 00 3A 00 00 00 00000791 <- 000000 81 10 00 00 00 00 3A 00 00 00 00000013 ifdhandler.c:1832:IFDHICCPresence() Card present 00000009 ifdhandler.c:1122:IFDHPowerICC() action: PowerDown, usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000010 -> 000000 63 00 00 00 00 00 3B 00 00 00 00087596 <- 000000 81 10 00 00 00 00 3B 01 00 00 00000022 eventhandler.c:478:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED 00000010 ifdhandler.c:1711:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000011 -> 000000 65 00 00 00 00 00 3C 00 00 00 00000399 <- 000000 81 10 00 00 00 00 3C 01 00 00 00000011 ifdhandler.c:1832:IFDHICCPresence() Card present 00000009 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 600000 ms 00000006 ccid_usb.c:1195:InterruptRead() before (0) 00094505 ccid_usb.c:1237:InterruptRead() after (0) (0) 00000037 NotifySlotChange: 50 02 00000012 ifdhandler.c:1711:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 00000011 -> 000000 65 00 00 00 00 00 3D 00 00 00 00000486 <- 000000 81 10 00 00 00 00 3D 42 FE 00 00000011 ifdhandler.c:1832:IFDHICCPresence() Card absent 00000008 eventhandler.c:358:EHStatusHandlerThread() Card Removed From O2 Micro Oz776 00 00 00000009 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/002/010 (lun: 0) 600000 ms 00000007 ccid_usb.c:1195:InterruptRead() before (0)
