Attachment 902524 Details for Bug 1079514 – detailed pcscd log

detailed pcscd log

log.txt (text/plain), 13.75 KB, created by Frank Ch. Eigler on 2014-06-05 12:11:32 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Frank Ch. Eigler

Created: 2014-06-05 12:11:32 UTC

Size: 13.75 KB

patch

obsolete

>00000000 debuglog.c:269:DebugLogSetLevel() debug level=debug
>00000016 debuglog.c:298:DebugLogSetCategory() Debug options: APDU
>00000405 configfile.l:245:DBGetReaderListDir() Parsing conf directory: /etc/reader.conf.d
>00000009 configfile.l:257:DBGetReaderListDir() Skipping non regular file: .
>00000000 configfile.l:257:DBGetReaderListDir() Skipping non regular file: ..
>00000003 configfile.l:298:DBGetReaderList() Parsing conf file: /etc/reader.conf.d/libccidtwin
>00000088 pcscdaemon.c:525:main() pcsc-lite 1.8.8 daemon ready.
>00001241 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/003/001
>00000038 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/003/001
>00000055 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1A7C, PID: 0x0068, path: /dev/bus/usb/003/004
>00000042 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/003/001
>00000052 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x05E3, PID: 0x0605, path: /dev/bus/usb/003/005
>00000046 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x0782, PID: 0x0002, path: /dev/bus/usb/003/006
>00000045 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x05E3, PID: 0x0605, path: /dev/bus/usb/003/005
>00000049 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x058F, PID: 0x9410, path: /dev/bus/usb/003/007
>00000044 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x058F, PID: 0x9410, path: /dev/bus/usb/003/007
>00000042 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x05E3, PID: 0x0605, path: /dev/bus/usb/003/005
>00000042 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/003/001
>00000045 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x058F, PID: 0x6362, path: /dev/bus/usb/003/002
>00000081 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0003, path: /dev/bus/usb/004/001
>00000061 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
>00000043 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
>00000046 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x8087, PID: 0x8008, path: /dev/bus/usb/001/002
>00000058 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/002/001
>00000042 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/002/001
>00000044 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x8087, PID: 0x8000, path: /dev/bus/usb/002/002
>03525530 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1050, PID: 0x0111, path: /dev/bus/usb/003/049
>00000008 hotplug_libudev.c:312:HPAddDevice() Adding USB device: Yubico Yubikey NEO OTP+CCID
>00000035 readerfactory.c:978:RFInitializeReader() Attempting startup of Yubico Yubikey NEO OTP+CCID 00 00 using /usr/lib64/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so
>00000103 readerfactory.c:868:RFBindFunctions() Loading IFD Handler 3.0
>00000012 ifdhandler.c:1840:init_driver() Driver version: 1.4.10
>00000237 ifdhandler.c:1857:init_driver() LogLevel: 0x0003
>00000002 ifdhandler.c:1868:init_driver() DriverOptions: 0x0000
>00000056 ifdhandler.c:1881:init_driver() LogLevel from LIBCCID_ifdLogLevel: 0x000F
>00000002 ifdhandler.c:83:CreateChannelByNameOrChannel() Lun: 0, device: usb:1050/0111:libudev:0:/dev/bus/usb/003/049
>00000003 ccid_usb.c:180:OpenUSBByName() Reader index: 0, Device: usb:1050/0111:libudev:0:/dev/bus/usb/003/049
>00000007 ccid_usb.c:212:OpenUSBByName() interface_number: 0
>00000001 ccid_usb.c:228:OpenUSBByName() Using: /usr/lib64/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist
>00000199 ccid_usb.c:246:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau (ludovic.rousseau@free.fr)
>00000001 ccid_usb.c:247:OpenUSBByName() ifdProductString: Generic CCID driver
>00000002 ccid_usb.c:248: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.
>00001878 ccid_usb.c:375:OpenUSBByName() Checking device: 3/49
>00000003 ccid_usb.c:430:OpenUSBByName() Trying to open USB bus/device: 3/49
>00000087 ccid_usb.c:499:OpenUSBByName() Found interface 0 but expecting 1
>00000002 ccid_usb.c:501:OpenUSBByName() Wrong interface for USB device 3/49. Checking next one.
>00000045 ifdhandler.c:117:CreateChannelByNameOrChannel() failed
>00000004 readerfactory.c:1009:RFInitializeReader() Open Port 0x200000 Failed (usb:1050/0111:libudev:0:/dev/bus/usb/003/049)
>00000010 readerfactory.c:312:RFAddReader() Yubico Yubikey NEO OTP+CCID init failed.
>00000005 readerfactory.c:529:RFRemoveReader() UnrefReader() count was: 1
>00000001 readerfactory.c:1029:RFUnInitializeReader() Attempting shutdown of Yubico Yubikey NEO OTP+CCID 00 00.
>00000002 readerfactory.c:905:RFUnloadReader() Unloading reader driver.
>00000092 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1050, PID: 0x0111, path: /dev/bus/usb/003/049
>00000003 hotplug_libudev.c:312:HPAddDevice() Adding USB device: Yubico Yubikey NEO OTP+CCID
>00000045 readerfactory.c:978:RFInitializeReader() Attempting startup of Yubico Yubikey NEO OTP+CCID 00 00 using /usr/lib64/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so
>00000082 readerfactory.c:868:RFBindFunctions() Loading IFD Handler 3.0
>00000012 ifdhandler.c:1840:init_driver() Driver version: 1.4.10
>00000260 ifdhandler.c:1857:init_driver() LogLevel: 0x0003
>00000003 ifdhandler.c:1868:init_driver() DriverOptions: 0x0000
>00000090 ifdhandler.c:1881:init_driver() LogLevel from LIBCCID_ifdLogLevel: 0x000F
>00000003 ifdhandler.c:83:CreateChannelByNameOrChannel() Lun: 0, device: usb:1050/0111:libudev:1:/dev/bus/usb/003/049
>00000012 ccid_usb.c:180:OpenUSBByName() Reader index: 0, Device: usb:1050/0111:libudev:1:/dev/bus/usb/003/049
>00000002 ccid_usb.c:212:OpenUSBByName() interface_number: 1
>00000002 ccid_usb.c:228:OpenUSBByName() Using: /usr/lib64/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist
>00000210 ccid_usb.c:246:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau (ludovic.rousseau@free.fr)
>00000003 ccid_usb.c:247:OpenUSBByName() ifdProductString: Generic CCID driver
>00000002 ccid_usb.c:248: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.
>00001512 ccid_usb.c:375:OpenUSBByName() Checking device: 3/49
>00000004 ccid_usb.c:430:OpenUSBByName() Trying to open USB bus/device: 3/49
>00000051 ccid_usb.c:521:OpenUSBByName() Found Vendor/Product: 1050/0111 (Yubico Yubikey NEO OTP+CCID)
>00000002 ccid_usb.c:523:OpenUSBByName() Using USB bus/device: 3/49
>00000002 ccid_usb.c:1041:ControlUSB() request: 0x03
>00000099 ccid_usb.c:1054:ControlUSB() control failed (3/49): -9 Resource temporarily unavailable
>00000005 ccid_usb.c:985:get_data_rates() IFD does not support GET_DATA_RATES request: -9
>00000215 ccid_usb.c:1090:InterruptRead() before (0)
>00007075 ccid_usb.c:1132:InterruptRead() after (0) (0)
>00000006 NotifySlotChange: 50 03 
>00000005 -> 000000 65 00 00 00 00 00 00 00 00 00 
>00000081 <- 000000 81 00 00 00 00 00 00 00 00 00 
>00000004 -> 000000 65 00 00 00 00 00 01 00 00 00 
>00000077 <- 000000 81 00 00 00 00 00 01 00 00 00 
>00000006 ifdhandler.c:358:IFDHGetCapabilities() tag: 0xFB3, usb:1050/0111:libudev:1:/dev/bus/usb/003/049 (lun: 0)
>00000002 readerfactory.c:332:RFAddReader() Using the reader polling thread
>00000002 ifdhandler.c:1703:IFDHICCPresence() usb:1050/0111:libudev:1:/dev/bus/usb/003/049 (lun: 0)
>00000003 -> 000000 65 00 00 00 00 00 02 00 00 00 
>00000100 <- 000000 81 00 00 00 00 00 02 00 00 00 
>00000003 ifdhandler.c:1821:IFDHICCPresence() Card present
>00000022 ifdhandler.c:358:IFDHGetCapabilities() tag: 0xFAE, usb:1050/0111:libudev:1:/dev/bus/usb/003/049 (lun: 0)
>00000002 ifdhandler.c:446:IFDHGetCapabilities() Reader supports 1 slot(s)
>00000014 ifdhandler.c:1703:IFDHICCPresence() usb:1050/0111:libudev:1:/dev/bus/usb/003/049 (lun: 0)
>00000008 -> 000000 65 00 00 00 00 00 03 00 00 00 
>00000117 <- 000000 81 00 00 00 00 00 03 00 00 00 
>00000003 ifdhandler.c:1821:IFDHICCPresence() Card present
>00000001 ifdhandler.c:1703:IFDHICCPresence() usb:1050/0111:libudev:1:/dev/bus/usb/003/049 (lun: 0)
>00000002 -> 000000 65 00 00 00 00 00 04 00 00 00 
>00000068 <- 000000 81 00 00 00 00 00 04 00 00 00 
>00000004 ifdhandler.c:1821:IFDHICCPresence() Card present
>00000004 ifdhandler.c:1122:IFDHPowerICC() action: PowerUp, usb:1050/0111:libudev:1:/dev/bus/usb/003/049 (lun: 0)
>00000002 -> 000000 62 00 00 00 00 00 05 00 00 00 
>00006781 <- 000000 80 14 00 00 00 00 05 00 00 00 3B FA 13 00 00 81 31 FE 15 59 75 62 69 6B 65 79 4E 45 4F A6 
>00000008 eventhandler.c:256:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
>00000002 Card ATR: 3B FA 13 00 00 81 31 FE 15 59 75 62 69 6B 65 79 4E 45 4F A6 
>00000001 ifdhandler.c:1703:IFDHICCPresence() usb:1050/0111:libudev:1:/dev/bus/usb/003/049 (lun: 0)
>00000002 -> 000000 65 00 00 00 00 00 06 00 00 00 
>00000079 <- 000000 81 00 00 00 00 00 06 00 00 00 
>00000002 ifdhandler.c:1821:IFDHICCPresence() Card present
>00000001 ifdhandler.c:287:IFDHPolling() usb:1050/0111:libudev:1:/dev/bus/usb/003/049 (lun: 0) 5000 ms
>00000001 ccid_usb.c:1090:InterruptRead() before (0)
>01456456 ccid_usb.c:1132:InterruptRead() after (0) (5)
>00000011 ccid_usb.c:1147:InterruptRead() InterruptRead (3/49): Resource temporarily unavailable
>00000371 hotplug_libudev.c:587:HPEstablishUSBNotifications() Device removed
>00000374 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/003/001
>00000076 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/003/001
>00000071 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1A7C, PID: 0x0068, path: /dev/bus/usb/003/004
>00000046 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/003/001
>00000060 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x05E3, PID: 0x0605, path: /dev/bus/usb/003/005
>00000080 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x0782, PID: 0x0002, path: /dev/bus/usb/003/006
>00000065 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x05E3, PID: 0x0605, path: /dev/bus/usb/003/005
>00000065 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x058F, PID: 0x9410, path: /dev/bus/usb/003/007
>00000041 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x058F, PID: 0x9410, path: /dev/bus/usb/003/007
>00000059 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x05E3, PID: 0x0605, path: /dev/bus/usb/003/005
>00000057 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/003/001
>00000041 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x058F, PID: 0x6362, path: /dev/bus/usb/003/002
>00000054 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0003, path: /dev/bus/usb/004/001
>00000053 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
>00000037 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
>00000040 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x8087, PID: 0x8008, path: /dev/bus/usb/001/002
>00000051 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/002/001
>00000036 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/002/001
>00000040 hotplug_libudev.c:260:get_driver() Looking for a driver for VID: 0x8087, PID: 0x8000, path: /dev/bus/usb/002/002
>00000006 hotplug_libudev.c:513:HPRescanUsbBus() Removing USB device[0]: Yubico Yubikey NEO OTP+CCID at /dev/bus/usb/003/049
>00000004 hotplug_libudev.c:513:HPRescanUsbBus() Removing USB device[1]: Yubico Yubikey NEO OTP+CCID at /dev/bus/usb/003/049
>00000002 readerfactory.c:529:RFRemoveReader() UnrefReader() count was: 1
>00000001 eventhandler.c:148:EHDestroyEventHandler() Stomping thread.
>00000002 ifdhandler.c:358:IFDHGetCapabilities() tag: 0xFB1, usb:1050/0111:libudev:1:/dev/bus/usb/003/049 (lun: 0)
>00000001 ifdhandler.c:358:IFDHGetCapabilities() tag: 0xFB2, usb:1050/0111:libudev:1:/dev/bus/usb/003/049 (lun: 0)
>00000001 eventhandler.c:173:EHDestroyEventHandler() Request stopping of polling thread
>00000001 ifdhandler.c:323:IFDHStopPolling() usb:1050/0111:libudev:1:/dev/bus/usb/003/049 (lun: 0)
>00398346 ifdhandler.c:1703:IFDHICCPresence() usb:1050/0111:libudev:1:/dev/bus/usb/003/049 (lun: 0)
>00000008 -> 000000 65 00 00 00 00 00 07 00 00 00 
>00000021 ccid_usb.c:660:WriteUSB() write failed (3/49): -4 No such device
>00000002 ifdwrapper.c:348:IFDStatusICC() Card not transacted: 617
>00000016 utils.c:68:SendHotplugSignal() Send hotplug signal to pcscd (pid=26617)
>01000069 eventhandler.c:446:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED
>00000007 eventhandler.c:469:EHStatusHandlerThread() Die
>00000103 eventhandler.c:188:EHDestroyEventHandler() Thread stomped.
>00000006 readerfactory.c:1029:RFUnInitializeReader() Attempting shutdown of Yubico Yubikey NEO OTP+CCID 00 00.
>00000005 ifdhandler.c:249:IFDHCloseChannel() usb:1050/0111:libudev:1:/dev/bus/usb/003/049 (lun: 0)
>00000014 -> 000000 63 00 00 00 00 00 08 00 00 00 
>00000014 ccid_usb.c:660:WriteUSB() write failed (3/49): -4 No such device
>00000003 ccid_usb.c:742:CloseUSB() Closing USB device: 3/49
>00000001 ccid_usb.c:763:CloseUSB() Last slot closed. Release resources
>00000022 readerfactory.c:905:RFUnloadReader() Unloading reader driver.
>00000061 hotplug_libudev.c:587:HPEstablishUSBNotifications() Device removed

Actions: View

Attachments on bug 1079514: 902524 | 902525 | 902987