Attachment 592642 Details for Bug 832983 – pcscd log

pcscd log

log.txt (text/plain), 10.53 KB, created by Manuel Bejarano on 2012-06-18 13:26:42 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Manuel Bejarano

Created: 2012-06-18 13:26:42 UTC

Size: 10.53 KB

patch

obsolete

>00000000 debuglog.c:269:DebugLogSetLevel() debug level=debug
>00000052 debuglog.c:298:DebugLogSetCategory() Debug options: APDU
>00000194 configfile.l:245:DBGetReaderListDir() Parsing conf directory: /etc/reader.conf.d
>00000022 configfile.l:257:DBGetReaderListDir() Skipping non regular file: .
>00000006 configfile.l:257:DBGetReaderListDir() Skipping non regular file: ..
>00000010 configfile.l:298:DBGetReaderList() Parsing conf file: /etc/reader.conf.d/libccidtwin
>00000065 pcscdaemon.c:518:main() pcsc-lite 1.8.3 daemon ready.
>00002904 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0001, path: /dev/bus/usb/003/001
>00000195 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0001, path: /dev/bus/usb/003/001
>00000206 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x0483, PID: 0x2016, path: /dev/bus/usb/003/002
>00000261 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0001, path: /dev/bus/usb/004/001
>00000252 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
>00000174 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
>00000230 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x17EF, PID: 0x1000, path: /dev/bus/usb/001/003
>00000193 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x046D, PID: 0xC52E, path: /dev/bus/usb/001/004
>00000184 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x046D, PID: 0xC52E, path: /dev/bus/usb/001/004
>00000302 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x046D, PID: 0xC52E, path: /dev/bus/usb/001/004
>00000177 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x17EF, PID: 0x1000, path: /dev/bus/usb/001/003
>00000280 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0001, path: /dev/bus/usb/005/001
>00000248 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0001, path: /dev/bus/usb/006/001
>00000256 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/002/001
>00000177 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/002/001
>00000202 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x046D, PID: 0x09A4, path: /dev/bus/usb/002/002
>00000186 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x046D, PID: 0x09A4, path: /dev/bus/usb/002/002
>00000186 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x046D, PID: 0x09A4, path: /dev/bus/usb/002/002
>00000185 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x046D, PID: 0x09A4, path: /dev/bus/usb/002/002
>06120469 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x072F, PID: 0x90CC, path: /dev/bus/usb/001/008
>00000023 hotplug_libudev.c:311:HPAddDevice() Adding USB device: ACS AET65
>00000081 readerfactory.c:936:RFInitializeReader() Attempting startup of ACS AET65 00 00 using /usr/lib64/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so
>00000299 readerfactory.c:826:RFBindFunctions() Loading IFD Handler 3.0
>00000048 ifdhandler.c:1768:init_driver() Driver version: 1.4.6
>00000912 ifdhandler.c:1785:init_driver() LogLevel: 0x0003
>00000016 ifdhandler.c:1796:init_driver() DriverOptions: 0x0000
>00000219 ifdhandler.c:1809:init_driver() LogLevel from LIBCCID_ifdLogLevel: 0x000F
>00000014 ifdhandler.c:83:CreateChannelByNameOrChannel() Lun: 0, device: usb:072f/90cc:libudev:0:/dev/bus/usb/001/008
>00000016 ccid_usb.c:180:OpenUSBByName() Reader index: 0, Device: usb:072f/90cc:libudev:0:/dev/bus/usb/001/008
>00000029 ccid_usb.c:212:OpenUSBByName() interface_number: 0
>00000813 ccid_usb.c:245:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau (ludovic.rousseau@free.fr)
>00000010 ccid_usb.c:246:OpenUSBByName() ifdProductString: Generic CCID driver
>00000011 ccid_usb.c:247:OpenUSBByName() Copyright: This driver is protected by terms of the GNU Lesser General Public License version 2.1, or (at your option) any later
>00002502 ccid_usb.c:365:OpenUSBByName() Checking device: 1/8
>00000008 ccid_usb.c:420:OpenUSBByName() Trying to open USB bus/device: 1/8
>00000349 ccid_usb.c:509:OpenUSBByName() Found Vendor/Product: 072F/90CC (ACS ACR 38U-CCID)
>00000043 ccid_usb.c:511:OpenUSBByName() Using USB bus/device: 1/8
>00000045 ccid_usb.c:1029:ControlUSB() request: 0x03
>00000390 receive: 
>00000012 ccid_usb.c:973:get_data_rates() IFD does not support GET_DATA_RATES request: 0
>00000950 ccid_usb.c:1078:InterruptRead() before (0)
>00002065 ccid_usb.c:1120:InterruptRead() after (0) (0)
>00000017 NotifySlotChange: 50 03 
>00000020 -> 000000 65 00 00 00 00 00 00 00 00 00 
>00000574 <- 000000 81 00 00 00 00 00 00 01 00 00 
>00000025 ifdhandler.c:353:IFDHGetCapabilities() tag: 0xFB3, usb:072f/90cc:libudev:0:/dev/bus/usb/001/008 (lun: 0)
>00000010 readerfactory.c:296:RFAddReader() Using the reader polling thread
>00000008 ifdhandler.c:1631:IFDHICCPresence() usb:072f/90cc:libudev:0:/dev/bus/usb/001/008 (lun: 0)
>00000013 -> 000000 65 00 00 00 00 00 01 00 00 00 
>00000570 <- 000000 81 00 00 00 00 00 01 01 00 00 
>00000245 ifdhandler.c:1749:IFDHICCPresence() Card present
>00000305 ifdhandler.c:353:IFDHGetCapabilities() tag: 0xFAE, usb:072f/90cc:libudev:0:/dev/bus/usb/001/008 (lun: 0)
>00000167 ifdhandler.c:441:IFDHGetCapabilities() Reader supports 1 slot(s)
>00000117 ifdhandler.c:1631:IFDHICCPresence() usb:072f/90cc:libudev:0:/dev/bus/usb/001/008 (lun: 0)
>00000083 -> 000000 65 00 00 00 00 00 02 00 00 00 
>00000696 <- 000000 81 00 00 00 00 00 02 01 00 00 
>00000065 ifdhandler.c:1749:IFDHICCPresence() Card present
>00000057 ifdhandler.c:1631:IFDHICCPresence() usb:072f/90cc:libudev:0:/dev/bus/usb/001/008 (lun: 0)
>00000059 -> 000000 65 00 00 00 00 00 03 00 00 00 
>00000570 <- 000000 81 00 00 00 00 00 03 01 00 00 
>00000062 ifdhandler.c:1749:IFDHICCPresence() Card present
>00000061 ifdhandler.c:1114:IFDHPowerICC() action: PowerUp, usb:072f/90cc:libudev:0:/dev/bus/usb/001/008 (lun: 0)
>00000060 -> 000000 62 00 00 00 00 00 04 01 00 00 
>00051115 <- 000000 80 13 00 00 00 00 04 00 00 00 3B BE 95 00 00 41 03 00 00 00 00 00 00 00 00 00 02 90 00 
>00000046 eventhandler.c:256:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
>00000012 Card ATR: 3B BE 95 00 00 41 03 00 00 00 00 00 00 00 00 00 02 90 00 
>00000010 ifdhandler.c:1631:IFDHICCPresence() usb:072f/90cc:libudev:0:/dev/bus/usb/001/008 (lun: 0)
>00000013 -> 000000 65 00 00 00 00 00 05 00 00 00 
>00000628 <- 000000 81 00 00 00 00 00 05 00 00 00 
>00000066 ifdhandler.c:1749:IFDHICCPresence() Card present
>00000047 ifdhandler.c:282:IFDHPolling() usb:072f/90cc:libudev:0:/dev/bus/usb/001/008 (lun: 0) 5000 ms
>00000040 ccid_usb.c:1078:InterruptRead() before (0)
>05000232 ccid_usb.c:1120:InterruptRead() after (0) (2)
>00000030 ifdhandler.c:1631:IFDHICCPresence() usb:072f/90cc:libudev:0:/dev/bus/usb/001/008 (lun: 0)
>00000017 -> 000000 65 00 00 00 00 00 06 00 00 00 
>00000876 <- 000000 81 00 00 00 00 00 06 00 00 00 
>00000019 ifdhandler.c:1749:IFDHICCPresence() Card present
>00000010 ifdhandler.c:1114:IFDHPowerICC() action: PowerDown, usb:072f/90cc:libudev:0:/dev/bus/usb/001/008 (lun: 0)
>00000012 -> 000000 63 00 00 00 00 00 07 00 00 00 
>00098913 <- 000000 81 00 00 00 00 00 07 01 00 00 
>00000030 eventhandler.c:446:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED
>00000013 ifdhandler.c:1631:IFDHICCPresence() usb:072f/90cc:libudev:0:/dev/bus/usb/001/008 (lun: 0)
>00000012 -> 000000 65 00 00 00 00 00 08 00 00 00 
>00000620 <- 000000 81 00 00 00 00 00 08 01 00 00 
>00000017 ifdhandler.c:1749:IFDHICCPresence() Card present
>00000012 ifdhandler.c:282:IFDHPolling() usb:072f/90cc:libudev:0:/dev/bus/usb/001/008 (lun: 0) 600000 ms
>00000009 ccid_usb.c:1078:InterruptRead() before (0)
>08155419 winscard_msg_srv.c:230:ProcessEventsServer() Common channel packet arrival
>00000043 winscard_msg_srv.c:242:ProcessEventsServer() ProcessCommonChannelRequest detects: 9
>00000038 pcscdaemon.c:93:SVCServiceRunLoop() A new context thread creation is requested: 9
>00000198 winscard_svc.c:297:ContextThread() Thread is started: dwClientID=9, threadContext @0x1d263e0
>00000109 winscard_svc.c:315:ContextThread() Received command: CMD_VERSION from client 9
>00000024 winscard_svc.c:327:ContextThread() Client is protocol version 4:2
>00000010 winscard_svc.c:347:ContextThread() CMD_VERSION rv=0x0 for client 9
>00000238 winscard_svc.c:315:ContextThread() Received command: ESTABLISH_CONTEXT from client 9
>00000033 winscard.c:193:SCardEstablishContext() Establishing Context: 0x10300F6
>00000009 winscard_svc.c:408:ContextThread() ESTABLISH_CONTEXT rv=0x0 for client 9
>00000065 winscard_svc.c:315:ContextThread() Received command: CMD_GET_READERS_STATE from client 9
>00000126 winscard_svc.c:315:ContextThread() Received command: RELEASE_CONTEXT from client 9
>00000027 winscard.c:204:SCardReleaseContext() Releasing Context: 0x10300F6
>00000012 winscard_svc.c:423:ContextThread() RELEASE_CONTEXT rv=0x0 for client 9
>00000195 winscard_svc.c:307:ContextThread() Client die: 9
>00000068 winscard_svc.c:918:MSGCleanupClient() Thread is stopping: dwClientID=9, threadContext @0x1d263e0
>00000046 winscard_svc.c:924:MSGCleanupClient() Freeing SCONTEXT @0x1d263e0
>02845550 winscard_msg_srv.c:230:ProcessEventsServer() Common channel packet arrival
>00000029 winscard_msg_srv.c:242:ProcessEventsServer() ProcessCommonChannelRequest detects: 9
>00000007 pcscdaemon.c:93:SVCServiceRunLoop() A new context thread creation is requested: 9
>00000066 winscard_svc.c:297:ContextThread() Thread is started: dwClientID=9, threadContext @0x1d263e0
>00000076 winscard_svc.c:315:ContextThread() Received command: CMD_VERSION from client 9
>00000016 winscard_svc.c:327:ContextThread() Client is protocol version 4:2
>00000007 winscard_svc.c:347:ContextThread() CMD_VERSION rv=0x0 for client 9
>00000175 winscard_svc.c:315:ContextThread() Received command: ESTABLISH_CONTEXT from client 9
>00000018 winscard.c:193:SCardEstablishContext() Establishing Context: 0x103DAA2
>00000006 winscard_svc.c:408:ContextThread() ESTABLISH_CONTEXT rv=0x0 for client 9
>00000043 winscard_svc.c:315:ContextThread() Received command: CMD_GET_READERS_STATE from client 9
>00000159 winscard_svc.c:315:ContextThread() Received command: RELEASE_CONTEXT from client 9
>00000017 winscard.c:204:SCardReleaseContext() Releasing Context: 0x103DAA2
>00000009 winscard_svc.c:423:ContextThread() RELEASE_CONTEXT rv=0x0 for client 9
>00000036 winscard_svc.c:307:ContextThread() Client die: 9
>00000023 winscard_svc.c:918:MSGCleanupClient() Thread is stopping: dwClientID=9, threadContext @0x1d263e0
>00000038 winscard_svc.c:924:MSGCleanupClient() Freeing SCONTEXT @0x1d263e0

Actions: View

Attachments on bug 832983: 592642 | 596290 | 596505 | 600628