Skip to content

Instantly share code, notes, and snippets.

@Mironenko
Created May 24, 2021 09:34
Show Gist options
  • Save Mironenko/4798626bcf5ea12ce684d89bfb8ec1d1 to your computer and use it in GitHub Desktop.
Save Mironenko/4798626bcf5ea12ce684d89bfb8ec1d1 to your computer and use it in GitHub Desktop.
Problem with Alcor Micro AU9540
Bus 001 Device 002: ID 058f:9540 Alcor Micro Corp. AU9540 Smartcard Reader
Device Descriptor:
bLength 18
bDescriptorType 1
bcdUSB 2.01
bDeviceClass 0
bDeviceSubClass 0
bDeviceProtocol 0
bMaxPacketSize0 8
idVendor 0x058f Alcor Micro Corp.
idProduct 0x9540 AU9540 Smartcard Reader
bcdDevice 1.20
iManufacturer 1 Generic
iProduct 2 EMV Smartcard Reader
iSerial 0
bNumConfigurations 1
Configuration Descriptor:
bLength 9
bDescriptorType 2
wTotalLength 0x005d
bNumInterfaces 1
bConfigurationValue 1
iConfiguration 0
bmAttributes 0xa0
(Bus Powered)
Remote Wakeup
MaxPower 50mA
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 0
bNumEndpoints 3
bInterfaceClass 11 Chip/SmartCard
bInterfaceSubClass 0
bInterfaceProtocol 0
iInterface 0
ChipCard Interface Descriptor:
bLength 54
bDescriptorType 33
bcdCCID 1.10 (Warning: Only accurate for version 1.0)
nMaxSlotIndex 0
bVoltageSupport 7 5.0V 3.0V 1.8V
dwProtocols 3 T=0 T=1
dwDefaultClock 3700
dwMaxiumumClock 12000
bNumClockSupported 3
dwDataRate 9946 bps
dwMaxDataRate 688172 bps
bNumDataRatesSupp. 138
dwMaxIFSD 254
dwSyncProtocols 00000007 2-wire 3-wire I2C
dwMechanical 00000000
dwFeatures 000404BE
Auto configuration based on ATR
Auto activation on insert
Auto voltage selection
Auto clock change
Auto baud rate change
Auto PPS made by CCID
Auto IFSD exchange
Short and extended APDU level exchange
dwMaxCCIDMsgLen 272
bClassGetResponse echo
bClassEnvelope echo
wlcdLayout none
bPINSupport 0
bMaxCCIDBusySlots 1
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 3
Transfer Type Interrupt
Synch Type None
Usage Type Data
wMaxPacketSize 0x0004 1x 4 bytes
bInterval 1
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x02 EP 2 OUT
bmAttributes 2
Transfer Type Bulk
Synch Type None
Usage Type Data
wMaxPacketSize 0x0010 1x 16 bytes
bInterval 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x83 EP 3 IN
bmAttributes 2
Transfer Type Bulk
Synch Type None
Usage Type Data
wMaxPacketSize 0x0010 1x 16 bytes
bInterval 0
Binary Object Store Descriptor:
bLength 5
bDescriptorType 15
wTotalLength 0x000c
bNumDeviceCaps 1
USB 2.0 Extension Device Capability:
bLength 7
bDescriptorType 16
bDevCapabilityType 2
bmAttributes 0x00000002
HIRD Link Power Management (LPM) Supported
can't get debug descriptor: Resource temporarily unavailable
Device Status: 0x0000
(Bus Powered)
00000000 debuglog.c:299:DebugLogSetLevel() debug level=debug
00000068 configfile.l:293:DBGetReaderListDir() Parsing conf directory: /etc/reader.conf.d
00000008 configfile.l:329:DBGetReaderListDir() Skipping non regular file: .
00000002 configfile.l:369:DBGetReaderList() Parsing conf file: /etc/reader.conf.d/libccidtwin
00000021 configfile.l:329:DBGetReaderListDir() Skipping non regular file: ..
00000005 pcscdaemon.c:663:main() pcsc-lite 1.9.1 daemon ready.
00003397 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000085 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000088 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x058F, PID: 0x9540, path: /dev/bus/usb/001/002
00000004 hotplug_libudev.c:440:HPAddDevice() Adding USB device: Alcor Micro AU9540
00000023 readerfactory.c:1079:RFInitializeReader() Attempting startup of Alcor Micro AU9540 00 00 using /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so
00000117 readerfactory.c:954:RFBindFunctions() Loading IFD Handler 3.0
00000030 ifdhandler.c:2026:init_driver() Driver version: 1.4.34
00000562 ifdhandler.c:2043:init_driver() LogLevel: 0x000F
00000004 ifdhandler.c:2054:init_driver() DriverOptions: 0x0000
00000164 ifdhandler.c:110:CreateChannelByNameOrChannel() Lun: 0, device: usb:058f/9540:libudev:0:/dev/bus/usb/001/002
00000007 ccid_usb.c:237:OpenUSBByName() Reader index: 0, Device: usb:058f/9540:libudev:0:/dev/bus/usb/001/002
00000004 ccid_usb.c:269:OpenUSBByName() interface_number: 0
00000001 ccid_usb.c:270:OpenUSBByName() usb bus/device: 1/2
00000001 ccid_usb.c:302:OpenUSBByName() Using: /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist
00000514 ccid_usb.c:320:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau (ludovic.rousseau@free.fr)
00000003 ccid_usb.c:321:OpenUSBByName() ifdProductString: Generic CCID driver
00000001 ccid_usb.c:322: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.
00003007 ccid_usb.c:406:OpenUSBByName() Try device: 1/2
00000008 ccid_usb.c:416:OpenUSBByName() vid/pid : 058F/9540
00000001 ccid_usb.c:487:OpenUSBByName() Checking device: 1/2
00000001 ccid_usb.c:558:OpenUSBByName() Trying to open USB bus/device: 1/2
00114942 ccid_usb.c:664:OpenUSBByName() Found Vendor/Product: 058F/9540 (Alcor Micro AU9540)
00000023 ccid_usb.c:666:OpenUSBByName() Using USB bus/device: 1/2
00000006 ccid_usb.c:1287:ControlUSB() request: 0x03
00010654 receive: 0F 07 00 00 C5 07 00 00 69 09 00 00 B7 09 00 00 F3 0C 00 00 1D 0E 00 00 8A 0F 00 00 D2 12 00 00 6D 13 00 00 E7 19 00 00 3B 1C 00 00 15 1F 00 00 A3 25 00 00 DA 26 00 00 CE 33 00 00 75 38 00 00 2A 3E 00 00 47 4B 00 00 B4 4D 00 00 B0 54 00 00 3F 5D 00 00 9B 67 00 00 EA 70 00 00 8F 74 00 00 54 7C 00 00 25 8D 00 00 8E 96 00 00 69 9B 00 00 5F A9 00 00 31 BC 00 00 43 C2 00 00 37 CF 00 00 D5 E1 00 00 1D E9 00 00 A8 F8 00 00 04 03 01 00 4A 1A 01 00 1B 2D 01 00 D2 36 01 00 BF 52 01 00 62 78 01 00 86 84 01 00 6D 9E 01 00 A9 C3 01 00 3B D2 01 00 08 06 02 00 93 34 02 00 37 5A 02 00 A4 6D 02 00 0D 09 03 00 DA 3C 03 00 52 87 03 00 48 DB 04 00 28 09 00 00 15 0A 00 00 35 0C 00 00 9A 0C 00 00 CD 10 00 00 50 12 00 00 29 14 00 00 E3 16 00 00 6A 18 00 00 34 19 00 00 85 1E 00 00 81 1F 00 00 9A 21 00 00 9F 24 00 00 53 28 00 00 01 2A 00 00 C7 2D 00 00 D4 30 00 00 67 32 00 00 09 3D 00 00 01 3F 00 00 34 43 00 00 3E 49 00 00 A5 50 00 00 01 54 00 00 8E 5B 00 00 A8 61 00 00 CE 64 00 00 DD 6D 00 00 F8 78 00 00 12 7A 00 00 02 7E 00 00 69 86 00 00 7C 92 00 00 36 97 00 00 4A A1 00 00 03 A8 00 00 1B B7 00 00 50 C3 00 00 9D C9 00 00 BA DB 00 00 24 F4 00 00 04 FC 00 00 D1 0C 01 00 A9 12 01 00 F8 24 01 00 6B 2E 01 00 95 42 01 00 06 50 01 00 36 6E 01 00 06 7A 01 00 A0 86 01 00 3A 93 01 00 74 B7 01 00 C4 C9 01 00 48 E8 01 00 50 F1 01 00 08 F8 01 00 A2 19 02 00 F0 49 02 00 5A 62 02 00 0A 76 02 00 29 85 02 00 0B A0 02 00 6C DC 02 00 40 0D 03 00 74 26 03 00 0E 48 03 00 90 D0 03 00 11 F0 03 00 45 33 04 00 E0 93 04 00 6D B4 04 00 16 40 05 00 D8 B8 05 00 80 1A 06 00 E7 4C 06 00 B5 79 06 00 A4 0E 07 00 20 A1 07 00 21 E0 07 00 8A 66 08 00 C0 27 09 00 8F B6 09 00 2C 80 0A 00
00000031 ccid_usb.c:1267:get_data_rates() declared: 1807 bps
00000005 ccid_usb.c:1267:get_data_rates() declared: 1989 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 2409 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 2487 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 3315 bps
00000008 ccid_usb.c:1267:get_data_rates() declared: 3613 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 3978 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 4818 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 4973 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 6631 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 7227 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 7957 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 9635 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 9946 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 13262 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 14453 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 15914 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 19271 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 19892 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 21680 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 23871 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 26523 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 28906 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 29839 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 31828 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 36133 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 38542 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 39785 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 43359 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 48177 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 49731 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 53047 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 57813 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 59677 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 63656 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 66308 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 72266 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 77083 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 79570 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 86719 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 96354 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 99462 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 106093 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 115625 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 119355 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 132616 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 144531 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 154167 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 159140 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 198925 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 212186 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 231250 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 318280 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 2344 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 2581 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 3125 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 3226 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 4301 bps
00000005 ccid_usb.c:1267:get_data_rates() declared: 4688 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 5161 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 5859 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 6250 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 6452 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 7813 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 8065 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 8602 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 9375 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 10323 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 10753 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 11719 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 12500 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 12903 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 15625 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 16129 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 17204 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 18750 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 20645 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 21505 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 23438 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 25000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 25806 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 28125 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 30968 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 31250 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 32258 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 34409 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 37500 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 38710 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 41290 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 43011 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 46875 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 50000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 51613 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 56250 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 62500 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 64516 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 68817 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 70313 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 75000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 77419 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 82581 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 86022 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 93750 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 96774 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 100000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 103226 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 112500 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 117188 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 125000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 127312 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 129032 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 137634 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 150000 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 156250 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 161290 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 165161 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 172043 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 187500 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 200000 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 206452 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 215054 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 250000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 258065 bps
00000008 ccid_usb.c:1267:get_data_rates() declared: 275269 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 300000 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 308333 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 344086 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 375000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 400000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 412903 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 424373 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 462500 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 500000 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 516129 bps
00000011 ccid_usb.c:1267:get_data_rates() declared: 550538 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 600000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 636559 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 688172 bps
00001619 ccid_usb.c:1340:InterruptRead() before (0), timeout: 100 ms
00000601 ccid_usb.c:1386:InterruptRead() after (0) (0)
00000020 NotifySlotChange: 50 02
00000008 -> 000000 65 00 00 00 00 00 00 00 00 00
00000848 <- 000000 81 00 00 00 00 00 00 42 FE 01
00000023 -> 000000 65 00 00 00 00 00 01 00 00 00
00000824 <- 000000 81 00 00 00 00 00 01 42 FE 01
00000026 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFB3, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000005 readerfactory.c:400:RFAddReader() Using the reader polling thread
00000005 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000006 -> 000000 65 00 00 00 00 00 02 00 00 00
00000832 <- 000000 81 00 00 00 00 00 02 42 FE 01
00000023 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000158 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFAE, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000012 ifdhandler.c:484:IFDHGetCapabilities() Reader supports 1 slot(s)
00000087 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000022 -> 000000 65 00 00 00 00 00 03 00 00 00
00000457 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000287 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x8087, PID: 0x0026, path: /dev/bus/usb/001/005
00000138 <- 000000 81 00 00 00 00 00 03 42 FE 01
00000022 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000009 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000012 -> 000000 65 00 00 00 00 00 04 00 00 00
00000085 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x8087, PID: 0x0026, path: /dev/bus/usb/001/005
00000244 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000256 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x05AC, PID: 0x1402, path: /dev/bus/usb/001/006
00000166 <- 000000 81 00 00 00 00 00 04 42 FE 01
00000018 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000008 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 600000 ms
00000005 ccid_usb.c:1340:InterruptRead() before (0), timeout: 600000 ms
00000041 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000245 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000249 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000276 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000255 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000246 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000233 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000259 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x06CB, PID: 0x00BD, path: /dev/bus/usb/001/004
00000413 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0003, path: /dev/bus/usb/002/001
00000754 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/003/001
00000752 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0003, path: /dev/bus/usb/004/001
06096972 ccid_usb.c:1386:InterruptRead() after (0) (0)
00000029 NotifySlotChange: 50 03
00000011 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000011 -> 000000 65 00 00 00 00 00 05 00 00 00
00010140 <- 000000 81 00 00 00 00 00 05 01 00 01
00000029 ifdhandler.c:2006:IFDHICCPresence() Card present
00000009 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000010 -> 000000 65 00 00 00 00 00 06 00 00 00
00000810 <- 000000 81 00 00 00 00 00 06 01 00 01
00000021 ifdhandler.c:2006:IFDHICCPresence() Card present
00000008 ifdhandler.c:1184:IFDHPowerICC() action: PowerUp, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000011 -> 000000 62 00 00 00 00 00 07 00 00 00
00185656 <- 000000 80 13 00 00 00 00 07 00 00 00 3B 9C 96 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C1
00000039 eventhandler.c:406:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
00000005 eventhandler.c:423:EHStatusHandlerThread() Card inserted into Alcor Micro AU9540 00 00
00000013 Card ATR: 3B 9C 96 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C1
00000008 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 5000 ms
00000006 ccid_usb.c:1340:InterruptRead() before (0), timeout: 5000 ms
05000402 ccid_usb.c:1386:InterruptRead() after (0) (2)
00000031 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000014 -> 000000 65 00 00 00 00 00 08 00 00 00
00000952 <- 000000 81 00 00 00 00 00 08 00 00 00
00000019 ifdhandler.c:2006:IFDHICCPresence() Card present
00000007 ifdhandler.c:1184:IFDHPowerICC() action: PowerDown, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000007 -> 000000 63 00 00 00 00 00 09 00 00 00
00041015 <- 000000 81 00 00 00 00 00 09 01 00 01
00000030 eventhandler.c:482:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED
00000010 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000010 -> 000000 65 00 00 00 00 00 0A 00 00 00
00000869 <- 000000 81 00 00 00 00 00 0A 01 00 01
00000022 ifdhandler.c:2006:IFDHICCPresence() Card present
00000008 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 600000 ms
00000007 ccid_usb.c:1340:InterruptRead() before (0), timeout: 600000 ms
07988170 winscard_msg_srv.c:256:ProcessEventsServer() Common channel packet arrival
00000017 winscard_msg_srv.c:267:ProcessEventsServer() ProcessCommonChannelRequest detects: 12
00000002 pcscdaemon.c:133:SVCServiceRunLoop() A new context thread creation is requested: 12
00000141 winscard_svc.c:340:ContextThread() Authorized PC/SC client
00000005 winscard_svc.c:343:ContextThread() Thread is started: dwClientID=12, threadContext @0x55c564058ba0
00000006 winscard_svc.c:361:ContextThread() Received command: CMD_VERSION from client 12
00000003 winscard_svc.c:373:ContextThread() Client is protocol version 4:4
00000001 winscard_svc.c:396:ContextThread() CMD_VERSION rv=0x0 for client 12
00000109 winscard_svc.c:361:ContextThread() Received command: ESTABLISH_CONTEXT from client 12
00000006 winscard.c:215:SCardEstablishContext() Establishing Context: 0x7692B15A
00000002 winscard_svc.c:461:ContextThread() ESTABLISH_CONTEXT rv=0x0 for client 12
00000097 winscard_svc.c:361:ContextThread() Received command: CMD_GET_READERS_STATE from client 12
00000100 winscard_svc.c:361:ContextThread() Received command: CMD_GET_READERS_STATE from client 12
00000110 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000022 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000033 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000003 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000078 winscard_svc.c:361:ContextThread() Received command: CONNECT from client 12
00000006 winscard_svc.c:499:ContextThread() Authorized client for 'Alcor Micro AU9540 00 00'
00000001 winscard.c:258:SCardConnect() Attempting Connect to Alcor Micro AU9540 00 00 using protocol: 3
00000002 readerfactory.c:825:RFReaderInfo() RefReader() count was: 1
00000003 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000003 -> 000000 65 00 00 00 00 00 0B 00 00 00
00000706 <- 000000 81 00 00 00 00 00 0B 01 00 01
00000002 ifdhandler.c:2006:IFDHICCPresence() Card present
00000002 ifdhandler.c:1184:IFDHPowerICC() action: PowerUp, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000002 -> 000000 62 00 00 00 00 00 0C 00 00 00
00185319 <- 000000 80 13 00 00 00 00 0C 00 00 00 3B 9C 96 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C1
00000032 winscard.c:332:SCardConnect() power up complete.
00000009 Card ATR: 3B 9C 96 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C1
00000004 winscard.c:352:SCardConnect() powerState: POWER_STATE_IN_USE
00000004 prothandler.c:107:PHSetProtocol() Attempting PTS to T=1
00000006 ifdhandler.c:715:IFDHSetProtocolParameters() protocol T=1, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000004 ifdhandler.c:2101:find_baud_rate() Card baud rate: 231250
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 1807
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 1989
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 2409
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 2487
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 3315
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 3613
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 3978
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 4818
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 4973
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 6631
00000006 ifdhandler.c:2110:find_baud_rate() Reader can do: 7227
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 7957
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 9635
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 9946
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 13262
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 14453
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 15914
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 19271
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 19892
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 21680
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 23871
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 26523
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 28906
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 29839
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 31828
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 36133
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 38542
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 39785
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 43359
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 48177
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 49731
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 53047
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 57813
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 59677
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 63656
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 66308
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 72266
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 77083
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 79570
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 86719
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 96354
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 99462
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 106093
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 115625
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 119355
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 132616
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 144531
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 154167
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 159140
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 198925
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 212186
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 231250
00000003 ifdhandler.c:847:IFDHSetProtocolParameters() Set speed to 231250 bauds
00000004 ifdhandler.c:1043:IFDHSetProtocolParameters() IFSC (TA3) present: 64
00000004 ifdhandler.c:1047:IFDHSetProtocolParameters() Timeout: 11780 ms
00000005 commands.c:2310:SetParameters() length: 7 bytes
00000014 -> 000000 61 07 00 00 00 00 0D 01 00 00 96 10 00 4D 00 40 00
00067464 <- 000000 82 07 00 00 00 00 0D 00 00 01 96 10 00 4D 00 40 00
00000031 winscard.c:430:SCardConnect() Active Protocol: T=1
00000009 winscard.c:456:SCardConnect() hCard Identity: a77cddd
00000006 winscard.c:518:SCardConnect() UnrefReader() count was: 2
00000007 winscard_svc.c:519:ContextThread() CONNECT rv=0x0 for client 12
00000225 winscard_svc.c:361:ContextThread() Received command: CONTROL from client 12
00000033 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000012 ifdhandler.c:1441:IFDHControl() ControlCode: 0x42000D48, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000004 Control TxBuffer:
00000008 Control RxBuffer: 12 04 42 33 00 12
00000005 winscard.c:1359:SCardControl() UnrefReader() count was: 2
00000005 winscard_svc.c:741:ContextThread() CONTROL rv=0x0 for client 12
00000187 winscard_svc.c:361:ContextThread() Received command: CONTROL from client 12
00000033 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000011 ifdhandler.c:1441:IFDHControl() ControlCode: 0x42330012, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000004 Control TxBuffer:
00000019 Control RxBuffer: 01 02 00 00 03 01 00 09 01 00 0B 02 8F 05 0C 02 40 95 0A 04 00 00 01 00
00000006 winscard.c:1359:SCardControl() UnrefReader() count was: 2
00000008 winscard_svc.c:741:ContextThread() CONTROL rv=0x0 for client 12
00000170 winscard_svc.c:361:ContextThread() Received command: CONTROL from client 12
00000033 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000010 ifdhandler.c:1441:IFDHControl() ControlCode: 0x42330012, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000004 Control TxBuffer:
00000020 Control RxBuffer: 01 02 00 00 03 01 00 09 01 00 0B 02 8F 05 0C 02 40 95 0A 04 00 00 01 00
00000007 winscard.c:1359:SCardControl() UnrefReader() count was: 2
00000005 winscard_svc.c:741:ContextThread() CONTROL rv=0x0 for client 12
00000181 winscard_svc.c:361:ContextThread() Received command: GET_ATTRIB from client 12
00000032 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000012 ifdhandler.c:388:IFDHGetCapabilities() tag: 0x10100, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000015 winscard.c:1434:SCardGetAttrib() UnrefReader() count was: 2
00000007 winscard_svc.c:770:ContextThread() GET_ATTRIB rv=0x0 for client 12
00000113 winscard_svc.c:361:ContextThread() Received command: GET_ATTRIB from client 12
00000051 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000010 ifdhandler.c:388:IFDHGetCapabilities() tag: 0x10102, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000005 winscard.c:1434:SCardGetAttrib() UnrefReader() count was: 2
00000005 winscard_svc.c:770:ContextThread() GET_ATTRIB rv=0x0 for client 12
00000182 winscard_svc.c:361:ContextThread() Received command: DISCONNECT from client 12
00000033 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000007 winscard.c:881:SCardDisconnect() Active Contexts: 1
00000006 winscard.c:882:SCardDisconnect() dwDisposition: 0
00000006 winscard.c:1017:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD
00000008 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFB2, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000004 winscard.c:1030:SCardDisconnect() Stopping polling thread
00000006 ifdhandler.c:353:IFDHStopPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000100 winscard.c:1043:SCardDisconnect() UnrefReader() count was: 2
00000009 winscard_svc.c:556:ContextThread() DISCONNECT rv=0x0 for client 12
00000027 ccid_usb.c:1386:InterruptRead() after (0) (3)
00000014 ccid_usb.c:1399:InterruptRead() InterruptRead (1/2): 3
00004449 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000018 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00001177 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000023 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000078 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000019 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000085 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000018 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000108 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000016 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00001126 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000022 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000072 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000017 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000154 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000028 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000102 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000013 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00001106 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000016 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000066 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000014 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000073 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000016 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000068 winscard_svc.c:361:ContextThread() Received command: CONNECT from client 12
00000021 winscard_svc.c:499:ContextThread() Authorized client for 'Alcor Micro AU9540 00 00'
00000007 winscard.c:258:SCardConnect() Attempting Connect to Alcor Micro AU9540 00 00 using protocol: 3
00000006 readerfactory.c:825:RFReaderInfo() RefReader() count was: 1
00000005 winscard.c:352:SCardConnect() powerState: POWER_STATE_IN_USE
00000006 winscard.c:430:SCardConnect() Active Protocol: T=1
00000007 winscard.c:456:SCardConnect() hCard Identity: 6c29098c
00000006 winscard.c:518:SCardConnect() UnrefReader() count was: 2
00000007 winscard_svc.c:519:ContextThread() CONNECT rv=0x0 for client 12
00000168 winscard_svc.c:361:ContextThread() Received command: BEGIN_TRANSACTION from client 12
00000021 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000008 winscard.c:1082:SCardBeginTransaction() Status: 0x00000000
00000004 winscard.c:1085:SCardBeginTransaction() UnrefReader() count was: 2
00000006 winscard_svc.c:571:ContextThread() BEGIN_TRANSACTION rv=0x0 for client 12
00000085 winscard_svc.c:361:ContextThread() Received command: TRANSMIT from client 12
00000025 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000006 winscard.c:1595:SCardTransmit() Send Protocol: T=1
00000010 APDU: 00 A4 00 00 02 3F 00 00
00000008 ifdhandler.c:1333:IFDHTransmitToICC() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000005 commands.c:1670:CmdXfrBlockAPDU_extended() T=0 (extended): 8 bytes
00000014 -> 000000 6F 08 00 00 00 00 0E 00 00 00 00 A4 00 00 02 3F 00 00
00085369 <- 000000 80 28 00 00 00 00 0E 00 00 00 6F 24 80 02 00 00 81 02 00 40 82 02 38 00 83 02 3F 00 8A 01 05 86 0F 47 02 02 01 00 00 00 FF 00 00 00 00 00 00 00 90 00
00000043 SW: 6F 24 80 02 00 00 81 02 00 40 82 02 38 00 83 02 3F 00 8A 01 05 86 0F 47 02 02 01 00 00 00 FF 00 00 00 00 00 00 00 90 00
00000006 winscard.c:1648:SCardTransmit() UnrefReader() count was: 2
00000006 winscard_svc.c:691:ContextThread() TRANSMIT rv=0x0 for client 12
00000247 winscard_svc.c:361:ContextThread() Received command: END_TRANSACTION from client 12
00000035 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000008 winscard.c:1234:SCardEndTransaction() Status: 0x00000000
00000005 winscard.c:1237:SCardEndTransaction() UnrefReader() count was: 2
00000005 winscard_svc.c:587:ContextThread() END_TRANSACTION rv=0x0 for client 12
00000177 winscard_svc.c:361:ContextThread() Received command: BEGIN_TRANSACTION from client 12
00000035 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000009 winscard.c:1082:SCardBeginTransaction() Status: 0x00000000
00000005 winscard.c:1085:SCardBeginTransaction() UnrefReader() count was: 2
00000006 winscard_svc.c:571:ContextThread() BEGIN_TRANSACTION rv=0x0 for client 12
00000167 winscard_svc.c:361:ContextThread() Received command: END_TRANSACTION from client 12
00000034 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000009 winscard.c:1234:SCardEndTransaction() Status: 0x00000000
00000005 winscard.c:1237:SCardEndTransaction() UnrefReader() count was: 2
00000005 winscard_svc.c:587:ContextThread() END_TRANSACTION rv=0x0 for client 12
00304776 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000038 -> 000000 65 00 00 00 00 00 0F 00 00 00
00001842 <- 000000 81 00 00 00 00 00 0F 00 00 00
00000027 ifdhandler.c:2006:IFDHICCPresence() Card present
00000011 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 600000 ms
00000006 ccid_usb.c:1340:InterruptRead() before (0), timeout: 600000 ms
03187381 winscard_svc.c:354:ContextThread() Client die: 12
00000025 winscard.c:229:SCardReleaseContext() Releasing Context: 0x7692B15A
00000006 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000002 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 2
00000001 winscard.c:881:SCardDisconnect() Active Contexts: 1
00000002 winscard.c:882:SCardDisconnect() dwDisposition: 0
00000003 winscard.c:1017:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD
00000004 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFB2, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000002 winscard.c:1030:SCardDisconnect() Stopping polling thread
00000002 ifdhandler.c:353:IFDHStopPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000051 winscard.c:1043:SCardDisconnect() UnrefReader() count was: 3
00000004 winscard_svc.c:937:MSGRemoveContext() UnrefReader() count was: 2
00000004 winscard_svc.c:1061:MSGCleanupClient() Thread is stopping: dwClientID=12, threadContext @0x55c564058ba0
00000002 winscard_svc.c:1069:MSGCleanupClient() Freeing SCONTEXT @0x55c564058ba0
00000013 ccid_usb.c:1386:InterruptRead() after (0) (3)
00000005 ccid_usb.c:1399:InterruptRead() InterruptRead (1/2): 3
00400532 eventhandler.c:494:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
00000020 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000008 -> 000000 65 00 00 00 00 00 10 00 00 00
00001622 <- 000000 81 00 00 00 00 00 10 00 00 00
00000017 ifdhandler.c:2006:IFDHICCPresence() Card present
00000007 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 5000 ms
00000003 ccid_usb.c:1340:InterruptRead() before (0), timeout: 5000 ms
00000000 debuglog00000000 debuglog.c:299:DebugLogSetLevel() debug level=debug
00000066 configfile.l:293:DBGetReaderListDir() Parsing conf directory: /etc/reader.conf.d
00000009 configfile.l:329:DBGetReaderListDir() Skipping non regular file: .
00000001 configfile.l:369:DBGetReaderList() Parsing conf file: /etc/reader.conf.d/libccidtwin
00000019 configfile.l:329:DBGetReaderListDir() Skipping non regular file: ..
00000003 pcscdaemon.c:663:main() pcsc-lite 1.9.1 daemon ready.
00003621 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000083 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000088 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x058F, PID: 0x9540, path: /dev/bus/usb/001/002
00000005 hotplug_libudev.c:440:HPAddDevice() Adding USB device: Alcor Micro AU9540
00000023 readerfactory.c:1079:RFInitializeReader() Attempting startup of Alcor Micro AU9540 00 00 using /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so
00000110 readerfactory.c:954:RFBindFunctions() Loading IFD Handler 3.0
00000015 ifdhandler.c:2026:init_driver() Driver version: 1.4.34
00000558 ifdhandler.c:2043:init_driver() LogLevel: 0x000F
00000004 ifdhandler.c:2054:init_driver() DriverOptions: 0x0000
00000183 ifdhandler.c:110:CreateChannelByNameOrChannel() Lun: 0, device: usb:058f/9540:libudev:0:/dev/bus/usb/001/002
00000007 ccid_usb.c:237:OpenUSBByName() Reader index: 0, Device: usb:058f/9540:libudev:0:/dev/bus/usb/001/002
00000005 ccid_usb.c:269:OpenUSBByName() interface_number: 0
00000001 ccid_usb.c:270:OpenUSBByName() usb bus/device: 1/2
00000001 ccid_usb.c:302:OpenUSBByName() Using: /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist
00000556 ccid_usb.c:320:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau (ludovic.rousseau@free.fr)
00000004 ccid_usb.c:321:OpenUSBByName() ifdProductString: Generic CCID driver
00000001 ccid_usb.c:322: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.
00003451 ccid_usb.c:406:OpenUSBByName() Try device: 1/2
00000011 ccid_usb.c:416:OpenUSBByName() vid/pid : 058F/9540
00000001 ccid_usb.c:487:OpenUSBByName() Checking device: 1/2
00000002 ccid_usb.c:558:OpenUSBByName() Trying to open USB bus/device: 1/2
00118663 ccid_usb.c:664:OpenUSBByName() Found Vendor/Product: 058F/9540 (Alcor Micro AU9540)
00000023 ccid_usb.c:666:OpenUSBByName() Using USB bus/device: 1/2
00000005 ccid_usb.c:1287:ControlUSB() request: 0x03
00009738 receive: 0F 07 00 00 C5 07 00 00 69 09 00 00 B7 09 00 00 F3 0C 00 00 1D 0E 00 00 8A 0F 00 00 D2 12 00 00 6D 13 00 00 E7 19 00 00 3B 1C 00 00 15 1F 00 00 A3 25 00 00 DA 26 00 00 CE 33 00 00 75 38 00 00 2A 3E 00 00 47 4B 00 00 B4 4D 00 00 B0 54 00 00 3F 5D 00 00 9B 67 00 00 EA 70 00 00 8F 74 00 00 54 7C 00 00 25 8D 00 00 8E 96 00 00 69 9B 00 00 5F A9 00 00 31 BC 00 00 43 C2 00 00 37 CF 00 00 D5 E1 00 00 1D E9 00 00 A8 F8 00 00 04 03 01 00 4A 1A 01 00 1B 2D 01 00 D2 36 01 00 BF 52 01 00 62 78 01 00 86 84 01 00 6D 9E 01 00 A9 C3 01 00 3B D2 01 00 08 06 02 00 93 34 02 00 37 5A 02 00 A4 6D 02 00 0D 09 03 00 DA 3C 03 00 52 87 03 00 48 DB 04 00 28 09 00 00 15 0A 00 00 35 0C 00 00 9A 0C 00 00 CD 10 00 00 50 12 00 00 29 14 00 00 E3 16 00 00 6A 18 00 00 34 19 00 00 85 1E 00 00 81 1F 00 00 9A 21 00 00 9F 24 00 00 53 28 00 00 01 2A 00 00 C7 2D 00 00 D4 30 00 00 67 32 00 00 09 3D 00 00 01 3F 00 00 34 43 00 00 3E 49 00 00 A5 50 00 00 01 54 00 00 8E 5B 00 00 A8 61 00 00 CE 64 00 00 DD 6D 00 00 F8 78 00 00 12 7A 00 00 02 7E 00 00 69 86 00 00 7C 92 00 00 36 97 00 00 4A A1 00 00 03 A8 00 00 1B B7 00 00 50 C3 00 00 9D C9 00 00 BA DB 00 00 24 F4 00 00 04 FC 00 00 D1 0C 01 00 A9 12 01 00 F8 24 01 00 6B 2E 01 00 95 42 01 00 06 50 01 00 36 6E 01 00 06 7A 01 00 A0 86 01 00 3A 93 01 00 74 B7 01 00 C4 C9 01 00 48 E8 01 00 50 F1 01 00 08 F8 01 00 A2 19 02 00 F0 49 02 00 5A 62 02 00 0A 76 02 00 29 85 02 00 0B A0 02 00 6C DC 02 00 40 0D 03 00 74 26 03 00 0E 48 03 00 90 D0 03 00 11 F0 03 00 45 33 04 00 E0 93 04 00 6D B4 04 00 16 40 05 00 D8 B8 05 00 80 1A 06 00 E7 4C 06 00 B5 79 06 00 A4 0E 07 00 20 A1 07 00 21 E0 07 00 8A 66 08 00 C0 27 09 00 8F B6 09 00 2C 80 0A 00
00000034 ccid_usb.c:1267:get_data_rates() declared: 1807 bps
00000004 ccid_usb.c:1267:get_data_rates() declared: 1989 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 2409 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 2487 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 3315 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 3613 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 3978 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 4818 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 4973 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 6631 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 7227 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 7957 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 9635 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 9946 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 13262 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 14453 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 15914 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 19271 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 19892 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 21680 bps
00000007 ccid_usb.c:1267:get_data_rates() declared: 23871 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 26523 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 28906 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 29839 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 31828 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 36133 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 38542 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 39785 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 43359 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 48177 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 49731 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 53047 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 57813 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 59677 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 63656 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 66308 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 72266 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 77083 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 79570 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 86719 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 96354 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 99462 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 106093 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 115625 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 119355 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 132616 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 144531 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 154167 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 159140 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 198925 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 212186 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 231250 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 318280 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 2344 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 2581 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 3125 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 3226 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 4301 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 4688 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 5161 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 5859 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 6250 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 6452 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 7813 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 8065 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 8602 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 9375 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 10323 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 10753 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 11719 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 12500 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 12903 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 15625 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 16129 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 17204 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 18750 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 20645 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 21505 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 23438 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 25000 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 25806 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 28125 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 30968 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 31250 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 32258 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 34409 bps
00000007 ccid_usb.c:1267:get_data_rates() declared: 37500 bps
00000009 ccid_usb.c:1267:get_data_rates() declared: 38710 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 41290 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 43011 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 46875 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 50000 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 51613 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 56250 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 62500 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 64516 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 68817 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 70313 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 75000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 77419 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 82581 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 86022 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 93750 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 96774 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 100000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 103226 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 112500 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 117188 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 125000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 127312 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 129032 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 137634 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 150000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 156250 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 161290 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 165161 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 172043 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 187500 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 200000 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 206452 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 215054 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 250000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 258065 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 275269 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 300000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 308333 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 344086 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 375000 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 400000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 412903 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 424373 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 462500 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 500000 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 516129 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 550538 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 600000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 636559 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 688172 bps
00001604 ccid_usb.c:1340:InterruptRead() before (0), timeout: 100 ms
00001317 ccid_usb.c:1386:InterruptRead() after (0) (0)
00000022 NotifySlotChange: 50 02
00000008 -> 000000 65 00 00 00 00 00 00 00 00 00
00000877 <- 000000 81 00 00 00 00 00 00 42 FE 01
00000024 -> 000000 65 00 00 00 00 00 01 00 00 00
00000819 <- 000000 81 00 00 00 00 00 01 42 FE 01
00000023 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFB3, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000006 readerfactory.c:400:RFAddReader() Using the reader polling thread
00000008 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000007 -> 000000 65 00 00 00 00 00 02 00 00 00
00000787 <- 000000 81 00 00 00 00 00 02 42 FE 01
00000018 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000120 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFAE, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000011 ifdhandler.c:484:IFDHGetCapabilities() Reader supports 1 slot(s)
00000061 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000026 -> 000000 65 00 00 00 00 00 03 00 00 00
00000213 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000090 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x8087, PID: 0x0026, path: /dev/bus/usb/001/005
00000080 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x8087, PID: 0x0026, path: /dev/bus/usb/001/005
00000073 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000082 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x05AC, PID: 0x1402, path: /dev/bus/usb/001/006
00000074 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000087 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000066 <- 000000 81 00 00 00 00 00 03 42 FE 01
00000007 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000003 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000003 -> 000000 65 00 00 00 00 00 04 00 00 00
00000015 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000090 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000076 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000076 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000071 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000077 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x06CB, PID: 0x00BD, path: /dev/bus/usb/001/004
00000130 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0003, path: /dev/bus/usb/002/001
00000145 <- 000000 81 00 00 00 00 00 04 42 FE 01
00000006 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000002 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 600000 ms
00000002 ccid_usb.c:1340:InterruptRead() before (0), timeout: 600000 ms
00000065 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/003/001
00000199 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0003, path: /dev/bus/usb/004/001
11557837 ccid_usb.c:1386:InterruptRead() after (0) (0)
00000031 NotifySlotChange: 50 03
00000008 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000008 -> 000000 65 00 00 00 00 00 05 00 00 00
00010363 <- 000000 81 00 00 00 00 00 05 01 00 01
00000033 ifdhandler.c:2006:IFDHICCPresence() Card present
00000007 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000007 -> 000000 65 00 00 00 00 00 06 00 00 00
00000838 <- 000000 81 00 00 00 00 00 06 01 00 01
00000025 ifdhandler.c:2006:IFDHICCPresence() Card present
00000006 ifdhandler.c:1184:IFDHPowerICC() action: PowerUp, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000007 -> 000000 62 00 00 00 00 00 07 00 00 00
00185720 <- 000000 80 13 00 00 00 00 07 00 00 00 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000040 eventhandler.c:406:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
00000005 eventhandler.c:423:EHStatusHandlerThread() Card inserted into Alcor Micro AU9540 00 00
00000008 Card ATR: 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000005 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 5000 ms
00000004 ccid_usb.c:1340:InterruptRead() before (0), timeout: 5000 ms
05000477 ccid_usb.c:1386:InterruptRead() after (0) (2)
00000033 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000010 -> 000000 65 00 00 00 00 00 08 00 00 00
00001058 <- 000000 81 00 00 00 00 00 08 00 00 00
00000019 ifdhandler.c:2006:IFDHICCPresence() Card present
00000006 ifdhandler.c:1184:IFDHPowerICC() action: PowerDown, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000007 -> 000000 63 00 00 00 00 00 09 00 00 00
00040893 <- 000000 81 00 00 00 00 00 09 01 00 01
00000027 eventhandler.c:482:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED
00000008 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000006 -> 000000 65 00 00 00 00 00 0A 00 00 00
00000787 <- 000000 81 00 00 00 00 00 0A 01 00 01
00000017 ifdhandler.c:2006:IFDHICCPresence() Card present
00000007 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 600000 ms
00000004 ccid_usb.c:1340:InterruptRead() before (0), timeout: 600000 ms
06035224 winscard_msg_srv.c:256:ProcessEventsServer() Common channel packet arrival
00000017 winscard_msg_srv.c:267:ProcessEventsServer() ProcessCommonChannelRequest detects: 12
00000002 pcscdaemon.c:133:SVCServiceRunLoop() A new context thread creation is requested: 12
00000148 winscard_svc.c:340:ContextThread() Authorized PC/SC client
00000005 winscard_svc.c:343:ContextThread() Thread is started: dwClientID=12, threadContext @0x55b5ffe9aba0
00000006 winscard_svc.c:361:ContextThread() Received command: CMD_VERSION from client 12
00000003 winscard_svc.c:373:ContextThread() Client is protocol version 4:4
00000001 winscard_svc.c:396:ContextThread() CMD_VERSION rv=0x0 for client 12
00000102 winscard_svc.c:361:ContextThread() Received command: ESTABLISH_CONTEXT from client 12
00000006 winscard.c:215:SCardEstablishContext() Establishing Context: 0x6CA9A43A
00000002 winscard_svc.c:461:ContextThread() ESTABLISH_CONTEXT rv=0x0 for client 12
00000098 winscard_svc.c:361:ContextThread() Received command: CMD_GET_READERS_STATE from client 12
00000101 winscard_svc.c:361:ContextThread() Received command: CMD_GET_READERS_STATE from client 12
00000113 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000020 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000103 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000005 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000024 winscard_svc.c:361:ContextThread() Received command: CONNECT from client 12
00000004 winscard_svc.c:499:ContextThread() Authorized client for 'Alcor Micro AU9540 00 00'
00000001 winscard.c:258:SCardConnect() Attempting Connect to Alcor Micro AU9540 00 00 using protocol: 3
00000002 readerfactory.c:825:RFReaderInfo() RefReader() count was: 1
00000003 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000004 -> 000000 65 00 00 00 00 00 0B 00 00 00
00000761 <- 000000 81 00 00 00 00 00 0B 01 00 01
00000006 ifdhandler.c:2006:IFDHICCPresence() Card present
00000003 ifdhandler.c:1184:IFDHPowerICC() action: PowerUp, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000003 -> 000000 62 00 00 00 00 00 0C 00 00 00
00185378 <- 000000 80 13 00 00 00 00 0C 00 00 00 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000033 winscard.c:332:SCardConnect() power up complete.
00000009 Card ATR: 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000003 winscard.c:352:SCardConnect() powerState: POWER_STATE_IN_USE
00000004 prothandler.c:107:PHSetProtocol() Attempting PTS to T=1
00000006 ifdhandler.c:715:IFDHSetProtocolParameters() protocol T=1, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000005 ifdhandler.c:2101:find_baud_rate() Card baud rate: 462500
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 1807
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 1989
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 2409
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 2487
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 3315
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 3613
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 3978
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 4818
00000006 ifdhandler.c:2110:find_baud_rate() Reader can do: 4973
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 6631
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 7227
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 7957
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 9635
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 9946
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 13262
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 14453
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 15914
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 19271
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 19892
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 21680
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 23871
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 26523
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 28906
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 29839
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 31828
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 36133
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 38542
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 39785
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 43359
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 48177
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 49731
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 53047
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 57813
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 59677
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 63656
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 66308
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 72266
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 77083
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 79570
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 86719
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 96354
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 99462
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 106093
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 115625
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 119355
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 132616
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 144531
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 154167
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 159140
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 198925
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 212186
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 231250
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 318280
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 2344
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 2581
00000006 ifdhandler.c:2110:find_baud_rate() Reader can do: 3125
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 3226
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 4301
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 4688
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 5161
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 5859
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 6250
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 6452
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 7813
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 8065
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 8602
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 9375
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 10323
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 10753
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 11719
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 12500
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 12903
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 15625
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 16129
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 17204
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 18750
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 20645
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 21505
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 23438
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 25000
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 25806
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 28125
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 30968
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 31250
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 32258
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 34409
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 37500
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 38710
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 41290
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 43011
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 46875
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 50000
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 51613
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 56250
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 62500
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 64516
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 68817
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 70313
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 75000
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 77419
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 82581
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 86022
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 93750
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 96774
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 100000
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 103226
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 112500
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 117188
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 125000
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 127312
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 129032
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 137634
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 150000
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 156250
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 161290
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 165161
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 172043
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 187500
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 200000
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 206452
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 215054
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 250000
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 258065
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 275269
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 300000
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 308333
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 344086
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 375000
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 400000
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 412903
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 424373
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 462500
00000004 ifdhandler.c:847:IFDHSetProtocolParameters() Set speed to 462500 bauds
00000004 ifdhandler.c:1043:IFDHSetProtocolParameters() IFSC (TA3) present: 64
00000003 ifdhandler.c:1047:IFDHSetProtocolParameters() Timeout: 7162 ms
00000003 commands.c:2310:SetParameters() length: 7 bytes
00000009 -> 000000 61 07 00 00 00 00 0D 01 00 00 97 10 00 4D 00 40 00
00067568 <- 000000 82 07 00 00 00 00 0D 00 00 01 97 10 00 4D 00 40 00
00000032 winscard.c:430:SCardConnect() Active Protocol: T=1
00000007 winscard.c:456:SCardConnect() hCard Identity: 6d5cb7d5
00000006 winscard.c:518:SCardConnect() UnrefReader() count was: 2
00000008 winscard_svc.c:519:ContextThread() CONNECT rv=0x0 for client 12
00000251 winscard_svc.c:361:ContextThread() Received command: CONTROL from client 12
00000033 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000011 ifdhandler.c:1441:IFDHControl() ControlCode: 0x42000D48, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000004 Control TxBuffer:
00000007 Control RxBuffer: 12 04 42 33 00 12
00000005 winscard.c:1359:SCardControl() UnrefReader() count was: 2
00000005 winscard_svc.c:741:ContextThread() CONTROL rv=0x0 for client 12
00000187 winscard_svc.c:361:ContextThread() Received command: CONTROL from client 12
00000025 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000008 ifdhandler.c:1441:IFDHControl() ControlCode: 0x42330012, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000003 Control TxBuffer:
00000018 Control RxBuffer: 01 02 00 00 03 01 00 09 01 00 0B 02 8F 05 0C 02 40 95 0A 04 00 00 01 00
00000031 winscard.c:1359:SCardControl() UnrefReader() count was: 2
00000009 winscard_svc.c:741:ContextThread() CONTROL rv=0x0 for client 12
00000217 winscard_svc.c:361:ContextThread() Received command: CONTROL from client 12
00000033 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000011 ifdhandler.c:1441:IFDHControl() ControlCode: 0x42330012, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000004 Control TxBuffer:
00000019 Control RxBuffer: 01 02 00 00 03 01 00 09 01 00 0B 02 8F 05 0C 02 40 95 0A 04 00 00 01 00
00000008 winscard.c:1359:SCardControl() UnrefReader() count was: 2
00000007 winscard_svc.c:741:ContextThread() CONTROL rv=0x0 for client 12
00000173 winscard_svc.c:361:ContextThread() Received command: GET_ATTRIB from client 12
00000031 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000012 ifdhandler.c:388:IFDHGetCapabilities() tag: 0x10100, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000015 winscard.c:1434:SCardGetAttrib() UnrefReader() count was: 2
00000008 winscard_svc.c:770:ContextThread() GET_ATTRIB rv=0x0 for client 12
00000192 winscard_svc.c:361:ContextThread() Received command: GET_ATTRIB from client 12
00000032 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000010 ifdhandler.c:388:IFDHGetCapabilities() tag: 0x10102, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000007 winscard.c:1434:SCardGetAttrib() UnrefReader() count was: 2
00000006 winscard_svc.c:770:ContextThread() GET_ATTRIB rv=0x0 for client 12
00000218 winscard_svc.c:361:ContextThread() Received command: DISCONNECT from client 12
00000034 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000007 winscard.c:881:SCardDisconnect() Active Contexts: 1
00000006 winscard.c:882:SCardDisconnect() dwDisposition: 0
00000006 winscard.c:1017:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD
00000007 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFB2, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000004 winscard.c:1030:SCardDisconnect() Stopping polling thread
00000005 ifdhandler.c:353:IFDHStopPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000107 winscard.c:1043:SCardDisconnect() UnrefReader() count was: 2
00000015 winscard_svc.c:556:ContextThread() DISCONNECT rv=0x0 for client 12
00000025 ccid_usb.c:1386:InterruptRead() after (0) (3)
00000017 ccid_usb.c:1399:InterruptRead() InterruptRead (1/2): 3
00004371 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000020 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00001201 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000022 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000191 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000024 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000197 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000026 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000254 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000022 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00001189 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000024 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000196 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000022 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000201 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000023 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000089 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000016 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00001124 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000023 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000062 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000011 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000069 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000014 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000061 winscard_svc.c:361:ContextThread() Received command: CONNECT from client 12
00000017 winscard_svc.c:499:ContextThread() Authorized client for 'Alcor Micro AU9540 00 00'
00000006 winscard.c:258:SCardConnect() Attempting Connect to Alcor Micro AU9540 00 00 using protocol: 3
00000004 readerfactory.c:825:RFReaderInfo() RefReader() count was: 1
00000006 winscard.c:352:SCardConnect() powerState: POWER_STATE_IN_USE
00000004 winscard.c:430:SCardConnect() Active Protocol: T=1
00000007 winscard.c:456:SCardConnect() hCard Identity: 6ef8bea4
00000005 winscard.c:518:SCardConnect() UnrefReader() count was: 2
00000008 winscard_svc.c:519:ContextThread() CONNECT rv=0x0 for client 12
00000206 winscard_svc.c:361:ContextThread() Received command: BEGIN_TRANSACTION from client 12
00000028 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000009 winscard.c:1082:SCardBeginTransaction() Status: 0x00000000
00000005 winscard.c:1085:SCardBeginTransaction() UnrefReader() count was: 2
00000006 winscard_svc.c:571:ContextThread() BEGIN_TRANSACTION rv=0x0 for client 12
00000088 winscard_svc.c:361:ContextThread() Received command: TRANSMIT from client 12
00000023 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000006 winscard.c:1595:SCardTransmit() Send Protocol: T=1
00000009 APDU: 00 A4 00 00 02 3F 00 00
00000007 ifdhandler.c:1333:IFDHTransmitToICC() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000006 commands.c:1670:CmdXfrBlockAPDU_extended() T=0 (extended): 8 bytes
00000017 -> 000000 6F 08 00 00 00 00 0E 00 00 00 00 A4 00 00 02 3F 00 00
02734396 <- 000000 80 00 00 00 00 00 0E 41 FB 00
00000025 commands.c:1563:CCID_Receive Hardware error
00000013 SW:
00000003 ifdwrapper.c:543:IFDTransmit() Card not transacted: 612
00000003 winscard.c:1620:SCardTransmit() Card not transacted: 0x80100016
00000003 winscard.c:1648:SCardTransmit() UnrefReader() count was: 2
00000005 winscard_svc.c:691:ContextThread() TRANSMIT rv=0x80100016 for client 12
00000045 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000012 -> 000000 65 00 00 00 00 00 0F 00 00 00
00000037 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000012 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000754 <- 000000 81 00 00 00 00 00 0F 01 00 01
00000019 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000006 eventhandler.c:358:EHStatusHandlerThread() Card Removed From Alcor Micro AU9540 00 00
00000005 winscard_svc.c:828:MSGSignalClient() Signal client: 12
00000004 winscard_svc.c:831:MSGSignalClient() SIGNAL rv=0x0 for client 12
00000014 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 600000 ms
00000004 ccid_usb.c:1340:InterruptRead() before (0), timeout: 600000 ms
00000038 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000009 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000154 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000013 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000148 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000012 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000136 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000014 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000151 winscard_svc.c:361:ContextThread() Received command: END_TRANSACTION from client 12
00000018 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000004 winscard.c:1237:SCardEndTransaction() UnrefReader() count was: 2
00000004 winscard_svc.c:587:ContextThread() END_TRANSACTION rv=0x80100069 for client 12
00000175 winscard_svc.c:361:ContextThread() Received command: DISCONNECT from client 12
00000016 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000004 winscard.c:881:SCardDisconnect() Active Contexts: 1
00000004 winscard.c:882:SCardDisconnect() dwDisposition: 0
00000004 winscard.c:1017:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD
00000004 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFB2, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000003 winscard.c:1030:SCardDisconnect() Stopping polling thread
00000003 ifdhandler.c:353:IFDHStopPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000066 winscard.c:1043:SCardDisconnect() UnrefReader() count was: 2
00000010 winscard_svc.c:556:ContextThread() DISCONNECT rv=0x0 for client 12
00000001 ccid_usb.c:1386:InterruptRead() after (0) (3)
00000007 ccid_usb.c:1399:InterruptRead() InterruptRead (1/2): 3
00000042 winscard_svc.c:361:ContextThread() Received command: RELEASE_CONTEXT from client 12
00000012 winscard.c:229:SCardReleaseContext() Releasing Context: 0x6CA9A43A
00000003 winscard_svc.c:476:ContextThread() RELEASE_CONTEXT rv=0x0 for client 12
00000032 winscard_svc.c:354:ContextThread() Client die: 12
00000025 winscard_svc.c:1061:MSGCleanupClient() Thread is stopping: dwClientID=12, threadContext @0x55b5ffe9aba0
00000004 winscard_svc.c:1069:MSGCleanupClient() Freeing SCONTEXT @0x55b5ffe9aba0
00400417 eventhandler.c:494:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
00000031 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000009 -> 000000 65 00 00 00 00 00 10 00 00 00
00001154 <- 000000 81 00 00 00 00 00 10 01 00 01
00000029 ifdhandler.c:2006:IFDHICCPresence() Card present
00000007 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000008 -> 000000 65 00 00 00 00 00 11 00 00 00
00001988 <- 000000 81 00 00 00 00 00 11 01 00 01
00000028 ifdhandler.c:2006:IFDHICCPresence() Card present
00000007 ifdhandler.c:1184:IFDHPowerICC() action: PowerUp, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000008 -> 000000 62 00 00 00 00 00 12 00 00 00
00185249 <- 000000 80 13 00 00 00 00 12 00 00 00 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000031 eventhandler.c:406:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
00000004 eventhandler.c:423:EHStatusHandlerThread() Card inserted into Alcor Micro AU9540 00 00
00000008 Card ATR: 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000006 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 5000 ms
00000003 ccid_usb.c:1340:InterruptRead() before (0), timeout: 5000 ms
05000698 ccid_usb.c:1386:InterruptRead() after (0) (2)
00000032 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000010 -> 000000 65 00 00 00 00 00 13 00 00 00
00000957 <- 000000 81 00 00 00 00 00 13 00 00 00
00000020 ifdhandler.c:2006:IFDHICCPresence() Card present
00000008 ifdhandler.c:1184:IFDHPowerICC() action: PowerDown, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000010 -> 000000 63 00 00 00 00 00 14 00 00 00
00041105 <- 000000 81 00 00 00 00 00 14 01 00 01
00000030 eventhandler.c:482:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED
00000007 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000007 -> 000000 65 00 00 00 00 00 15 00 00 00
00000962 <- 000000 81 00 00 00 00 00 15 01 00 01
00000039 ifdhandler.c:2006:IFDHICCPresence() Card present
00000011 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 600000 ms
00000005 ccid_usb.c:1340:InterruptRead() before (0), timeout: 600000 ms.c:299:DebugLogSetLevel() debug level=debug
00000066 configfile.l:293:DBGetReaderListDir() Parsing conf directory: /etc/reader.conf.d
00000009 configfile.l:329:DBGetReaderListDir() Skipping non regular file: .
00000001 configfile.l:369:DBGetReaderList() Parsing conf file: /etc/reader.conf.d/libccidtwin
00000019 configfile.l:329:DBGetReaderListDir() Skipping non regular file: ..
00000003 pcscdaemon.c:663:main() pcsc-lite 1.9.1 daemon ready.
00003621 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000083 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000088 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x058F, PID: 0x9540, path: /dev/bus/usb/001/002
00000005 hotplug_libudev.c:440:HPAddDevice() Adding USB device: Alcor Micro AU9540
00000023 readerfactory.c:1079:RFInitializeReader() Attempting startup of Alcor Micro AU9540 00 00 using /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so
00000110 readerfactory.c:954:RFBindFunctions() Loading IFD Handler 3.0
00000015 ifdhandler.c:2026:init_driver() Driver version: 1.4.34
00000558 ifdhandler.c:2043:init_driver() LogLevel: 0x000F
00000004 ifdhandler.c:2054:init_driver() DriverOptions: 0x0000
00000183 ifdhandler.c:110:CreateChannelByNameOrChannel() Lun: 0, device: usb:058f/9540:libudev:0:/dev/bus/usb/001/002
00000007 ccid_usb.c:237:OpenUSBByName() Reader index: 0, Device: usb:058f/9540:libudev:0:/dev/bus/usb/001/002
00000005 ccid_usb.c:269:OpenUSBByName() interface_number: 0
00000001 ccid_usb.c:270:OpenUSBByName() usb bus/device: 1/2
00000001 ccid_usb.c:302:OpenUSBByName() Using: /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist
00000556 ccid_usb.c:320:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau (ludovic.rousseau@free.fr)
00000004 ccid_usb.c:321:OpenUSBByName() ifdProductString: Generic CCID driver
00000001 ccid_usb.c:322: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.
00003451 ccid_usb.c:406:OpenUSBByName() Try device: 1/2
00000011 ccid_usb.c:416:OpenUSBByName() vid/pid : 058F/9540
00000001 ccid_usb.c:487:OpenUSBByName() Checking device: 1/2
00000002 ccid_usb.c:558:OpenUSBByName() Trying to open USB bus/device: 1/2
00118663 ccid_usb.c:664:OpenUSBByName() Found Vendor/Product: 058F/9540 (Alcor Micro AU9540)
00000023 ccid_usb.c:666:OpenUSBByName() Using USB bus/device: 1/2
00000005 ccid_usb.c:1287:ControlUSB() request: 0x03
00009738 receive: 0F 07 00 00 C5 07 00 00 69 09 00 00 B7 09 00 00 F3 0C 00 00 1D 0E 00 00 8A 0F 00 00 D2 12 00 00 6D 13 00 00 E7 19 00 00 3B 1C 00 00 15 1F 00 00 A3 25 00 00 DA 26 00 00 CE 33 00 00 75 38 00 00 2A 3E 00 00 47 4B 00 00 B4 4D 00 00 B0 54 00 00 3F 5D 00 00 9B 67 00 00 EA 70 00 00 8F 74 00 00 54 7C 00 00 25 8D 00 00 8E 96 00 00 69 9B 00 00 5F A9 00 00 31 BC 00 00 43 C2 00 00 37 CF 00 00 D5 E1 00 00 1D E9 00 00 A8 F8 00 00 04 03 01 00 4A 1A 01 00 1B 2D 01 00 D2 36 01 00 BF 52 01 00 62 78 01 00 86 84 01 00 6D 9E 01 00 A9 C3 01 00 3B D2 01 00 08 06 02 00 93 34 02 00 37 5A 02 00 A4 6D 02 00 0D 09 03 00 DA 3C 03 00 52 87 03 00 48 DB 04 00 28 09 00 00 15 0A 00 00 35 0C 00 00 9A 0C 00 00 CD 10 00 00 50 12 00 00 29 14 00 00 E3 16 00 00 6A 18 00 00 34 19 00 00 85 1E 00 00 81 1F 00 00 9A 21 00 00 9F 24 00 00 53 28 00 00 01 2A 00 00 C7 2D 00 00 D4 30 00 00 67 32 00 00 09 3D 00 00 01 3F 00 00 34 43 00 00 3E 49 00 00 A5 50 00 00 01 54 00 00 8E 5B 00 00 A8 61 00 00 CE 64 00 00 DD 6D 00 00 F8 78 00 00 12 7A 00 00 02 7E 00 00 69 86 00 00 7C 92 00 00 36 97 00 00 4A A1 00 00 03 A8 00 00 1B B7 00 00 50 C3 00 00 9D C9 00 00 BA DB 00 00 24 F4 00 00 04 FC 00 00 D1 0C 01 00 A9 12 01 00 F8 24 01 00 6B 2E 01 00 95 42 01 00 06 50 01 00 36 6E 01 00 06 7A 01 00 A0 86 01 00 3A 93 01 00 74 B7 01 00 C4 C9 01 00 48 E8 01 00 50 F1 01 00 08 F8 01 00 A2 19 02 00 F0 49 02 00 5A 62 02 00 0A 76 02 00 29 85 02 00 0B A0 02 00 6C DC 02 00 40 0D 03 00 74 26 03 00 0E 48 03 00 90 D0 03 00 11 F0 03 00 45 33 04 00 E0 93 04 00 6D B4 04 00 16 40 05 00 D8 B8 05 00 80 1A 06 00 E7 4C 06 00 B5 79 06 00 A4 0E 07 00 20 A1 07 00 21 E0 07 00 8A 66 08 00 C0 27 09 00 8F B6 09 00 2C 80 0A 00
00000034 ccid_usb.c:1267:get_data_rates() declared: 1807 bps
00000004 ccid_usb.c:1267:get_data_rates() declared: 1989 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 2409 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 2487 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 3315 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 3613 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 3978 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 4818 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 4973 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 6631 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 7227 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 7957 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 9635 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 9946 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 13262 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 14453 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 15914 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 19271 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 19892 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 21680 bps
00000007 ccid_usb.c:1267:get_data_rates() declared: 23871 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 26523 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 28906 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 29839 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 31828 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 36133 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 38542 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 39785 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 43359 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 48177 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 49731 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 53047 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 57813 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 59677 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 63656 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 66308 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 72266 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 77083 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 79570 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 86719 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 96354 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 99462 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 106093 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 115625 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 119355 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 132616 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 144531 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 154167 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 159140 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 198925 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 212186 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 231250 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 318280 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 2344 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 2581 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 3125 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 3226 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 4301 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 4688 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 5161 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 5859 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 6250 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 6452 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 7813 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 8065 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 8602 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 9375 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 10323 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 10753 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 11719 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 12500 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 12903 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 15625 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 16129 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 17204 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 18750 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 20645 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 21505 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 23438 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 25000 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 25806 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 28125 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 30968 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 31250 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 32258 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 34409 bps
00000007 ccid_usb.c:1267:get_data_rates() declared: 37500 bps
00000009 ccid_usb.c:1267:get_data_rates() declared: 38710 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 41290 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 43011 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 46875 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 50000 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 51613 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 56250 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 62500 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 64516 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 68817 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 70313 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 75000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 77419 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 82581 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 86022 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 93750 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 96774 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 100000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 103226 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 112500 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 117188 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 125000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 127312 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 129032 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 137634 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 150000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 156250 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 161290 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 165161 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 172043 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 187500 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 200000 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 206452 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 215054 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 250000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 258065 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 275269 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 300000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 308333 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 344086 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 375000 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 400000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 412903 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 424373 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 462500 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 500000 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 516129 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 550538 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 600000 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 636559 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 688172 bps
00001604 ccid_usb.c:1340:InterruptRead() before (0), timeout: 100 ms
00001317 ccid_usb.c:1386:InterruptRead() after (0) (0)
00000022 NotifySlotChange: 50 02
00000008 -> 000000 65 00 00 00 00 00 00 00 00 00
00000877 <- 000000 81 00 00 00 00 00 00 42 FE 01
00000024 -> 000000 65 00 00 00 00 00 01 00 00 00
00000819 <- 000000 81 00 00 00 00 00 01 42 FE 01
00000023 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFB3, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000006 readerfactory.c:400:RFAddReader() Using the reader polling thread
00000008 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000007 -> 000000 65 00 00 00 00 00 02 00 00 00
00000787 <- 000000 81 00 00 00 00 00 02 42 FE 01
00000018 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000120 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFAE, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000011 ifdhandler.c:484:IFDHGetCapabilities() Reader supports 1 slot(s)
00000061 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000026 -> 000000 65 00 00 00 00 00 03 00 00 00
00000213 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000090 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x8087, PID: 0x0026, path: /dev/bus/usb/001/005
00000080 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x8087, PID: 0x0026, path: /dev/bus/usb/001/005
00000073 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000082 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x05AC, PID: 0x1402, path: /dev/bus/usb/001/006
00000074 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000087 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000066 <- 000000 81 00 00 00 00 00 03 42 FE 01
00000007 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000003 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000003 -> 000000 65 00 00 00 00 00 04 00 00 00
00000015 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000090 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000076 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000076 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000071 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000077 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x06CB, PID: 0x00BD, path: /dev/bus/usb/001/004
00000130 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0003, path: /dev/bus/usb/002/001
00000145 <- 000000 81 00 00 00 00 00 04 42 FE 01
00000006 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000002 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 600000 ms
00000002 ccid_usb.c:1340:InterruptRead() before (0), timeout: 600000 ms
00000065 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/003/001
00000199 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0003, path: /dev/bus/usb/004/001
11557837 ccid_usb.c:1386:InterruptRead() after (0) (0)
00000031 NotifySlotChange: 50 03
00000008 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000008 -> 000000 65 00 00 00 00 00 05 00 00 00
00010363 <- 000000 81 00 00 00 00 00 05 01 00 01
00000033 ifdhandler.c:2006:IFDHICCPresence() Card present
00000007 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000007 -> 000000 65 00 00 00 00 00 06 00 00 00
00000838 <- 000000 81 00 00 00 00 00 06 01 00 01
00000025 ifdhandler.c:2006:IFDHICCPresence() Card present
00000006 ifdhandler.c:1184:IFDHPowerICC() action: PowerUp, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000007 -> 000000 62 00 00 00 00 00 07 00 00 00
00185720 <- 000000 80 13 00 00 00 00 07 00 00 00 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000040 eventhandler.c:406:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
00000005 eventhandler.c:423:EHStatusHandlerThread() Card inserted into Alcor Micro AU9540 00 00
00000008 Card ATR: 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000005 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 5000 ms
00000004 ccid_usb.c:1340:InterruptRead() before (0), timeout: 5000 ms
05000477 ccid_usb.c:1386:InterruptRead() after (0) (2)
00000033 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000010 -> 000000 65 00 00 00 00 00 08 00 00 00
00001058 <- 000000 81 00 00 00 00 00 08 00 00 00
00000019 ifdhandler.c:2006:IFDHICCPresence() Card present
00000006 ifdhandler.c:1184:IFDHPowerICC() action: PowerDown, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000007 -> 000000 63 00 00 00 00 00 09 00 00 00
00040893 <- 000000 81 00 00 00 00 00 09 01 00 01
00000027 eventhandler.c:482:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED
00000008 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000006 -> 000000 65 00 00 00 00 00 0A 00 00 00
00000787 <- 000000 81 00 00 00 00 00 0A 01 00 01
00000017 ifdhandler.c:2006:IFDHICCPresence() Card present
00000007 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 600000 ms
00000004 ccid_usb.c:1340:InterruptRead() before (0), timeout: 600000 ms
06035224 winscard_msg_srv.c:256:ProcessEventsServer() Common channel packet arrival
00000017 winscard_msg_srv.c:267:ProcessEventsServer() ProcessCommonChannelRequest detects: 12
00000002 pcscdaemon.c:133:SVCServiceRunLoop() A new context thread creation is requested: 12
00000148 winscard_svc.c:340:ContextThread() Authorized PC/SC client
00000005 winscard_svc.c:343:ContextThread() Thread is started: dwClientID=12, threadContext @0x55b5ffe9aba0
00000006 winscard_svc.c:361:ContextThread() Received command: CMD_VERSION from client 12
00000003 winscard_svc.c:373:ContextThread() Client is protocol version 4:4
00000001 winscard_svc.c:396:ContextThread() CMD_VERSION rv=0x0 for client 12
00000102 winscard_svc.c:361:ContextThread() Received command: ESTABLISH_CONTEXT from client 12
00000006 winscard.c:215:SCardEstablishContext() Establishing Context: 0x6CA9A43A
00000002 winscard_svc.c:461:ContextThread() ESTABLISH_CONTEXT rv=0x0 for client 12
00000098 winscard_svc.c:361:ContextThread() Received command: CMD_GET_READERS_STATE from client 12
00000101 winscard_svc.c:361:ContextThread() Received command: CMD_GET_READERS_STATE from client 12
00000113 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000020 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000103 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000005 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000024 winscard_svc.c:361:ContextThread() Received command: CONNECT from client 12
00000004 winscard_svc.c:499:ContextThread() Authorized client for 'Alcor Micro AU9540 00 00'
00000001 winscard.c:258:SCardConnect() Attempting Connect to Alcor Micro AU9540 00 00 using protocol: 3
00000002 readerfactory.c:825:RFReaderInfo() RefReader() count was: 1
00000003 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000004 -> 000000 65 00 00 00 00 00 0B 00 00 00
00000761 <- 000000 81 00 00 00 00 00 0B 01 00 01
00000006 ifdhandler.c:2006:IFDHICCPresence() Card present
00000003 ifdhandler.c:1184:IFDHPowerICC() action: PowerUp, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000003 -> 000000 62 00 00 00 00 00 0C 00 00 00
00185378 <- 000000 80 13 00 00 00 00 0C 00 00 00 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000033 winscard.c:332:SCardConnect() power up complete.
00000009 Card ATR: 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000003 winscard.c:352:SCardConnect() powerState: POWER_STATE_IN_USE
00000004 prothandler.c:107:PHSetProtocol() Attempting PTS to T=1
00000006 ifdhandler.c:715:IFDHSetProtocolParameters() protocol T=1, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000005 ifdhandler.c:2101:find_baud_rate() Card baud rate: 462500
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 1807
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 1989
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 2409
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 2487
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 3315
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 3613
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 3978
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 4818
00000006 ifdhandler.c:2110:find_baud_rate() Reader can do: 4973
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 6631
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 7227
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 7957
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 9635
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 9946
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 13262
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 14453
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 15914
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 19271
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 19892
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 21680
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 23871
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 26523
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 28906
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 29839
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 31828
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 36133
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 38542
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 39785
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 43359
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 48177
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 49731
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 53047
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 57813
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 59677
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 63656
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 66308
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 72266
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 77083
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 79570
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 86719
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 96354
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 99462
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 106093
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 115625
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 119355
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 132616
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 144531
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 154167
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 159140
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 198925
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 212186
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 231250
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 318280
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 2344
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 2581
00000006 ifdhandler.c:2110:find_baud_rate() Reader can do: 3125
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 3226
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 4301
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 4688
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 5161
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 5859
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 6250
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 6452
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 7813
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 8065
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 8602
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 9375
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 10323
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 10753
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 11719
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 12500
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 12903
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 15625
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 16129
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 17204
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 18750
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 20645
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 21505
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 23438
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 25000
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 25806
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 28125
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 30968
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 31250
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 32258
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 34409
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 37500
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 38710
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 41290
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 43011
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 46875
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 50000
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 51613
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 56250
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 62500
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 64516
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 68817
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 70313
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 75000
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 77419
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 82581
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 86022
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 93750
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 96774
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 100000
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 103226
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 112500
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 117188
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 125000
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 127312
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 129032
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 137634
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 150000
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 156250
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 161290
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 165161
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 172043
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 187500
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 200000
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 206452
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 215054
00000004 ifdhandler.c:2110:find_baud_rate() Reader can do: 250000
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 258065
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 275269
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 300000
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 308333
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 344086
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 375000
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 400000
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 412903
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 424373
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 462500
00000004 ifdhandler.c:847:IFDHSetProtocolParameters() Set speed to 462500 bauds
00000004 ifdhandler.c:1043:IFDHSetProtocolParameters() IFSC (TA3) present: 64
00000003 ifdhandler.c:1047:IFDHSetProtocolParameters() Timeout: 7162 ms
00000003 commands.c:2310:SetParameters() length: 7 bytes
00000009 -> 000000 61 07 00 00 00 00 0D 01 00 00 97 10 00 4D 00 40 00
00067568 <- 000000 82 07 00 00 00 00 0D 00 00 01 97 10 00 4D 00 40 00
00000032 winscard.c:430:SCardConnect() Active Protocol: T=1
00000007 winscard.c:456:SCardConnect() hCard Identity: 6d5cb7d5
00000006 winscard.c:518:SCardConnect() UnrefReader() count was: 2
00000008 winscard_svc.c:519:ContextThread() CONNECT rv=0x0 for client 12
00000251 winscard_svc.c:361:ContextThread() Received command: CONTROL from client 12
00000033 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000011 ifdhandler.c:1441:IFDHControl() ControlCode: 0x42000D48, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000004 Control TxBuffer:
00000007 Control RxBuffer: 12 04 42 33 00 12
00000005 winscard.c:1359:SCardControl() UnrefReader() count was: 2
00000005 winscard_svc.c:741:ContextThread() CONTROL rv=0x0 for client 12
00000187 winscard_svc.c:361:ContextThread() Received command: CONTROL from client 12
00000025 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000008 ifdhandler.c:1441:IFDHControl() ControlCode: 0x42330012, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000003 Control TxBuffer:
00000018 Control RxBuffer: 01 02 00 00 03 01 00 09 01 00 0B 02 8F 05 0C 02 40 95 0A 04 00 00 01 00
00000031 winscard.c:1359:SCardControl() UnrefReader() count was: 2
00000009 winscard_svc.c:741:ContextThread() CONTROL rv=0x0 for client 12
00000217 winscard_svc.c:361:ContextThread() Received command: CONTROL from client 12
00000033 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000011 ifdhandler.c:1441:IFDHControl() ControlCode: 0x42330012, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000004 Control TxBuffer:
00000019 Control RxBuffer: 01 02 00 00 03 01 00 09 01 00 0B 02 8F 05 0C 02 40 95 0A 04 00 00 01 00
00000008 winscard.c:1359:SCardControl() UnrefReader() count was: 2
00000007 winscard_svc.c:741:ContextThread() CONTROL rv=0x0 for client 12
00000173 winscard_svc.c:361:ContextThread() Received command: GET_ATTRIB from client 12
00000031 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000012 ifdhandler.c:388:IFDHGetCapabilities() tag: 0x10100, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000015 winscard.c:1434:SCardGetAttrib() UnrefReader() count was: 2
00000008 winscard_svc.c:770:ContextThread() GET_ATTRIB rv=0x0 for client 12
00000192 winscard_svc.c:361:ContextThread() Received command: GET_ATTRIB from client 12
00000032 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000010 ifdhandler.c:388:IFDHGetCapabilities() tag: 0x10102, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000007 winscard.c:1434:SCardGetAttrib() UnrefReader() count was: 2
00000006 winscard_svc.c:770:ContextThread() GET_ATTRIB rv=0x0 for client 12
00000218 winscard_svc.c:361:ContextThread() Received command: DISCONNECT from client 12
00000034 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000007 winscard.c:881:SCardDisconnect() Active Contexts: 1
00000006 winscard.c:882:SCardDisconnect() dwDisposition: 0
00000006 winscard.c:1017:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD
00000007 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFB2, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000004 winscard.c:1030:SCardDisconnect() Stopping polling thread
00000005 ifdhandler.c:353:IFDHStopPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000107 winscard.c:1043:SCardDisconnect() UnrefReader() count was: 2
00000015 winscard_svc.c:556:ContextThread() DISCONNECT rv=0x0 for client 12
00000025 ccid_usb.c:1386:InterruptRead() after (0) (3)
00000017 ccid_usb.c:1399:InterruptRead() InterruptRead (1/2): 3
00004371 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000020 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00001201 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000022 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000191 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000024 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000197 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000026 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000254 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000022 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00001189 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000024 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000196 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000022 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000201 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000023 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000089 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000016 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00001124 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000023 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000062 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000011 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000069 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000014 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000061 winscard_svc.c:361:ContextThread() Received command: CONNECT from client 12
00000017 winscard_svc.c:499:ContextThread() Authorized client for 'Alcor Micro AU9540 00 00'
00000006 winscard.c:258:SCardConnect() Attempting Connect to Alcor Micro AU9540 00 00 using protocol: 3
00000004 readerfactory.c:825:RFReaderInfo() RefReader() count was: 1
00000006 winscard.c:352:SCardConnect() powerState: POWER_STATE_IN_USE
00000004 winscard.c:430:SCardConnect() Active Protocol: T=1
00000007 winscard.c:456:SCardConnect() hCard Identity: 6ef8bea4
00000005 winscard.c:518:SCardConnect() UnrefReader() count was: 2
00000008 winscard_svc.c:519:ContextThread() CONNECT rv=0x0 for client 12
00000206 winscard_svc.c:361:ContextThread() Received command: BEGIN_TRANSACTION from client 12
00000028 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000009 winscard.c:1082:SCardBeginTransaction() Status: 0x00000000
00000005 winscard.c:1085:SCardBeginTransaction() UnrefReader() count was: 2
00000006 winscard_svc.c:571:ContextThread() BEGIN_TRANSACTION rv=0x0 for client 12
00000088 winscard_svc.c:361:ContextThread() Received command: TRANSMIT from client 12
00000023 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000006 winscard.c:1595:SCardTransmit() Send Protocol: T=1
00000009 APDU: 00 A4 00 00 02 3F 00 00
00000007 ifdhandler.c:1333:IFDHTransmitToICC() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000006 commands.c:1670:CmdXfrBlockAPDU_extended() T=0 (extended): 8 bytes
00000017 -> 000000 6F 08 00 00 00 00 0E 00 00 00 00 A4 00 00 02 3F 00 00
02734396 <- 000000 80 00 00 00 00 00 0E 41 FB 00
00000025 commands.c:1563:CCID_Receive Hardware error
00000013 SW:
00000003 ifdwrapper.c:543:IFDTransmit() Card not transacted: 612
00000003 winscard.c:1620:SCardTransmit() Card not transacted: 0x80100016
00000003 winscard.c:1648:SCardTransmit() UnrefReader() count was: 2
00000005 winscard_svc.c:691:ContextThread() TRANSMIT rv=0x80100016 for client 12
00000045 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000012 -> 000000 65 00 00 00 00 00 0F 00 00 00
00000037 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000012 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000754 <- 000000 81 00 00 00 00 00 0F 01 00 01
00000019 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000006 eventhandler.c:358:EHStatusHandlerThread() Card Removed From Alcor Micro AU9540 00 00
00000005 winscard_svc.c:828:MSGSignalClient() Signal client: 12
00000004 winscard_svc.c:831:MSGSignalClient() SIGNAL rv=0x0 for client 12
00000014 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 600000 ms
00000004 ccid_usb.c:1340:InterruptRead() before (0), timeout: 600000 ms
00000038 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000009 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000154 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000013 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000148 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 12
00000012 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 12
00000136 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 12
00000014 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 12
00000151 winscard_svc.c:361:ContextThread() Received command: END_TRANSACTION from client 12
00000018 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000004 winscard.c:1237:SCardEndTransaction() UnrefReader() count was: 2
00000004 winscard_svc.c:587:ContextThread() END_TRANSACTION rv=0x80100069 for client 12
00000175 winscard_svc.c:361:ContextThread() Received command: DISCONNECT from client 12
00000016 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000004 winscard.c:881:SCardDisconnect() Active Contexts: 1
00000004 winscard.c:882:SCardDisconnect() dwDisposition: 0
00000004 winscard.c:1017:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD
00000004 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFB2, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000003 winscard.c:1030:SCardDisconnect() Stopping polling thread
00000003 ifdhandler.c:353:IFDHStopPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000066 winscard.c:1043:SCardDisconnect() UnrefReader() count was: 2
00000010 winscard_svc.c:556:ContextThread() DISCONNECT rv=0x0 for client 12
00000001 ccid_usb.c:1386:InterruptRead() after (0) (3)
00000007 ccid_usb.c:1399:InterruptRead() InterruptRead (1/2): 3
00000042 winscard_svc.c:361:ContextThread() Received command: RELEASE_CONTEXT from client 12
00000012 winscard.c:229:SCardReleaseContext() Releasing Context: 0x6CA9A43A
00000003 winscard_svc.c:476:ContextThread() RELEASE_CONTEXT rv=0x0 for client 12
00000032 winscard_svc.c:354:ContextThread() Client die: 12
00000025 winscard_svc.c:1061:MSGCleanupClient() Thread is stopping: dwClientID=12, threadContext @0x55b5ffe9aba0
00000004 winscard_svc.c:1069:MSGCleanupClient() Freeing SCONTEXT @0x55b5ffe9aba0
00400417 eventhandler.c:494:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
00000031 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000009 -> 000000 65 00 00 00 00 00 10 00 00 00
00001154 <- 000000 81 00 00 00 00 00 10 01 00 01
00000029 ifdhandler.c:2006:IFDHICCPresence() Card present
00000007 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000008 -> 000000 65 00 00 00 00 00 11 00 00 00
00001988 <- 000000 81 00 00 00 00 00 11 01 00 01
00000028 ifdhandler.c:2006:IFDHICCPresence() Card present
00000007 ifdhandler.c:1184:IFDHPowerICC() action: PowerUp, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000008 -> 000000 62 00 00 00 00 00 12 00 00 00
00185249 <- 000000 80 13 00 00 00 00 12 00 00 00 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000031 eventhandler.c:406:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
00000004 eventhandler.c:423:EHStatusHandlerThread() Card inserted into Alcor Micro AU9540 00 00
00000008 Card ATR: 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000006 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 5000 ms
00000003 ccid_usb.c:1340:InterruptRead() before (0), timeout: 5000 ms
05000698 ccid_usb.c:1386:InterruptRead() after (0) (2)
00000032 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000010 -> 000000 65 00 00 00 00 00 13 00 00 00
00000957 <- 000000 81 00 00 00 00 00 13 00 00 00
00000020 ifdhandler.c:2006:IFDHICCPresence() Card present
00000008 ifdhandler.c:1184:IFDHPowerICC() action: PowerDown, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000010 -> 000000 63 00 00 00 00 00 14 00 00 00
00041105 <- 000000 81 00 00 00 00 00 14 01 00 01
00000030 eventhandler.c:482:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED
00000007 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000007 -> 000000 65 00 00 00 00 00 15 00 00 00
00000962 <- 000000 81 00 00 00 00 00 15 01 00 01
00000039 ifdhandler.c:2006:IFDHICCPresence() Card present
00000011 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 600000 ms
00000005 ccid_usb.c:1340:InterruptRead() before (0), timeout: 600000 ms
00000000 debuglog.c:299:DebugLogSetLevel() debug level=debug
00000077 configfile.l:293:DBGetReaderListDir() Parsing conf directory: /etc/reader.conf.d
00000008 configfile.l:329:DBGetReaderListDir() Skipping non regular file: .
00000002 configfile.l:369:DBGetReaderList() Parsing conf file: /etc/reader.conf.d/libccidtwin
00000024 configfile.l:329:DBGetReaderListDir() Skipping non regular file: ..
00000006 pcscdaemon.c:663:main() pcsc-lite 1.9.1 daemon ready.
00003855 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000087 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000089 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x058F, PID: 0x9540, path: /dev/bus/usb/001/002
00000005 hotplug_libudev.c:440:HPAddDevice() Adding USB device: Alcor Micro AU9540
00000029 readerfactory.c:1079:RFInitializeReader() Attempting startup of Alcor Micro AU9540 00 00 using /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so
00000155 readerfactory.c:954:RFBindFunctions() Loading IFD Handler 3.0
00000016 ifdhandler.c:2026:init_driver() Driver version: 1.4.34
00000560 ifdhandler.c:2043:init_driver() LogLevel: 0x000F
00000004 ifdhandler.c:2054:init_driver() DriverOptions: 0x0000
00000175 ifdhandler.c:110:CreateChannelByNameOrChannel() Lun: 0, device: usb:058f/9540:libudev:0:/dev/bus/usb/001/002
00000017 ccid_usb.c:237:OpenUSBByName() Reader index: 0, Device: usb:058f/9540:libudev:0:/dev/bus/usb/001/002
00000012 ccid_usb.c:269:OpenUSBByName() interface_number: 0
00000001 ccid_usb.c:270:OpenUSBByName() usb bus/device: 1/2
00000001 ccid_usb.c:302:OpenUSBByName() Using: /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist
00000507 ccid_usb.c:320:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau (ludovic.rousseau@free.fr)
00000004 ccid_usb.c:321:OpenUSBByName() ifdProductString: Generic CCID driver
00000001 ccid_usb.c:322: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.
00003423 ccid_usb.c:406:OpenUSBByName() Try device: 1/2
00000010 ccid_usb.c:416:OpenUSBByName() vid/pid : 058F/9540
00000002 ccid_usb.c:487:OpenUSBByName() Checking device: 1/2
00000001 ccid_usb.c:558:OpenUSBByName() Trying to open USB bus/device: 1/2
00115937 ccid_usb.c:664:OpenUSBByName() Found Vendor/Product: 058F/9540 (Alcor Micro AU9540)
00000027 ccid_usb.c:666:OpenUSBByName() Using USB bus/device: 1/2
00000006 ccid_usb.c:1287:ControlUSB() request: 0x03
00009310 receive: 0F 07 00 00 C5 07 00 00 69 09 00 00 B7 09 00 00 F3 0C 00 00 1D 0E 00 00 8A 0F 00 00 D2 12 00 00 6D 13 00 00 E7 19 00 00 3B 1C 00 00 15 1F 00 00 A3 25 00 00 DA 26 00 00 CE 33 00 00 75 38 00 00 2A 3E 00 00 47 4B 00 00 B4 4D 00 00 B0 54 00 00 3F 5D 00 00 9B 67 00 00 EA 70 00 00 8F 74 00 00 54 7C 00 00 25 8D 00 00 8E 96 00 00 69 9B 00 00 5F A9 00 00 31 BC 00 00 43 C2 00 00 37 CF 00 00 D5 E1 00 00 1D E9 00 00 A8 F8 00 00 04 03 01 00 4A 1A 01 00 1B 2D 01 00 D2 36 01 00 BF 52 01 00 62 78 01 00 86 84 01 00 6D 9E 01 00 A9 C3 01 00 3B D2 01 00 08 06 02 00 93 34 02 00 37 5A 02 00 A4 6D 02 00 0D 09 03 00 DA 3C 03 00 52 87 03 00 48 DB 04 00 28 09 00 00 15 0A 00 00 35 0C 00 00 9A 0C 00 00 CD 10 00 00 50 12 00 00 29 14 00 00 E3 16 00 00 6A 18 00 00 34 19 00 00 85 1E 00 00 81 1F 00 00 9A 21 00 00 9F 24 00 00 53 28 00 00 01 2A 00 00 C7 2D 00 00 D4 30 00 00 67 32 00 00 09 3D 00 00 01 3F 00 00 34 43 00 00 3E 49 00 00 A5 50 00 00 01 54 00 00 8E 5B 00 00 A8 61 00 00 CE 64 00 00 DD 6D 00 00 F8 78 00 00 12 7A 00 00 02 7E 00 00 69 86 00 00 7C 92 00 00 36 97 00 00 4A A1 00 00 03 A8 00 00 1B B7 00 00 50 C3 00 00 9D C9 00 00 BA DB 00 00 24 F4 00 00 04 FC 00 00 D1 0C 01 00 A9 12 01 00 F8 24 01 00 6B 2E 01 00 95 42 01 00 06 50 01 00 36 6E 01 00 06 7A 01 00 A0 86 01 00 3A 93 01 00 74 B7 01 00 C4 C9 01 00 48 E8 01 00 50 F1 01 00 08 F8 01 00 A2 19 02 00 F0 49 02 00 5A 62 02 00 0A 76 02 00 29 85 02 00 0B A0 02 00 6C DC 02 00 40 0D 03 00 74 26 03 00 0E 48 03 00 90 D0 03 00 11 F0 03 00 45 33 04 00 E0 93 04 00 6D B4 04 00 16 40 05 00 D8 B8 05 00 80 1A 06 00 E7 4C 06 00 B5 79 06 00 A4 0E 07 00 20 A1 07 00 21 E0 07 00 8A 66 08 00 C0 27 09 00 8F B6 09 00 2C 80 0A 00
00000014 ccid_usb.c:1267:get_data_rates() declared: 1807 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 1989 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 2409 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 2487 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 3315 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 3613 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 3978 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 4818 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 4973 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 6631 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 7227 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 7957 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 9635 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 9946 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 13262 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 14453 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 15914 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 19271 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 19892 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 21680 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 23871 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 26523 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 28906 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 29839 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 31828 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 36133 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 38542 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 39785 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 43359 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 48177 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 49731 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 53047 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 57813 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 59677 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 63656 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 66308 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 72266 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 77083 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 79570 bps
00000004 ccid_usb.c:1267:get_data_rates() declared: 86719 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 96354 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 99462 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 106093 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 115625 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 119355 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 132616 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 144531 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 154167 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 159140 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 198925 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 212186 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 231250 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 318280 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 2344 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 2581 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 3125 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 3226 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 4301 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 4688 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 5161 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 5859 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 6250 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 6452 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 7813 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 8065 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 8602 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 9375 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 10323 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 10753 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 11719 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 12500 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 12903 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 15625 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 16129 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 17204 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 18750 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 20645 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 21505 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 23438 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 25000 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 25806 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 28125 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 30968 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 31250 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 32258 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 34409 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 37500 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 38710 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 41290 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 43011 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 46875 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 50000 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 51613 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 56250 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 62500 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 64516 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 68817 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 70313 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 75000 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 77419 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 82581 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 86022 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 93750 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 96774 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 100000 bps
00000004 ccid_usb.c:1267:get_data_rates() declared: 103226 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 112500 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 117188 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 125000 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 127312 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 129032 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 137634 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 150000 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 156250 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 161290 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 165161 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 172043 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 187500 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 200000 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 206452 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 215054 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 250000 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 258065 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 275269 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 300000 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 308333 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 344086 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 375000 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 400000 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 412903 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 424373 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 462500 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 500000 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 516129 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 550538 bps
00000000 ccid_usb.c:1267:get_data_rates() declared: 600000 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 636559 bps
00000001 ccid_usb.c:1267:get_data_rates() declared: 688172 bps
00001131 ccid_usb.c:1340:InterruptRead() before (0), timeout: 100 ms
00000924 ccid_usb.c:1386:InterruptRead() after (0) (0)
00000008 NotifySlotChange: 50 02
00000006 -> 000000 65 00 00 00 00 00 00 00 00 00
00000707 <- 000000 81 00 00 00 00 00 00 42 FE 01
00000009 -> 000000 65 00 00 00 00 00 01 00 00 00
00000720 <- 000000 81 00 00 00 00 00 01 42 FE 01
00000010 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFB3, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000002 readerfactory.c:400:RFAddReader() Using the reader polling thread
00000003 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000004 -> 000000 65 00 00 00 00 00 02 00 00 00
00000762 <- 000000 81 00 00 00 00 00 02 42 FE 01
00000008 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000065 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFAE, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000006 ifdhandler.c:484:IFDHGetCapabilities() Reader supports 1 slot(s)
00000044 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000006 -> 000000 65 00 00 00 00 00 03 00 00 00
00000267 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000147 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x8087, PID: 0x0026, path: /dev/bus/usb/001/005
00000125 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x8087, PID: 0x0026, path: /dev/bus/usb/001/005
00000115 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000121 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x0A89, PID: 0x0069, path: /dev/bus/usb/001/008
00000006 hotplug_libudev.c:440:HPAddDevice() Adding USB device: Aktiv Rutoken SCR 3001 Reader
00000105 <- 000000 81 00 00 00 00 00 03 42 FE 01
00000008 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000006 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000002 -> 000000 65 00 00 00 00 00 04 00 00 00
00000754 <- 000000 81 00 00 00 00 00 04 42 FE 01
00000009 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000006 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 600000 ms
00000003 ccid_usb.c:1340:InterruptRead() before (0), timeout: 600000 ms
00000034 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFAF, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000009 readerfactory.c:730:RFSetReaderName() Support 16 simultaneous readers
00000007 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFAD, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000003 readerfactory.c:338:RFAddReader() Driver is thread safe
00000002 readerfactory.c:1079:RFInitializeReader() Attempting startup of Aktiv Rutoken SCR 3001 Reader 01 00 using /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so
00000002 readerfactory.c:867:RFLoadReader() Reusing already loaded driver for /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so
00000009 readerfactory.c:954:RFBindFunctions() Loading IFD Handler 3.0
00000013 ifdhandler.c:110:CreateChannelByNameOrChannel() Lun: 10000, device: usb:0a89/0069:libudev:0:/dev/bus/usb/001/008
00000003 ccid_usb.c:237:OpenUSBByName() Reader index: 1, Device: usb:0a89/0069:libudev:0:/dev/bus/usb/001/008
00000005 ccid_usb.c:269:OpenUSBByName() interface_number: 0
00000001 ccid_usb.c:270:OpenUSBByName() usb bus/device: 1/8
00000002 ccid_usb.c:302:OpenUSBByName() Using: /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist
00000703 ccid_usb.c:320:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau (ludovic.rousseau@free.fr)
00000007 ccid_usb.c:321:OpenUSBByName() ifdProductString: Generic CCID driver
00000003 ccid_usb.c:322: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.
00000038 ccid_usb.c:406:OpenUSBByName() Try device: 1/8
00000005 ccid_usb.c:416:OpenUSBByName() vid/pid : 0A89/0069
00000002 ccid_usb.c:487:OpenUSBByName() Checking device: 1/8
00000001 ccid_usb.c:558:OpenUSBByName() Trying to open USB bus/device: 1/8
00115817 ccid_usb.c:664:OpenUSBByName() Found Vendor/Product: 0A89/0069 (Aktiv Rutoken SCR 3001 Reader)
00000020 ccid_usb.c:666:OpenUSBByName() Using USB bus/device: 1/8
00000005 ccid_usb.c:1287:ControlUSB() request: 0x03
00000295 receive: 80 25 00 00 4B 4C 00 00 01 69 00 00 96 98 00 00 03 D2 00 00 2D 31 01 00 5A 62 02 00 0A 76 02 00 B4 C4 04 00 68 89 09 00
00000028 ccid_usb.c:1267:get_data_rates() declared: 9600 bps
00000006 ccid_usb.c:1267:get_data_rates() declared: 19531 bps
00000004 ccid_usb.c:1267:get_data_rates() declared: 26881 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 39062 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 53763 bps
00000003 ccid_usb.c:1267:get_data_rates() declared: 78125 bps
00000004 ccid_usb.c:1267:get_data_rates() declared: 156250 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 161290 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 312500 bps
00000002 ccid_usb.c:1267:get_data_rates() declared: 625000 bps
00001149 ccid_usb.c:1340:InterruptRead() before (1), timeout: 100 ms
00001114 ccid_usb.c:1386:InterruptRead() after (1) (0)
00000027 NotifySlotChange: 50 02
00000009 -> 000001 65 00 00 00 00 00 00 00 00 00
00000458 <- 000001 81 00 00 00 00 00 00 02 00 01
00000055 -> 000001 65 00 00 00 00 00 01 00 00 00
00000468 <- 000001 81 00 00 00 00 00 01 02 00 01
00000027 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFB3, usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000005 readerfactory.c:400:RFAddReader() Using the reader polling thread
00000004 ifdhandler.c:1886:IFDHICCPresence() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000007 -> 000001 65 00 00 00 00 00 02 00 00 00
00000494 <- 000001 81 00 00 00 00 00 02 02 00 01
00000021 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000121 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFAE, usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000012 ifdhandler.c:484:IFDHGetCapabilities() Reader supports 1 slot(s)
00000075 ifdhandler.c:1886:IFDHICCPresence() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000026 -> 000001 65 00 00 00 00 00 03 00 00 00
00000411 <- 000001 81 00 00 00 00 00 03 02 00 01
00000020 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000007 ifdhandler.c:1886:IFDHICCPresence() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000007 -> 000001 65 00 00 00 00 00 04 00 00 00
00000002 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000290 <- 000001 81 00 00 00 00 00 04 02 00 01
00000022 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000008 ifdhandler.c:317:IFDHPolling() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000) 600000 ms
00000001 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x05AC, PID: 0x1402, path: /dev/bus/usb/001/006
00000005 ccid_usb.c:1340:InterruptRead() before (1), timeout: 600000 ms
00000289 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000306 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000304 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000300 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000299 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000299 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x04F2, PID: 0xB6D0, path: /dev/bus/usb/001/003
00000319 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
00000307 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x06CB, PID: 0x00BD, path: /dev/bus/usb/001/004
00000478 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0003, path: /dev/bus/usb/002/001
00000719 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/003/001
00000694 hotplug_libudev.c:299:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0003, path: /dev/bus/usb/004/001
07321393 ccid_usb.c:1386:InterruptRead() after (1) (0)
00000030 NotifySlotChange: 50 03
00000009 ifdhandler.c:1886:IFDHICCPresence() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000007 -> 000001 65 00 00 00 00 00 05 00 00 00
00000533 <- 000001 81 00 00 00 00 00 05 01 00 01
00000026 ifdhandler.c:2006:IFDHICCPresence() Card present
00000006 ifdhandler.c:1886:IFDHICCPresence() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000007 -> 000001 65 00 00 00 00 00 06 00 00 00
00000381 <- 000001 81 00 00 00 00 00 06 01 00 01
00000022 ifdhandler.c:2006:IFDHICCPresence() Card present
00000007 ifdhandler.c:1184:IFDHPowerICC() action: PowerUp, usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000007 -> 000001 62 00 00 00 00 00 07 00 00 00
00051510 <- 000001 80 13 00 00 00 00 07 00 00 00 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000033 eventhandler.c:406:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
00000004 eventhandler.c:423:EHStatusHandlerThread() Card inserted into Aktiv Rutoken SCR 3001 Reader 01 00
00000007 Card ATR: 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000004 ifdhandler.c:317:IFDHPolling() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000) 5000 ms
00000004 ccid_usb.c:1340:InterruptRead() before (1), timeout: 5000 ms
05000710 ccid_usb.c:1386:InterruptRead() after (1) (2)
00000034 ifdhandler.c:1886:IFDHICCPresence() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000009 -> 000001 65 00 00 00 00 00 08 00 00 00
00000399 <- 000001 81 00 00 00 00 00 08 00 00 00
00000014 ifdhandler.c:2006:IFDHICCPresence() Card present
00000007 ifdhandler.c:1184:IFDHPowerICC() action: PowerDown, usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000007 -> 000001 63 00 00 00 00 00 09 00 00 00
00008125 <- 000001 81 00 00 00 00 00 09 00 00 01
00000034 eventhandler.c:482:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED
00000010 ifdhandler.c:1886:IFDHICCPresence() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000012 -> 000001 65 00 00 00 00 00 0A 00 00 00
00000386 <- 000001 81 00 00 00 00 00 0A 01 00 01
00000022 ifdhandler.c:2006:IFDHICCPresence() Card present
00000007 ifdhandler.c:317:IFDHPolling() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000) 600000 ms
00000004 ccid_usb.c:1340:InterruptRead() before (1), timeout: 600000 ms
24144983 winscard_msg_srv.c:256:ProcessEventsServer() Common channel packet arrival
00000017 winscard_msg_srv.c:267:ProcessEventsServer() ProcessCommonChannelRequest detects: 13
00000002 pcscdaemon.c:133:SVCServiceRunLoop() A new context thread creation is requested: 13
00000127 winscard_svc.c:340:ContextThread() Authorized PC/SC client
00000004 winscard_svc.c:343:ContextThread() Thread is started: dwClientID=13, threadContext @0x5604acc05f50
00000021 winscard_svc.c:361:ContextThread() Received command: CMD_VERSION from client 13
00000003 winscard_svc.c:373:ContextThread() Client is protocol version 4:4
00000002 winscard_svc.c:396:ContextThread() CMD_VERSION rv=0x0 for client 13
00000103 winscard_svc.c:361:ContextThread() Received command: ESTABLISH_CONTEXT from client 13
00000006 winscard.c:215:SCardEstablishContext() Establishing Context: 0x789F0975
00000002 winscard_svc.c:461:ContextThread() ESTABLISH_CONTEXT rv=0x0 for client 13
00000092 winscard_svc.c:361:ContextThread() Received command: CMD_GET_READERS_STATE from client 13
00000106 winscard_svc.c:361:ContextThread() Received command: CMD_GET_READERS_STATE from client 13
00000092 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 13
00000015 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 13
00000074 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 13
00000003 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 13
00000016 winscard_svc.c:361:ContextThread() Received command: CONNECT from client 13
00000003 winscard_svc.c:499:ContextThread() Authorized client for 'Alcor Micro AU9540 00 00'
00000001 winscard.c:258:SCardConnect() Attempting Connect to Alcor Micro AU9540 00 00 using protocol: 3
00000001 readerfactory.c:825:RFReaderInfo() RefReader() count was: 1
00000002 winscard.c:444:SCardConnect() Direct access: no protocol selected
00000002 winscard.c:456:SCardConnect() hCard Identity: 268a69ed
00000001 winscard.c:518:SCardConnect() UnrefReader() count was: 2
00000002 winscard_svc.c:519:ContextThread() CONNECT rv=0x0 for client 13
00000015 winscard_svc.c:361:ContextThread() Received command: CONTROL from client 13
00000004 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000003 ifdhandler.c:1441:IFDHControl() ControlCode: 0x42000D48, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000001 Control TxBuffer:
00000003 Control RxBuffer: 12 04 42 33 00 12
00000001 winscard.c:1359:SCardControl() UnrefReader() count was: 2
00000001 winscard_svc.c:741:ContextThread() CONTROL rv=0x0 for client 13
00000015 winscard_svc.c:361:ContextThread() Received command: CONTROL from client 13
00000003 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000002 ifdhandler.c:1441:IFDHControl() ControlCode: 0x42330012, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000000 Control TxBuffer:
00000004 Control RxBuffer: 01 02 00 00 03 01 00 09 01 00 0B 02 8F 05 0C 02 40 95 0A 04 00 00 01 00
00000001 winscard.c:1359:SCardControl() UnrefReader() count was: 2
00000001 winscard_svc.c:741:ContextThread() CONTROL rv=0x0 for client 13
00000015 winscard_svc.c:361:ContextThread() Received command: CONTROL from client 13
00000003 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000001 ifdhandler.c:1441:IFDHControl() ControlCode: 0x42330012, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000000 Control TxBuffer:
00000004 Control RxBuffer: 01 02 00 00 03 01 00 09 01 00 0B 02 8F 05 0C 02 40 95 0A 04 00 00 01 00
00000001 winscard.c:1359:SCardControl() UnrefReader() count was: 2
00000000 winscard_svc.c:741:ContextThread() CONTROL rv=0x0 for client 13
00000016 winscard_svc.c:361:ContextThread() Received command: GET_ATTRIB from client 13
00000003 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000002 ifdhandler.c:388:IFDHGetCapabilities() tag: 0x10100, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000005 winscard.c:1434:SCardGetAttrib() UnrefReader() count was: 2
00000001 winscard_svc.c:770:ContextThread() GET_ATTRIB rv=0x0 for client 13
00000015 winscard_svc.c:361:ContextThread() Received command: GET_ATTRIB from client 13
00000002 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000002 ifdhandler.c:388:IFDHGetCapabilities() tag: 0x10102, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000002 winscard.c:1434:SCardGetAttrib() UnrefReader() count was: 2
00000001 winscard_svc.c:770:ContextThread() GET_ATTRIB rv=0x0 for client 13
00000014 winscard_svc.c:361:ContextThread() Received command: DISCONNECT from client 13
00000003 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000001 winscard.c:881:SCardDisconnect() Active Contexts: 1
00000001 winscard.c:882:SCardDisconnect() dwDisposition: 0
00000001 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFB2, usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000001 winscard.c:1030:SCardDisconnect() Stopping polling thread
00000001 ifdhandler.c:353:IFDHStopPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000078 winscard.c:1043:SCardDisconnect() UnrefReader() count was: 2
00000002 winscard_svc.c:556:ContextThread() DISCONNECT rv=0x0 for client 13
00000020 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 13
00000002 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 13
00000001 ccid_usb.c:1386:InterruptRead() after (0) (3)
00000004 ccid_usb.c:1399:InterruptRead() InterruptRead (1/2): 3
00000013 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 13
00000001 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 13
00000016 winscard_svc.c:361:ContextThread() Received command: CONNECT from client 13
00000003 winscard_svc.c:499:ContextThread() Authorized client for 'Aktiv Rutoken SCR 3001 Reader 01 00'
00000001 winscard.c:258:SCardConnect() Attempting Connect to Aktiv Rutoken SCR 3001 Reader 01 00 using protocol: 3
00000001 readerfactory.c:825:RFReaderInfo() RefReader() count was: 1
00000002 ifdhandler.c:1886:IFDHICCPresence() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000003 -> 000001 65 00 00 00 00 00 0B 00 00 00
00000161 <- 000001 81 00 00 00 00 00 0B 01 00 01
00000001 ifdhandler.c:2006:IFDHICCPresence() Card present
00000002 ifdhandler.c:1184:IFDHPowerICC() action: PowerUp, usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000002 -> 000001 62 00 00 00 00 00 0C 00 00 00
00053396 <- 000001 80 13 00 00 00 00 0C 00 00 00 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000031 winscard.c:332:SCardConnect() power up complete.
00000009 Card ATR: 3B 9C 97 80 11 40 52 75 74 6F 6B 65 6E 45 43 50 73 63 C0
00000003 winscard.c:352:SCardConnect() powerState: POWER_STATE_IN_USE
00000004 prothandler.c:107:PHSetProtocol() Attempting PTS to T=1
00000007 ifdhandler.c:715:IFDHSetProtocolParameters() protocol T=1, usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000004 ifdhandler.c:2101:find_baud_rate() Card baud rate: 447500
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 9600
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 19531
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 26881
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 39062
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 53763
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 78125
00000003 ifdhandler.c:2110:find_baud_rate() Reader can do: 156250
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 161290
00000002 ifdhandler.c:2110:find_baud_rate() Reader can do: 312500
00000006 ifdhandler.c:2110:find_baud_rate() Reader can do: 625000
00000004 ifdhandler.c:851:IFDHSetProtocolParameters() Reader does not support 447500 bauds
00000003 ifdhandler.c:1043:IFDHSetProtocolParameters() IFSC (TA3) present: 64
00000003 ifdhandler.c:1047:IFDHSetProtocolParameters() Timeout: 7368 ms
00000004 commands.c:2310:SetParameters() length: 7 bytes
00000009 -> 000001 61 07 00 00 00 00 0D 01 00 00 11 10 00 4D 00 40 00
00018965 <- 000001 82 07 00 00 00 00 0D 00 00 01 11 10 00 4D 00 40 00
00000014 winscard.c:430:SCardConnect() Active Protocol: T=1
00000004 winscard.c:456:SCardConnect() hCard Identity: 317c281d
00000002 winscard.c:518:SCardConnect() UnrefReader() count was: 2
00000004 winscard_svc.c:519:ContextThread() CONNECT rv=0x0 for client 13
00000095 winscard_svc.c:361:ContextThread() Received command: CONTROL from client 13
00000014 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000003 ifdhandler.c:1441:IFDHControl() ControlCode: 0x42000D48, usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000001 Control TxBuffer:
00000003 Control RxBuffer: 12 04 42 33 00 12
00000001 winscard.c:1359:SCardControl() UnrefReader() count was: 2
00000002 winscard_svc.c:741:ContextThread() CONTROL rv=0x0 for client 13
00000091 winscard_svc.c:361:ContextThread() Received command: CONTROL from client 13
00000011 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000003 ifdhandler.c:1441:IFDHControl() ControlCode: 0x42330012, usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000001 Control TxBuffer:
00000004 Control RxBuffer: 01 02 00 00 03 01 00 09 01 00 0B 02 89 0A 0C 02 69 00 0A 04 00 00 00 00
00000001 winscard.c:1359:SCardControl() UnrefReader() count was: 2
00000002 winscard_svc.c:741:ContextThread() CONTROL rv=0x0 for client 13
00000107 winscard_svc.c:361:ContextThread() Received command: CONTROL from client 13
00000011 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000003 ifdhandler.c:1441:IFDHControl() ControlCode: 0x42330012, usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000001 Control TxBuffer:
00000005 Control RxBuffer: 01 02 00 00 03 01 00 09 01 00 0B 02 89 0A 0C 02 69 00 0A 04 00 00 00 00
00000001 winscard.c:1359:SCardControl() UnrefReader() count was: 2
00000002 winscard_svc.c:741:ContextThread() CONTROL rv=0x0 for client 13
00000099 winscard_svc.c:361:ContextThread() Received command: GET_ATTRIB from client 13
00000013 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000003 ifdhandler.c:388:IFDHGetCapabilities() tag: 0x10100, usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000002 winscard.c:1434:SCardGetAttrib() UnrefReader() count was: 2
00000002 winscard_svc.c:770:ContextThread() GET_ATTRIB rv=0x0 for client 13
00000108 winscard_svc.c:361:ContextThread() Received command: GET_ATTRIB from client 13
00000028 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000003 ifdhandler.c:388:IFDHGetCapabilities() tag: 0x10102, usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000001 winscard.c:1434:SCardGetAttrib() UnrefReader() count was: 2
00000002 winscard_svc.c:770:ContextThread() GET_ATTRIB rv=0x0 for client 13
00000035 winscard_svc.c:361:ContextThread() Received command: DISCONNECT from client 13
00000004 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000002 winscard.c:881:SCardDisconnect() Active Contexts: 1
00000001 winscard.c:882:SCardDisconnect() dwDisposition: 0
00000002 winscard.c:1017:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD
00000002 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFB2, usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000001 winscard.c:1030:SCardDisconnect() Stopping polling thread
00000001 ifdhandler.c:353:IFDHStopPolling() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000043 winscard.c:1043:SCardDisconnect() UnrefReader() count was: 2
00000003 ccid_usb.c:1386:InterruptRead() after (1) (3)
00000008 winscard_svc.c:556:ContextThread() DISCONNECT rv=0x0 for client 13
00000009 ccid_usb.c:1399:InterruptRead() InterruptRead (1/8): 3
00001684 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 13
00000009 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 13
00001039 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 13
00000007 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 13
00000069 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 13
00000003 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 13
00000028 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 13
00000006 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 13
00000026 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 13
00000002 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 13
00001026 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 13
00000005 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 13
00000019 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 13
00000002 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 13
00000021 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 13
00000002 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 13
00000037 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 13
00000002 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 13
00001022 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 13
00000005 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 13
00000018 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 13
00000004 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 13
00000021 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 13
00000004 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 13
00000025 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 13
00000003 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 13
00001023 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 13
00000004 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 13
00000018 winscard_svc.c:361:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 13
00000004 winscard_svc.c:840:MSGSendReaderStates() Send reader states: 13
00000022 winscard_svc.c:361:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 13
00000003 winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 13
00000021 winscard_svc.c:361:ContextThread() Received command: CONNECT from client 13
00000005 winscard_svc.c:499:ContextThread() Authorized client for 'Aktiv Rutoken SCR 3001 Reader 01 00'
00000002 winscard.c:258:SCardConnect() Attempting Connect to Aktiv Rutoken SCR 3001 Reader 01 00 using protocol: 3
00000002 readerfactory.c:825:RFReaderInfo() RefReader() count was: 1
00000001 winscard.c:352:SCardConnect() powerState: POWER_STATE_IN_USE
00000002 winscard.c:430:SCardConnect() Active Protocol: T=1
00000003 winscard.c:456:SCardConnect() hCard Identity: 51d6dc47
00000002 winscard.c:518:SCardConnect() UnrefReader() count was: 2
00000002 winscard_svc.c:519:ContextThread() CONNECT rv=0x0 for client 13
00000092 winscard_svc.c:361:ContextThread() Received command: BEGIN_TRANSACTION from client 13
00000006 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000002 winscard.c:1082:SCardBeginTransaction() Status: 0x00000000
00000001 winscard.c:1085:SCardBeginTransaction() UnrefReader() count was: 2
00000001 winscard_svc.c:571:ContextThread() BEGIN_TRANSACTION rv=0x0 for client 13
00000032 winscard_svc.c:361:ContextThread() Received command: TRANSMIT from client 13
00000007 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000002 winscard.c:1595:SCardTransmit() Send Protocol: T=1
00000003 APDU: 00 A4 00 00 02 3F 00 00
00000003 ifdhandler.c:1333:IFDHTransmitToICC() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000001 commands.c:1802:CmdXfrBlockTPDU_T0() T=0: 8 bytes
00000005 -> 000001 6F 08 00 00 00 00 0E 00 00 00 00 A4 00 00 02 3F 00 00
00079990 <- 000001 80 28 00 00 00 00 0E 00 00 00 6F 24 80 02 00 00 81 02 00 40 82 02 38 00 83 02 3F 00 8A 01 05 86 0F 47 02 02 01 00 00 00 FF 00 00 00 00 00 00 00 90 00
00000043 SW: 6F 24 80 02 00 00 81 02 00 40 82 02 38 00 83 02 3F 00 8A 01 05 86 0F 47 02 02 01 00 00 00 FF 00 00 00 00 00 00 00 90 00
00000007 winscard.c:1648:SCardTransmit() UnrefReader() count was: 2
00000005 winscard_svc.c:691:ContextThread() TRANSMIT rv=0x0 for client 13
00000288 winscard_svc.c:361:ContextThread() Received command: END_TRANSACTION from client 13
00000028 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000007 winscard.c:1234:SCardEndTransaction() Status: 0x00000000
00000004 winscard.c:1237:SCardEndTransaction() UnrefReader() count was: 2
00000004 winscard_svc.c:587:ContextThread() END_TRANSACTION rv=0x0 for client 13
00000193 winscard_svc.c:361:ContextThread() Received command: BEGIN_TRANSACTION from client 13
00000027 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000007 winscard.c:1082:SCardBeginTransaction() Status: 0x00000000
00000003 winscard.c:1085:SCardBeginTransaction() UnrefReader() count was: 2
00000004 winscard_svc.c:571:ContextThread() BEGIN_TRANSACTION rv=0x0 for client 13
00000199 winscard_svc.c:361:ContextThread() Received command: END_TRANSACTION from client 13
00000026 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000005 winscard.c:1234:SCardEndTransaction() Status: 0x00000000
00000004 winscard.c:1237:SCardEndTransaction() UnrefReader() count was: 2
00000004 winscard_svc.c:587:ContextThread() END_TRANSACTION rv=0x0 for client 13
00239758 ifdhandler.c:1886:IFDHICCPresence() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0)
00000033 -> 000000 65 00 00 00 00 00 05 00 00 00
00001872 <- 000000 81 00 00 00 00 00 05 42 FE 01
00000025 ifdhandler.c:2006:IFDHICCPresence() Card absent
00000009 ifdhandler.c:317:IFDHPolling() usb:058f/9540:libudev:0:/dev/bus/usb/001/002 (lun: 0) 600000 ms
00000004 ccid_usb.c:1340:InterruptRead() before (0), timeout: 600000 ms
00071640 ifdhandler.c:1886:IFDHICCPresence() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000033 -> 000001 65 00 00 00 00 00 0F 00 00 00
00000496 <- 000001 81 00 00 00 00 00 0F 00 00 00
00000023 ifdhandler.c:2006:IFDHICCPresence() Card present
00000008 ifdhandler.c:317:IFDHPolling() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000) 600000 ms
00000004 ccid_usb.c:1340:InterruptRead() before (1), timeout: 600000 ms
03372274 winscard_svc.c:354:ContextThread() Client die: 13
00000054 winscard.c:229:SCardReleaseContext() Releasing Context: 0x789F0975
00000009 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
00000003 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 2
00000004 winscard.c:881:SCardDisconnect() Active Contexts: 1
00000003 winscard.c:882:SCardDisconnect() dwDisposition: 0
00000005 winscard.c:1017:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD
00000006 ifdhandler.c:388:IFDHGetCapabilities() tag: 0xFB2, usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000005 winscard.c:1030:SCardDisconnect() Stopping polling thread
00000003 ifdhandler.c:353:IFDHStopPolling() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000117 winscard.c:1043:SCardDisconnect() UnrefReader() count was: 3
00000017 winscard_svc.c:937:MSGRemoveContext() UnrefReader() count was: 2
00000009 winscard_svc.c:1061:MSGCleanupClient() Thread is stopping: dwClientID=13, threadContext @0x5604acc05f50
00000005 winscard_svc.c:1069:MSGCleanupClient() Freeing SCONTEXT @0x5604acc05f50
00000004 ccid_usb.c:1386:InterruptRead() after (1) (3)
00000011 ccid_usb.c:1399:InterruptRead() InterruptRead (1/8): 3
00400513 eventhandler.c:494:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
00000032 ifdhandler.c:1886:IFDHICCPresence() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000)
00000010 -> 000001 65 00 00 00 00 00 10 00 00 00
00000526 <- 000001 81 00 00 00 00 00 10 00 00 00
00000023 ifdhandler.c:2006:IFDHICCPresence() Card present
00000008 ifdhandler.c:317:IFDHPolling() usb:0a89/0069:libudev:0:/dev/bus/usb/001/008 (lun: 10000) 5000 ms
00000004 ccid_usb.c:1340:InterruptRead() before (1), timeout: 5000 ms
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment