[Pcsclite-muscle] SCardConnect() returns unresponsive card

Gökçenur CANLI gokcenur.canli at udea.com.tr
Thu May 18 11:29:55 UTC 2017


Sorry for wrong one, generated updated log is attached.


On 18-05-2017 14:22, Ludovic Rousseau wrote:
> 2017-05-18 12:10 GMT+02:00 Gökçenur CANLI <gokcenur.canli at udea.com.tr 
> <mailto:gokcenur.canli at udea.com.tr>>:
>
>     Hello,
>
>     I executed my program and reproduced problem again. New log file
>     is attached.
>
>
> This log is not complete.
> Your first log was correctly generated. Please use the same method.
>
> Thanks
>
> -- 
>  Dr. Ludovic Rousseau
>
>
> _______________________________________________
> Pcsclite-muscle mailing list
> Pcsclite-muscle at lists.alioth.debian.org
> http://lists.alioth.debian.org/cgi-bin/mailman/listinfo/pcsclite-muscle

-- 
*Gökçenur CANLI*
/Ar-Ge Mühendisi
/UDEA Elektronik A.Ş. ODTÜ Teknokent
Gümüş Bloklar K1-3 Ofis Alanı
Çankaya/ANKARA
Tel : + 90 (312) 210 19 82
Fax: +90 (312) 210 19 97
//
Signature <http://www.udea.com.tr>//
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.alioth.debian.org/pipermail/pcsclite-muscle/attachments/20170518/02182cf4/attachment-0001.html>
-------------- next part --------------
00000000 debuglog.c:289:DebugLogSetLevel() debug level=debug
00000016 debuglog.c:310:DebugLogSetCategory() Debug options: APDU
00000004 pcscdaemon.c:351:main() Force colored logs
00000092 configfile.l:358:DBGetReaderList() Parsing conf file: /usr/local/etc/reader.conf.d
00000013 pcscdaemon.c:655:main() pcsc-lite 1.8.20 daemon ready.
00001889 hotplug_libusb.c:536:HPAddHotPluggable() Adding USB device: 1:12:0
00000607 readerfactory.c:1079:RFInitializeReader() Attempting startup of USX101x SmartCard Reader (330C38CB) 00 00 using /usr/local/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so
00000079 readerfactory.c:954:RFBindFunctions() Loading IFD Handler 3.0
00000019 ifdhandler.c:1961:init_driver() Driver version: 1.4.26
00000461 ifdhandler.c:1978:init_driver() LogLevel: 0x0003
00000006 ifdhandler.c:1989:init_driver() DriverOptions: 0x0000
00000147 ifdhandler.c:2002:init_driver() LogLevel from LIBCCID_ifdLogLevel: 0x000F
00000004 ifdhandler.c:111:CreateChannelByNameOrChannel() Lun: 0, device: usb:0424/1104:libusb-1.0:1:12:0
00000005 ccid_usb.c:237:OpenUSBByName() Reader index: 0, Device: usb:0424/1104:libusb-1.0:1:12:0
00000007 ccid_usb.c:287:OpenUSBByName() Using: /usr/local/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist
00000458 ccid_usb.c:305:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau (ludovic.rousseau at free.fr)
00000004 ccid_usb.c:306:OpenUSBByName() ifdProductString: Generic CCID driver
00000003 ccid_usb.c:307: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.
00000760 ccid_usb.c:391:OpenUSBByName() Try device: 2/1
00000004 ccid_usb.c:401:OpenUSBByName() vid/pid : 1D6B/0003
00000002 ccid_usb.c:391:OpenUSBByName() Try device: 1/7
00000002 ccid_usb.c:401:OpenUSBByName() vid/pid : 0BDA/0129
00000002 ccid_usb.c:391:OpenUSBByName() Try device: 1/5
00000002 ccid_usb.c:401:OpenUSBByName() vid/pid : 04F2/B483
00000001 ccid_usb.c:391:OpenUSBByName() Try device: 1/12
00000012 ccid_usb.c:401:OpenUSBByName() vid/pid : 0424/1104
00000002 ccid_usb.c:448:OpenUSBByName() Checking device: 1/12
00000002 ccid_usb.c:519:OpenUSBByName() Trying to open USB bus/device: 1/12
00000039 ccid_usb.c:621:OpenUSBByName() Found Vendor/Product: 0424/1104 (USX101x SmartCard Reader)
00000003 ccid_usb.c:623:OpenUSBByName() Using USB bus/device: 1/12
00000002 ccid_usb.c:680:OpenUSBByName() bNumDataRatesSupported is 0
00001257 ccid_usb.c:1244:InterruptRead() before (0)
00005929 ccid_usb.c:1290:InterruptRead() after (0) (0)
00000011 NotifySlotChange: 50 02 
00000005 -> 000000 65 00 00 00 00 00 00 00 00 00 
00000247 <- 000000 81 00 00 00 00 00 00 01 00 01 
00000007 -> 000000 65 00 00 00 00 00 01 00 00 00 
00000247 <- 000000 81 00 00 00 00 00 01 01 00 01 
00000010 ifdhandler.c:382:IFDHGetCapabilities() tag: 0xFB3, usb:0424/1104:libusb-1.0:1:12:0 (lun: 0)
00000003 readerfactory.c:395:RFAddReader() Using the reader polling thread
00000003 ifdhandler.c:1821:IFDHICCPresence() usb:0424/1104:libusb-1.0:1:12:0 (lun: 0)
00000004 -> 000000 65 00 00 00 00 00 02 00 00 00 
00000207 <- 000000 81 00 00 00 00 00 02 01 00 01 
00000005 ifdhandler.c:1942:IFDHICCPresence() Card present
00000509 ifdhandler.c:382:IFDHGetCapabilities() tag: 0xFAE, usb:0424/1104:libusb-1.0:1:12:0 (lun: 0)
00000007 ifdhandler.c:473:IFDHGetCapabilities() Reader supports 1 slot(s)
00000212 hotplug_libusb.c:440:HPEstablishUSBNotifications() Driver ifd-ccid.bundle does not support IFD_GENERATE_HOTPLUG. Using active polling instead.
00000004 hotplug_libusb.c:449:HPEstablishUSBNotifications() Polling forced every 1 second(s)
00000057 ifdhandler.c:1821:IFDHICCPresence() usb:0424/1104:libusb-1.0:1:12:0 (lun: 0)
00000021 -> 000000 65 00 00 00 00 00 03 00 00 00 
00000000 readerfactory.c:1420:RFWaitForReaderInit() Waiting init for reader: USX101x SmartCard Reader (330C38CB) 00 00
00000405 <- 000000 81 00 00 00 00 00 03 01 00 01 
00000012 ifdhandler.c:1942:IFDHICCPresence() Card present
00000005 ifdhandler.c:1821:IFDHICCPresence() usb:0424/1104:libusb-1.0:1:12:0 (lun: 0)
00000006 -> 000000 65 00 00 00 00 00 04 00 00 00 
00000222 <- 000000 81 00 00 00 00 00 04 01 00 01 
00000008 ifdhandler.c:1942:IFDHICCPresence() Card present
00000004 ifdhandler.c:1154:IFDHPowerICC() action: PowerUp, usb:0424/1104:libusb-1.0:1:12:0 (lun: 0)
00000005 -> 000000 62 00 00 00 00 00 05 01 00 00 
00009462 readerfactory.c:1420:RFWaitForReaderInit() Waiting init for reader: USX101x SmartCard Reader (330C38CB) 00 00
00010150 readerfactory.c:1420:RFWaitForReaderInit() Waiting init for reader: USX101x SmartCard Reader (330C38CB) 00 00
00010085 readerfactory.c:1420:RFWaitForReaderInit() Waiting init for reader: USX101x SmartCard Reader (330C38CB) 00 00
00010072 readerfactory.c:1420:RFWaitForReaderInit() Waiting init for reader: USX101x SmartCard Reader (330C38CB) 00 00
00010109 readerfactory.c:1420:RFWaitForReaderInit() Waiting init for reader: USX101x SmartCard Reader (330C38CB) 00 00
00010116 readerfactory.c:1420:RFWaitForReaderInit() Waiting init for reader: USX101x SmartCard Reader (330C38CB) 00 00
00010126 readerfactory.c:1420:RFWaitForReaderInit() Waiting init for reader: USX101x SmartCard Reader (330C38CB) 00 00
00010146 readerfactory.c:1420:RFWaitForReaderInit() Waiting init for reader: USX101x SmartCard Reader (330C38CB) 00 00
00010099 readerfactory.c:1420:RFWaitForReaderInit() Waiting init for reader: USX101x SmartCard Reader (330C38CB) 00 00
00001901 <- 000000 80 17 00 00 00 00 05 00 00 00 3B 9F 96 81 31 FE 45 80 65 54 43 12 21 08 31 C0 73 F6 21 80 81 05 9A 
00000029 eventhandler.c:286:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
00000004 Card ATR: 3B 9F 96 81 31 FE 45 80 65 54 43 12 21 08 31 C0 73 F6 21 80 81 05 9A 
00000007 ifdhandler.c:1821:IFDHICCPresence() usb:0424/1104:libusb-1.0:1:12:0 (lun: 0)
00000003 -> 000000 65 00 00 00 00 00 06 00 00 00 
00000290 <- 000000 81 00 00 00 00 00 06 00 00 00 
00000004 ifdhandler.c:1942:IFDHICCPresence() Card present
00000002 ifdhandler.c:311:IFDHPolling() usb:0424/1104:libusb-1.0:1:12:0 (lun: 0) 5000 ms
00000001 ccid_usb.c:1244:InterruptRead() before (0)
00001163 ccid_usb.c:1290:InterruptRead() after (0) (0)
00000005 NotifySlotChange: 50 03 
00000002 ifdhandler.c:1821:IFDHICCPresence() usb:0424/1104:libusb-1.0:1:12:0 (lun: 0)
00000013 -> 000000 65 00 00 00 00 00 07 00 00 00 
00000268 <- 000000 81 00 00 00 00 00 07 00 00 00 
00000014 ifdhandler.c:1942:IFDHICCPresence() Card present
00000002 ifdhandler.c:1154:IFDHPowerICC() action: PowerDown, usb:0424/1104:libusb-1.0:1:12:0 (lun: 0)
00000002 -> 000000 63 00 00 00 00 00 08 00 00 00 
00011525 <- 000000 81 00 00 00 00 00 08 01 00 01 
00000014 eventhandler.c:479:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED
00000003 ifdhandler.c:1821:IFDHICCPresence() usb:0424/1104:libusb-1.0:1:12:0 (lun: 0)
00000004 -> 000000 65 00 00 00 00 00 09 00 00 00 
00000289 <- 000000 81 00 00 00 00 00 09 01 00 01 
00000007 ifdhandler.c:1942:IFDHICCPresence() Card present
00000003 ifdhandler.c:311:IFDHPolling() usb:0424/1104:libusb-1.0:1:12:0 (lun: 0) 600000 ms
00000003 ccid_usb.c:1244:InterruptRead() before (0)
08070632 winscard_msg_srv.c:251:ProcessEventsServer() Common channel packet arrival
00000021 winscard_msg_srv.c:263:ProcessEventsServer() ProcessCommonChannelRequest detects: 6
00000004 pcscdaemon.c:132:SVCServiceRunLoop() A new context thread creation is requested: 6
00000053 winscard_svc.c:337:ContextThread() Authorized PC/SC client
00000006 winscard_svc.c:341:ContextThread() Thread is started: dwClientID=6, threadContext @0x126f9b0
00000010 winscard_svc.c:359:ContextThread() Received command: CMD_VERSION from client 6
00000004 winscard_svc.c:371:ContextThread() Client is protocol version 4:3
00000003 winscard_svc.c:391:ContextThread() CMD_VERSION rv=0x0 for client 6
00000041 winscard_svc.c:359:ContextThread() Received command: ESTABLISH_CONTEXT from client 6
00000011 winscard.c:215:SCardEstablishContext() Establishing Context: 0x55646AFD
00000002 winscard_svc.c:455:ContextThread() ESTABLISH_CONTEXT rv=0x0 for client 6
00000042 winscard_svc.c:359:ContextThread() Received command: CMD_GET_READERS_STATE from client 6
00000056 winscard_svc.c:359:ContextThread() Received command: CONNECT from client 6
00000012 winscard_svc.c:493:ContextThread() Authorized client for 'USX101x SmartCard Reader (330C38CB) 00 00'
00000003 winscard.c:256:SCardConnect() Attempting Connect to USX101x SmartCard Reader (330C38CB) 00 00 using protocol: 2
00000003 readerfactory.c:825:RFReaderInfo() RefReader() count was: 1
00000014 ifdhandler.c:1821:IFDHICCPresence() usb:0424/1104:libusb-1.0:1:12:0 (lun: 0)
00000005 -> 000000 65 00 00 00 00 00 0A 00 00 00 
00000314 <- 000000 81 00 00 00 00 00 0A 01 00 01 
00000007 ifdhandler.c:1942:IFDHICCPresence() Card present
00000004 ifdhandler.c:1154:IFDHPowerICC() action: PowerUp, usb:0424/1104:libusb-1.0:1:12:0 (lun: 0)
00000004 -> 000000 62 00 00 00 00 00 0B 01 00 00 
00092345 <- 000000 80 17 00 00 00 00 0B 00 00 00 3B 9F 96 81 31 FE 45 80 65 54 43 12 21 08 31 C0 73 F6 21 80 81 05 9A 
00000015 winscard.c:329:SCardConnect() power up complete.
00000006 Card ATR: 3B 9F 96 81 31 FE 45 80 65 54 43 12 21 08 31 C0 73 F6 21 80 81 05 9A 
00000003 winscard.c:349:SCardConnect() powerState: POWER_STATE_INUSE
00000006 ATR: 3B 9F 96 81 31 FE 45 80 65 54 43 12 21 08 31 C0 73 F6 21 80 81 05 9A 
00000003 atrhandler.c:124:ATRDecodeAtr() TA1: 96, TB1: FFFFFFFF, TC1: FFFFFFFF, TD1: 81
00000002 atrhandler.c:154:ATRDecodeAtr() T=1 Protocol Found
00000003 atrhandler.c:124:ATRDecodeAtr() TA2: FFFFFFFF, TB2: FFFFFFFF, TC2: FFFFFFFF, TD2: 31
00000002 atrhandler.c:154:ATRDecodeAtr() T=1 Protocol Found
00000003 atrhandler.c:124:ATRDecodeAtr() TA3: FE, TB3: 45, TC3: FFFFFFFF, TD3: FFFFFFFF
00000002 atrhandler.c:222:ATRDecodeAtr() CurrentProtocol: 2, AvailableProtocols: 2
00000003 prothandler.c:108:PHSetProtocol() Attempting PTS to T=1
00000004 ifdhandler.c:692:IFDHSetProtocolParameters() protocol T=1, usb:0424/1104:libusb-1.0:1:12:0 (lun: 0)
00000003 ifdhandler.c:818:IFDHSetProtocolParameters() Set speed to 300000 bauds
00000002 ifdhandler.c:979:IFDHSetProtocolParameters() BWI/CWI (TB3) present: 0x45
00000006 ifdhandler.c:1013:IFDHSetProtocolParameters() IFSC (TA3) present: 254
00000003 ifdhandler.c:1017:IFDHSetProtocolParameters() Timeout: 2237 ms
00000002 commands.c:2251:SetParameters() length: 7 bytes
00000006 -> 000000 61 07 00 00 00 00 0C 01 00 00 96 10 00 45 00 FE 00 
00017346 <- 000000 82 07 00 00 00 00 0C 00 00 01 96 10 00 45 00 FE 00 
00000011 ifdhandler.c:1074:IFDHSetProtocolParameters() IFSC (TA3) present: 254
00000002 ifdhandler.c:1081:IFDHSetProtocolParameters() Negotiate IFSD at 254
00000003 sending: 00 C1 01 FE 3E 
00000003 -> 000000 6F 05 00 00 00 00 0D 00 00 00 00 C1 01 FE 3E 
00000966 <- 000000 80 04 00 00 00 00 0D 00 00 00 92 82 00 10 
00000005 received: 92 82 00 10 
00000002 sending: 00 C1 01 FE 3E 
00000003 -> 000000 6F 05 00 00 00 00 0E 00 00 00 00 C1 01 FE 3E 
00000769 <- 000000 80 04 00 00 00 00 0E 00 00 00 92 82 00 10 
00000005 received: 92 82 00 10 
00000002 sending: 00 C1 01 FE 3E 
00000003 -> 000000 6F 05 00 00 00 00 0F 00 00 00 00 C1 01 FE 3E 
00000767 <- 000000 80 04 00 00 00 00 0F 00 00 00 92 82 00 10 
00000005 received: 92 82 00 10 
00000002 prothandler.c:124:PHSetProtocol() PTS failed (612), using T=1
00000003 winscard.c:517:SCardConnect() UnrefReader() count was: 2
00000004 winscard_svc.c:507:ContextThread() CONNECT rv=0x80100066 for client 6
01447353 winscard_svc.c:359:ContextThread() Received command: RELEASE_CONTEXT from client 6
00000009 winscard.c:226:SCardReleaseContext() Releasing Context: 0x55646AFD
00000003 winscard_svc.c:470:ContextThread() RELEASE_CONTEXT rv=0x0 for client 6
00000121 winscard_svc.c:351:ContextThread() Client die: 6
00000012 winscard_svc.c:1013:MSGCleanupClient() Thread is stopping: dwClientID=6, threadContext @0x126f9b0
00000002 winscard_svc.c:1019:MSGCleanupClient() Freeing SCONTEXT @0x126f9b0


More information about the Pcsclite-muscle mailing list