Hello Ludovic, For some reason, the message below never was delivered to the bug. Resending.
---------- Forwarded message ---------- From: Martin-Éric Racine <martin-eric.rac...@iki.fi> Date: 2014-05-24 17:23 GMT+03:00 Subject: Re: Bug#748754: pcscd: card reader no longer recognized To: 748...@bugs.debian.org 2014-05-24 16:37 GMT+03:00 Ludovic Rousseau <ludovic.rouss...@gmail.com>: > Le 20/05/2014 20:35, Martin-Éric Racine a écrit : >> >> >> 2014-05-20 20:08 GMT+03:00 Ludovic Rousseau <ludovic.rouss...@gmail.com>: >>> >>> Please follow http://pcsclite.alioth.debian.org/ccid.html#support to >>> provide >>> more detailed information. >> >> >> On Debian/testing, accessing a FinEID card using the D430's internal Oz776 >> card reader: > > > Thanks for the details. > > I can't find any problem in the log you sent. I ran the same logging sequence, this time trying to access the card with 1) opensc-explorer 2) opensc-tools and 3) the OpenSC pluging via Iceweasel. Attached. Martin-Éric
00000000 debuglog.c:295:DebugLogSetLevel() debug level=debug 00000050 debuglog.c:324:DebugLogSetCategory() Debug options: APDU 00000064 utils.c:87:GetDaemonPid() Can't open /var/run/pcscd/pcscd.pid: No such file or directory 00000177 configfile.l:286:DBGetReaderListDir() Parsing conf directory: /etc/reader.conf.d 00000034 configfile.l:298:DBGetReaderListDir() Skipping non regular file: . 00000009 configfile.l:339:DBGetReaderList() Parsing conf file: /etc/reader.conf.d/libccidtwin 00000073 configfile.l:298:DBGetReaderListDir() Skipping non regular file: .. 00000013 pcscdaemon.c:571:main() pcsc-lite 1.8.11 daemon ready. 00004795 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0001, path: /dev/bus/usb/002/001 00000173 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0001, path: /dev/bus/usb/003/001 00000165 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0001, path: /dev/bus/usb/004/001 00000164 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0001, path: /dev/bus/usb/005/001 00000164 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001 00000125 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001 00000129 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA005, path: /dev/bus/usb/001/002 00000140 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x0B97, PID: 0x7761, path: /dev/bus/usb/001/004 00000143 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x0B97, PID: 0x7762, path: /dev/bus/usb/001/008 00000034 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x0B97, PID: 0x7762, path: /dev/bus/usb/001/008 00000008 hotplug_libudev.c:347:HPAddDevice() Adding USB device: O2 Micro Oz776 00000045 readerfactory.c:1015:RFInitializeReader() Attempting startup of O2 Micro Oz776 00 00 using /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so 00000276 readerfactory.c:900:RFBindFunctions() Loading IFD Handler 3.0 00000049 ifdhandler.c:1910:init_driver() Driver version: 1.4.16 00001003 ifdhandler.c:1927:init_driver() LogLevel: 0x0003 00000011 ifdhandler.c:1938:init_driver() DriverOptions: 0x0000 00000219 ifdhandler.c:1951:init_driver() LogLevel from LIBCCID_ifdLogLevel: 0x000F 00000011 ifdhandler.c:83:CreateChannelByNameOrChannel() Lun: 0, device: usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 00000012 ccid_usb.c:233:OpenUSBByName() Reader index: 0, Device: usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 00000030 ccid_usb.c:265:OpenUSBByName() interface_number: 0 00000008 ccid_usb.c:281:OpenUSBByName() Using: /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist 00000992 ccid_usb.c:299:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau (ludovic.rouss...@free.fr) 00000011 ccid_usb.c:300:OpenUSBByName() ifdProductString: Generic CCID driver 00000010 ccid_usb.c:301:OpenUSBByName() Copyright: This driver is protected by terms of the GNU Lesser General Public License version 2.1, or (at your option) any later version. 00006829 ccid_usb.c:426:OpenUSBByName() Checking device: 1/8 00000015 ccid_usb.c:488:OpenUSBByName() Trying to open USB bus/device: 1/8 00145985 ccid_usb.c:589:OpenUSBByName() Found Vendor/Product: 0B97/7762 (O2 Micro Oz776) 00000024 ccid_usb.c:591:OpenUSBByName() Using USB bus/device: 1/8 00000012 ccid_usb.c:643:OpenUSBByName() bNumDataRatesSupported is 0 00001218 ccid_usb.c:1202:InterruptRead() before (0) 00102540 ccid_usb.c:1246:InterruptRead() after (0) (2) 00000054 -> 000000 65 00 00 00 00 00 00 00 00 00 00000536 <- 000000 81 00 00 00 00 00 00 42 FE 00 00000023 -> 000000 65 00 00 00 00 00 01 00 00 00 00000221 <- 000000 81 00 00 00 00 00 01 42 FE 00 00000029 ifdhandler.c:362:IFDHGetCapabilities() tag: 0xFB3, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000011 readerfactory.c:358:RFAddReader() Using the reader polling thread 00000010 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000015 -> 000000 65 00 00 00 00 00 02 00 00 00 00000310 <- 000000 81 00 00 00 00 00 02 42 FE 00 00000015 ifdhandler.c:1891:IFDHICCPresence() Card absent 00000112 ifdhandler.c:362:IFDHGetCapabilities() tag: 0xFAE, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000012 ifdhandler.c:450:IFDHGetCapabilities() Reader supports 1 slot(s) 00000335 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x0B97, PID: 0x7761, path: /dev/bus/usb/001/004 00000215 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA005, path: /dev/bus/usb/001/002 00000197 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001 00000200 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA005, path: /dev/bus/usb/001/003 00000209 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x413C, PID: 0x9001, path: /dev/bus/usb/001/005 00000197 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA005, path: /dev/bus/usb/001/003 00000206 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x046D, PID: 0xC00E, path: /dev/bus/usb/001/006 00000274 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA005, path: /dev/bus/usb/001/003 00000358 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x03F9, PID: 0x0100, path: /dev/bus/usb/001/007 00000359 hotplug_libudev.c:295:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA005, path: /dev/bus/usb/001/003 00000230 readerfactory.c:1356:RFWaitForReaderInit() Waiting init for reader: O2 Micro Oz776 00 00 00000179 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000164 -> 000000 65 00 00 00 00 00 03 00 00 00 00000512 <- 000000 81 00 00 00 00 00 03 42 FE 00 00000160 ifdhandler.c:1891:IFDHICCPresence() Card absent 00000154 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000159 -> 000000 65 00 00 00 00 00 04 00 00 00 00000403 <- 000000 81 00 00 00 00 00 04 42 FE 00 00000159 ifdhandler.c:1891:IFDHICCPresence() Card absent 00000153 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 600000 ms 00000150 ccid_usb.c:1202:InterruptRead() before (0) 03192587 ccid_usb.c:1246:InterruptRead() after (0) (0) 00000031 NotifySlotChange: 50 03 00000016 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000016 -> 000000 65 00 00 00 00 00 05 00 00 00 00000741 <- 000000 81 00 00 00 00 00 05 01 00 00 00000018 ifdhandler.c:1891:IFDHICCPresence() Card present 00000011 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000015 -> 000000 65 00 00 00 00 00 06 00 00 00 00000336 <- 000000 81 00 00 00 00 00 06 01 00 00 00000016 ifdhandler.c:1891:IFDHICCPresence() Card present 00000024 ifdhandler.c:1122:IFDHPowerICC() action: PowerUp, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000016 -> 000000 62 00 00 00 00 00 07 01 00 00 00972477 <- 000000 80 10 00 00 00 00 07 00 00 00 3B 7B 94 00 00 80 62 12 51 56 46 69 6E 45 49 44 00000051 eventhandler.c:407:EHStatusHandlerThread() powerState: POWER_STATE_POWERED 00000009 eventhandler.c:422:EHStatusHandlerThread() Card inserted into O2 Micro Oz776 00 00 00000012 Card ATR: 3B 7B 94 00 00 80 62 12 51 56 46 69 6E 45 49 44 00000009 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 5000 ms 00000007 ccid_usb.c:1202:InterruptRead() before (0) 05002327 ccid_usb.c:1246:InterruptRead() after (0) (2) 00000032 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000024 -> 000000 65 00 00 00 00 00 08 00 00 00 00000812 <- 000000 81 10 00 00 00 00 08 00 00 00 00000023 ifdhandler.c:1891:IFDHICCPresence() Card present 00000014 ifdhandler.c:1122:IFDHPowerICC() action: PowerDown, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000015 -> 000000 63 00 00 00 00 00 09 00 00 00 00087593 <- 000000 81 10 00 00 00 00 09 01 00 00 00000028 eventhandler.c:481:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED 00000012 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000012 -> 000000 65 00 00 00 00 00 0A 00 00 00 00000396 <- 000000 81 10 00 00 00 00 0A 01 00 00 00000012 ifdhandler.c:1891:IFDHICCPresence() Card present 00000009 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 600000 ms 00000007 ccid_usb.c:1202:InterruptRead() before (0) 13529141 winscard_msg_srv.c:256:ProcessEventsServer() Common channel packet arrival 00000043 winscard_msg_srv.c:268:ProcessEventsServer() ProcessCommonChannelRequest detects: 14 00000014 pcscdaemon.c:137:SVCServiceRunLoop() A new context thread creation is requested: 14 00000522 winscard_svc.c:334:ContextThread() Authorized PC/SC client 00000163 winscard_svc.c:338:ContextThread() Thread is started: dwClientID=14, threadContext @0x9338c90 00000165 winscard_svc.c:356:ContextThread() Received command: CMD_VERSION from client 14 00000164 winscard_svc.c:368:ContextThread() Client is protocol version 4:3 00000152 winscard_svc.c:388:ContextThread() CMD_VERSION rv=0x0 for client 14 00000211 winscard_svc.c:356:ContextThread() Received command: ESTABLISH_CONTEXT from client 14 00000184 winscard.c:219:SCardEstablishContext() Establishing Context: 0x480198B 00000152 winscard_svc.c:449:ContextThread() ESTABLISH_CONTEXT rv=0x0 for client 14 00000200 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000236 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000519 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000215 winscard_svc.c:356:ContextThread() Received command: CONNECT from client 14 00000168 winscard_svc.c:487:ContextThread() Authorized client for 'O2 Micro Oz776 00 00' 00000151 winscard.c:261:SCardConnect() Attempting Connect to O2 Micro Oz776 00 00 using protocol: 3 00000151 readerfactory.c:771:RFReaderInfo() RefReader() count was: 1 00001092 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000179 -> 000000 65 00 00 00 00 00 0B 00 00 00 00000771 <- 000000 81 10 00 00 00 00 0B 01 00 00 00000241 ifdhandler.c:1891:IFDHICCPresence() Card present 00000159 ifdhandler.c:1122:IFDHPowerICC() action: PowerUp, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000163 -> 000000 62 00 00 00 00 00 0C 01 00 00 00972736 <- 000000 80 10 00 00 00 00 0C 00 00 00 3B 7B 94 00 00 80 62 12 51 56 46 69 6E 45 49 44 00000034 winscard.c:336:SCardConnect() power up complete. 00000018 Card ATR: 3B 7B 94 00 00 80 62 12 51 56 46 69 6E 45 49 44 00000009 winscard.c:356:SCardConnect() powerState: POWER_STATE_INUSE 00000010 prothandler.c:113:PHSetProtocol() Attempting PTS to T=0 00000026 ifdhandler.c:668:IFDHSetProtocolParameters() protocol T=0, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000011 ifdhandler.c:2030:extra_egt() Extra EGT patch applied 00000009 ifdhandler.c:792:IFDHSetProtocolParameters() Set speed to 62500 bauds 00000009 towitoko/atr.c:341:ATR_GetDefaultProtocol() no default protocol found in ATR. Using T=0 00000008 ifdhandler.c:889:IFDHSetProtocolParameters() PPS not supported on O2Micro readers. Using T=0 00000010 ifdhandler.c:1028:IFDHSetProtocolParameters() Communication timeout: 319489 ms 00000009 commands.c:2207:SetParameters() length: 5 bytes 00000018 -> 000000 61 05 00 00 00 00 0D 00 00 00 94 00 02 0A 00 00000723 <- 000000 82 05 00 00 00 00 0D 00 00 00 94 00 02 0A 00 00000017 winscard.c:435:SCardConnect() Active Protocol: T=0 00000014 winscard.c:455:SCardConnect() hCard Identity: 5a3bc9ca 00000013 winscard.c:516:SCardConnect() UnrefReader() count was: 2 00000014 winscard_svc.c:501:ContextThread() CONNECT rv=0x0 for client 14 00000273 winscard_svc.c:356:ContextThread() Received command: CONTROL from client 14 00000023 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000014 ifdhandler.c:1360:IFDHControl() ControlCode: 0x42000D48, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000008 Control TxBuffer: 00000012 Control RxBuffer: 12 04 42 33 00 12 00000008 winscard.c:1376:SCardControl() UnrefReader() count was: 2 00000009 winscard_svc.c:700:ContextThread() CONTROL rv=0x0 for client 14 00000253 winscard_svc.c:356:ContextThread() Received command: DISCONNECT from client 14 00000022 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000010 winscard.c:876:SCardDisconnect() Active Contexts: 1 00000008 winscard.c:877:SCardDisconnect() dwDisposition: 0 00000011 winscard.c:1042:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD 00000010 ifdhandler.c:362:IFDHGetCapabilities() tag: 0xFB2, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000008 winscard.c:1056:SCardDisconnect() Stopping polling thread 00000010 ifdhandler.c:327:IFDHStopPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00002220 winscard.c:1069:SCardDisconnect() UnrefReader() count was: 2 00000019 winscard_svc.c:538:ContextThread() DISCONNECT rv=0x0 for client 14 00000096 ccid_usb.c:1246:InterruptRead() after (0) (3) 00000033 ccid_usb.c:1261:InterruptRead() InterruptRead (1/8): Resource temporarily unavailable 00000172 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000222 winscard_svc.c:356:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14 00000029 winscard_svc.c:356:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14 00000017 winscard_svc.c:430:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14 00000188 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000238 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000205 winscard_svc.c:356:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14 00000028 winscard_svc.c:356:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14 00000016 winscard_svc.c:430:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14 00000086 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000211 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000104 winscard_svc.c:356:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14 00000027 winscard_svc.c:356:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14 00000016 winscard_svc.c:430:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14 00000181 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000097 winscard_svc.c:356:ContextThread() Received command: CONNECT from client 14 00000019 winscard_svc.c:487:ContextThread() Authorized client for 'O2 Micro Oz776 00 00' 00000010 winscard.c:261:SCardConnect() Attempting Connect to O2 Micro Oz776 00 00 using protocol: 3 00000009 readerfactory.c:771:RFReaderInfo() RefReader() count was: 1 00000008 winscard.c:356:SCardConnect() powerState: POWER_STATE_INUSE 00000009 winscard.c:435:SCardConnect() Active Protocol: T=0 00000008 winscard.c:455:SCardConnect() hCard Identity: 1bfe714 00000011 winscard.c:516:SCardConnect() UnrefReader() count was: 2 00000011 winscard_svc.c:501:ContextThread() CONNECT rv=0x0 for client 14 00011923 winscard_svc.c:356:ContextThread() Received command: BEGIN_TRANSACTION from client 14 00000031 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000013 winscard.c:1108:SCardBeginTransaction() Status: 0x00000000 00000008 winscard.c:1111:SCardBeginTransaction() UnrefReader() count was: 2 00000010 winscard_svc.c:553:ContextThread() BEGIN_TRANSACTION rv=0x0 for client 14 00000290 winscard_svc.c:356:ContextThread() Received command: TRANSMIT from client 14 00000026 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000011 winscard.c:1613:SCardTransmit() Send Protocol: T=0 00000021 APDU: 00 A4 04 0C 0C A0 00 00 00 63 50 4B 43 53 2D 31 35 00000011 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000023 commands.c:1966:CmdXfrBlockCHAR_T0() T=0: 17 bytes 00000020 -> 000000 6F 05 00 00 00 00 0E 00 01 00 00 A4 04 0C 0C 01230094 <- 000000 80 00 00 00 00 00 0E 40 FE 00 00000066 commands.c:1477:CCID_Receive Card absent or mute 00000013 commands.c:2104:CmdXfrBlockCHAR_T0() CCID_Receive failed 00000016 SW: 00000010 ifdwrapper.c:553:IFDTransmit() Card not transacted: 612 00000009 winscard.c:1638:SCardTransmit() Card not transacted: 0x80100016 00000008 winscard.c:1658:SCardTransmit() UnrefReader() count was: 2 00000012 winscard_svc.c:656:ContextThread() TRANSMIT rv=0x80100016 for client 14 00000158 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000024 -> 000000 65 00 00 00 00 00 0F 00 00 00 00000679 <- 000000 81 00 00 00 00 00 0F 00 00 00 00000017 ifdhandler.c:1891:IFDHICCPresence() Card present 00000015 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 600000 ms 00000009 ccid_usb.c:1202:InterruptRead() before (0) 00000094 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000214 winscard_svc.c:356:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14 00000031 winscard_svc.c:356:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14 00000017 winscard_svc.c:430:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14 00000088 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000191 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000104 winscard_svc.c:356:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14 00000027 winscard_svc.c:356:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14 00000016 winscard_svc.c:430:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14 00000182 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000126 winscard_svc.c:356:ContextThread() Received command: END_TRANSACTION from client 14 00000023 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000012 winscard.c:1251:SCardEndTransaction() Status: 0x00000000 00000008 winscard.c:1254:SCardEndTransaction() UnrefReader() count was: 2 00000009 winscard_svc.c:569:ContextThread() END_TRANSACTION rv=0x0 for client 14 00002721 winscard_svc.c:356:ContextThread() Received command: BEGIN_TRANSACTION from client 14 00000027 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000012 winscard.c:1108:SCardBeginTransaction() Status: 0x00000000 00000008 winscard.c:1111:SCardBeginTransaction() UnrefReader() count was: 2 00000010 winscard_svc.c:553:ContextThread() BEGIN_TRANSACTION rv=0x0 for client 14 00000267 winscard_svc.c:356:ContextThread() Received command: TRANSMIT from client 14 00000025 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000011 winscard.c:1613:SCardTransmit() Send Protocol: T=0 00000015 APDU: 00 A4 00 00 02 3F 00 00000010 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000009 commands.c:1966:CmdXfrBlockCHAR_T0() T=0: 7 bytes 00000019 -> 000000 6F 05 00 00 00 00 10 00 01 00 00 A4 00 00 02 01230504 <- 000000 80 00 00 00 00 00 10 40 FE 00 00000028 commands.c:1477:CCID_Receive Card absent or mute 00000012 commands.c:2104:CmdXfrBlockCHAR_T0() CCID_Receive failed 00000009 SW: 00000009 ifdwrapper.c:553:IFDTransmit() Card not transacted: 612 00000019 winscard.c:1638:SCardTransmit() Card not transacted: 0x80100016 00000009 winscard.c:1658:SCardTransmit() UnrefReader() count was: 2 00000011 winscard_svc.c:656:ContextThread() TRANSMIT rv=0x80100016 for client 14 00000531 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000235 winscard_svc.c:356:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14 00000031 winscard_svc.c:356:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14 00000018 winscard_svc.c:430:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14 00000239 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000101 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000203 winscard_svc.c:356:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14 00000028 winscard_svc.c:356:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14 00000016 winscard_svc.c:430:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14 00000089 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00001908 winscard_svc.c:348:ContextThread() Client die: 14 00000040 winscard.c:230:SCardReleaseContext() Releasing Context: 0x480198B 00000016 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000009 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 2 00000009 winscard.c:1317:SCardStatus() UnrefReader() count was: 3 00000009 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 2 00000009 winscard.c:876:SCardDisconnect() Active Contexts: 1 00000008 winscard.c:877:SCardDisconnect() dwDisposition: 1 00000013 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000018 -> 000000 65 00 00 00 00 00 11 00 00 00 00000500 <- 000000 81 00 00 00 00 00 11 00 00 00 00000016 ifdhandler.c:1891:IFDHICCPresence() Card present 00000012 ifdhandler.c:1122:IFDHPowerICC() action: Reset, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000016 -> 000000 62 00 00 00 00 00 12 01 00 00 00078753 <- 000000 80 10 00 00 00 00 12 00 00 00 3B 7B 94 00 00 80 62 12 51 56 46 69 6E 45 49 44 00000024 winscard.c:943:SCardDisconnect() Reset complete. 00000013 Card ATR: 3B 7B 94 00 00 80 62 12 51 56 46 69 6E 45 49 44 00000010 winscard.c:1042:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD 00000008 ifdhandler.c:362:IFDHGetCapabilities() tag: 0xFB2, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000006 winscard.c:1056:SCardDisconnect() Stopping polling thread 00000007 ifdhandler.c:327:IFDHStopPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00002164 winscard.c:1069:SCardDisconnect() UnrefReader() count was: 3 00000014 winscard_svc.c:865:MSGRemoveContext() UnrefReader() count was: 2 00000009 winscard_svc.c:981:MSGCleanupClient() Thread is stopping: dwClientID=14, threadContext @0x9338c90 00000006 winscard_svc.c:987:MSGCleanupClient() Freeing SCONTEXT @0x9338c90 00000528 ccid_usb.c:1246:InterruptRead() after (0) (3) 00000019 ccid_usb.c:1261:InterruptRead() InterruptRead (1/8): Resource temporarily unavailable 00400106 eventhandler.c:493:EHStatusHandlerThread() powerState: POWER_STATE_POWERED 00000033 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000017 -> 000000 65 00 00 00 00 00 13 00 00 00 00000578 <- 000000 81 10 00 00 00 00 13 00 00 00 00000012 ifdhandler.c:1891:IFDHICCPresence() Card present 00000010 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 5000 ms 00000007 ccid_usb.c:1202:InterruptRead() before (0) 05002150 ccid_usb.c:1246:InterruptRead() after (0) (2) 00000034 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000023 -> 000000 65 00 00 00 00 00 14 00 00 00 00000739 <- 000000 81 10 00 00 00 00 14 00 00 00 00000019 ifdhandler.c:1891:IFDHICCPresence() Card present 00000012 ifdhandler.c:1122:IFDHPowerICC() action: PowerDown, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000015 -> 000000 63 00 00 00 00 00 15 00 00 00 00087651 <- 000000 81 10 00 00 00 00 15 01 00 00 00000031 eventhandler.c:481:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED 00000015 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000016 -> 000000 65 00 00 00 00 00 16 00 00 00 00002702 <- 000000 81 10 00 00 00 00 16 01 00 00 00000027 ifdhandler.c:1891:IFDHICCPresence() Card present 00000014 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 600000 ms 00000009 ccid_usb.c:1202:InterruptRead() before (0) 31199077 winscard_msg_srv.c:256:ProcessEventsServer() Common channel packet arrival 00000028 winscard_msg_srv.c:268:ProcessEventsServer() ProcessCommonChannelRequest detects: 14 00000010 pcscdaemon.c:137:SVCServiceRunLoop() A new context thread creation is requested: 14 00000340 winscard_svc.c:334:ContextThread() Authorized PC/SC client 00000036 winscard_svc.c:338:ContextThread() Thread is started: dwClientID=14, threadContext @0x9338650 00000035 winscard_svc.c:356:ContextThread() Received command: CMD_VERSION from client 14 00000033 winscard_svc.c:368:ContextThread() Client is protocol version 4:3 00000028 winscard_svc.c:388:ContextThread() CMD_VERSION rv=0x0 for client 14 00000069 winscard_svc.c:356:ContextThread() Received command: ESTABLISH_CONTEXT from client 14 00000037 winscard.c:219:SCardEstablishContext() Establishing Context: 0x7323DB6B 00014693 winscard_svc.c:449:ContextThread() ESTABLISH_CONTEXT rv=0x0 for client 14 00000254 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000063 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000078 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000070 winscard_svc.c:356:ContextThread() Received command: CONNECT from client 14 00000045 winscard_svc.c:487:ContextThread() Authorized client for 'O2 Micro Oz776 00 00' 00000030 winscard.c:261:SCardConnect() Attempting Connect to O2 Micro Oz776 00 00 using protocol: 3 00000028 readerfactory.c:771:RFReaderInfo() RefReader() count was: 1 00000031 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000036 -> 000000 65 00 00 00 00 00 17 00 00 00 00000335 <- 000000 81 10 00 00 00 00 17 01 00 00 00000034 ifdhandler.c:1891:IFDHICCPresence() Card present 00000029 ifdhandler.c:1122:IFDHPowerICC() action: PowerUp, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000033 -> 000000 62 00 00 00 00 00 18 01 00 00 00972540 <- 000000 80 10 00 00 00 00 18 00 00 00 3B 7B 94 00 00 80 62 12 51 56 46 69 6E 45 49 44 00000036 winscard.c:336:SCardConnect() power up complete. 00000019 Card ATR: 3B 7B 94 00 00 80 62 12 51 56 46 69 6E 45 49 44 00000008 winscard.c:356:SCardConnect() powerState: POWER_STATE_INUSE 00000010 prothandler.c:113:PHSetProtocol() Attempting PTS to T=0 00000013 ifdhandler.c:668:IFDHSetProtocolParameters() protocol T=0, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000011 ifdhandler.c:2030:extra_egt() Extra EGT patch applied 00000009 ifdhandler.c:792:IFDHSetProtocolParameters() Set speed to 62500 bauds 00000009 towitoko/atr.c:341:ATR_GetDefaultProtocol() no default protocol found in ATR. Using T=0 00000008 ifdhandler.c:889:IFDHSetProtocolParameters() PPS not supported on O2Micro readers. Using T=0 00000009 ifdhandler.c:1028:IFDHSetProtocolParameters() Communication timeout: 319489 ms 00000009 commands.c:2207:SetParameters() length: 5 bytes 00000018 -> 000000 61 05 00 00 00 00 19 00 00 00 94 00 02 0A 00 00000746 <- 000000 82 05 00 00 00 00 19 00 00 00 94 00 02 0A 00 00000019 winscard.c:435:SCardConnect() Active Protocol: T=0 00000014 winscard.c:455:SCardConnect() hCard Identity: 66a2ea9f 00000013 winscard.c:516:SCardConnect() UnrefReader() count was: 2 00000014 winscard_svc.c:501:ContextThread() CONNECT rv=0x0 for client 14 00000289 winscard_svc.c:356:ContextThread() Received command: CONTROL from client 14 00000024 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000014 ifdhandler.c:1360:IFDHControl() ControlCode: 0x42000D48, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000008 Control TxBuffer: 00000012 Control RxBuffer: 12 04 42 33 00 12 00000008 winscard.c:1376:SCardControl() UnrefReader() count was: 2 00000009 winscard_svc.c:700:ContextThread() CONTROL rv=0x0 for client 14 00000267 winscard_svc.c:356:ContextThread() Received command: DISCONNECT from client 14 00000023 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000010 winscard.c:876:SCardDisconnect() Active Contexts: 1 00000008 winscard.c:877:SCardDisconnect() dwDisposition: 0 00000010 winscard.c:1042:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD 00000011 ifdhandler.c:362:IFDHGetCapabilities() tag: 0xFB2, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000008 winscard.c:1056:SCardDisconnect() Stopping polling thread 00000009 ifdhandler.c:327:IFDHStopPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00002063 winscard.c:1069:SCardDisconnect() UnrefReader() count was: 2 00000019 winscard_svc.c:538:ContextThread() DISCONNECT rv=0x0 for client 14 00000107 ccid_usb.c:1246:InterruptRead() after (0) (3) 00000024 ccid_usb.c:1261:InterruptRead() InterruptRead (1/8): Resource temporarily unavailable 00000177 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000227 winscard_svc.c:356:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14 00000030 winscard_svc.c:356:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14 00000016 winscard_svc.c:430:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14 00000188 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000215 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000205 winscard_svc.c:356:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14 00000028 winscard_svc.c:356:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14 00000016 winscard_svc.c:430:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14 00000088 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000194 winscard_svc.c:356:ContextThread() Received command: CONNECT from client 14 00000020 winscard_svc.c:487:ContextThread() Authorized client for 'O2 Micro Oz776 00 00' 00000010 winscard.c:261:SCardConnect() Attempting Connect to O2 Micro Oz776 00 00 using protocol: 3 00000009 readerfactory.c:771:RFReaderInfo() RefReader() count was: 1 00000008 winscard.c:356:SCardConnect() powerState: POWER_STATE_INUSE 00000008 winscard.c:435:SCardConnect() Active Protocol: T=0 00000009 winscard.c:455:SCardConnect() hCard Identity: 7adb483e 00000011 winscard.c:516:SCardConnect() UnrefReader() count was: 2 00000011 winscard_svc.c:501:ContextThread() CONNECT rv=0x0 for client 14 00000859 winscard_svc.c:356:ContextThread() Received command: BEGIN_TRANSACTION from client 14 00000022 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000012 winscard.c:1108:SCardBeginTransaction() Status: 0x00000000 00000007 winscard.c:1111:SCardBeginTransaction() UnrefReader() count was: 2 00000009 winscard_svc.c:553:ContextThread() BEGIN_TRANSACTION rv=0x0 for client 14 00000225 winscard_svc.c:356:ContextThread() Received command: TRANSMIT from client 14 00000025 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000011 winscard.c:1613:SCardTransmit() Send Protocol: T=0 00000020 APDU: 00 A4 04 0C 0C A0 00 00 00 63 50 4B 43 53 2D 31 35 00000010 ifdhandler.c:1266:IFDHTransmitToICC() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000017 commands.c:1966:CmdXfrBlockCHAR_T0() T=0: 17 bytes 00000019 -> 000000 6F 05 00 00 00 00 1A 00 01 00 00 A4 04 0C 0C 01230242 <- 000000 80 00 00 00 00 00 1A 40 FE 00 00000046 commands.c:1477:CCID_Receive Card absent or mute 00000012 commands.c:2104:CmdXfrBlockCHAR_T0() CCID_Receive failed 00000017 SW: 00000010 ifdwrapper.c:553:IFDTransmit() Card not transacted: 612 00000019 winscard.c:1638:SCardTransmit() Card not transacted: 0x80100016 00000008 winscard.c:1658:SCardTransmit() UnrefReader() count was: 2 00000012 winscard_svc.c:656:ContextThread() TRANSMIT rv=0x80100016 for client 14 00000204 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000024 -> 000000 65 00 00 00 00 00 1B 00 00 00 00000722 <- 000000 81 00 00 00 00 00 1B 00 00 00 00000017 ifdhandler.c:1891:IFDHICCPresence() Card present 00000014 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 600000 ms 00000010 ccid_usb.c:1202:InterruptRead() before (0) 00000093 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000212 winscard_svc.c:356:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14 00000031 winscard_svc.c:356:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14 00000017 winscard_svc.c:430:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14 00000186 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000096 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000099 winscard_svc.c:356:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14 00000026 winscard_svc.c:356:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14 00000016 winscard_svc.c:430:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14 00000182 winscard_svc.c:356:ContextThread() Received command: CMD_GET_READERS_STATE from client 14 00000126 winscard_svc.c:356:ContextThread() Received command: END_TRANSACTION from client 14 00000024 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000011 winscard.c:1251:SCardEndTransaction() Status: 0x00000000 00000008 winscard.c:1254:SCardEndTransaction() UnrefReader() count was: 2 00000010 winscard_svc.c:569:ContextThread() END_TRANSACTION rv=0x0 for client 14 00004990 winscard_svc.c:356:ContextThread() Received command: BEGIN_TRANSACTION from client 14 00000024 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000012 winscard.c:1108:SCardBeginTransaction() Status: 0x00000000 00000008 winscard.c:1111:SCardBeginTransaction() UnrefReader() count was: 2 00000009 winscard_svc.c:553:ContextThread() BEGIN_TRANSACTION rv=0x0 for client 14 00000242 winscard_svc.c:356:ContextThread() Received command: END_TRANSACTION from client 14 00000022 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000010 winscard.c:1251:SCardEndTransaction() Status: 0x00000000 00000008 winscard.c:1254:SCardEndTransaction() UnrefReader() count was: 2 00000009 winscard_svc.c:569:ContextThread() END_TRANSACTION rv=0x0 for client 14 00001171 winscard_svc.c:356:ContextThread() Received command: DISCONNECT from client 14 00000023 readerfactory.c:798:RFReaderInfoById() RefReader() count was: 1 00000010 winscard.c:876:SCardDisconnect() Active Contexts: 1 00000008 winscard.c:877:SCardDisconnect() dwDisposition: 1 00000012 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000016 -> 000000 65 00 00 00 00 00 1C 00 00 00 00000510 <- 000000 81 00 00 00 00 00 1C 00 00 00 00000024 ifdhandler.c:1891:IFDHICCPresence() Card present 00000013 ifdhandler.c:1122:IFDHPowerICC() action: Reset, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000016 -> 000000 62 00 00 00 00 00 1D 01 00 00 00078797 <- 000000 80 10 00 00 00 00 1D 00 00 00 3B 7B 94 00 00 80 62 12 51 56 46 69 6E 45 49 44 00000038 winscard.c:943:SCardDisconnect() Reset complete. 00000019 Card ATR: 3B 7B 94 00 00 80 62 12 51 56 46 69 6E 45 49 44 00000013 winscard.c:1042:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD 00000012 ifdhandler.c:362:IFDHGetCapabilities() tag: 0xFB2, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000008 winscard.c:1056:SCardDisconnect() Stopping polling thread 00000009 ifdhandler.c:327:IFDHStopPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00002233 winscard.c:1069:SCardDisconnect() UnrefReader() count was: 2 00000027 winscard_svc.c:538:ContextThread() DISCONNECT rv=0x0 for client 14 00000207 ccid_usb.c:1246:InterruptRead() after (0) (3) 00000027 ccid_usb.c:1261:InterruptRead() InterruptRead (1/8): Resource temporarily unavailable 00000101 winscard_svc.c:356:ContextThread() Received command: RELEASE_CONTEXT from client 14 00000021 winscard.c:230:SCardReleaseContext() Releasing Context: 0x7323DB6B 00000012 winscard_svc.c:464:ContextThread() RELEASE_CONTEXT rv=0x0 for client 14 00001719 winscard_svc.c:348:ContextThread() Client die: 14 00000034 winscard_svc.c:981:MSGCleanupClient() Thread is stopping: dwClientID=14, threadContext @0x9338650 00000010 winscard_svc.c:987:MSGCleanupClient() Freeing SCONTEXT @0x9338650 00398308 eventhandler.c:493:EHStatusHandlerThread() powerState: POWER_STATE_POWERED 00000044 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000024 -> 000000 65 00 00 00 00 00 1E 00 00 00 00000870 <- 000000 81 10 00 00 00 00 1E 00 00 00 00000024 ifdhandler.c:1891:IFDHICCPresence() Card present 00000014 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 5000 ms 00000010 ccid_usb.c:1202:InterruptRead() before (0) 05002342 ccid_usb.c:1246:InterruptRead() after (0) (2) 00000073 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000024 -> 000000 65 00 00 00 00 00 1F 00 00 00 00000829 <- 000000 81 10 00 00 00 00 1F 00 00 00 00000019 ifdhandler.c:1891:IFDHICCPresence() Card present 00000012 ifdhandler.c:1122:IFDHPowerICC() action: PowerDown, usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000015 -> 000000 63 00 00 00 00 00 20 00 00 00 00087637 <- 000000 81 10 00 00 00 00 20 01 00 00 00000036 eventhandler.c:481:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED 00000017 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000016 -> 000000 65 00 00 00 00 00 21 00 00 00 00000474 <- 000000 81 10 00 00 00 00 21 01 00 00 00000017 ifdhandler.c:1891:IFDHICCPresence() Card present 00000012 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 600000 ms 00000010 ccid_usb.c:1202:InterruptRead() before (0) 40385576 ccid_usb.c:1246:InterruptRead() after (0) (0) 00000029 NotifySlotChange: 50 02 00000015 ifdhandler.c:1770:IFDHICCPresence() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 00000016 -> 000000 65 00 00 00 00 00 22 00 00 00 00000554 <- 000000 81 10 00 00 00 00 22 42 FE 00 00000017 ifdhandler.c:1891:IFDHICCPresence() Card absent 00000011 eventhandler.c:361:EHStatusHandlerThread() Card Removed From O2 Micro Oz776 00 00 00000012 ifdhandler.c:291:IFDHPolling() usb:0b97/7762:libudev:0:/dev/bus/usb/001/008 (lun: 0) 600000 ms 00000009 ccid_usb.c:1202:InterruptRead() before (0)