Yubikey init failed

Robin Lambertz <[email protected]> Tue, 14 Feb 2017 01:53:22 +0100

Newsgroups	gmane.comp.lib.muscle
Message-ID	<[email protected]>

Hello,

I'm trying to get my Yubikey NEO to work with GPG in an archlinux VM on 
Qubes OS. Unfortunately, it seems that PCSCD is unable to work with my 
yubikey, it doesn't appear when running pcsc_scan.

I started pcscd with `sudo LIBCCID_ifdLogLevel=0x000F pcscd --foreground 
--debug --apdu --color | tee log.txt` to get more info about where the 
problem could come from. The full logs are attached, but the interesting 
bits are here :

```
00000206 ccid_usb.c:621:OpenUSBByName() Found Vendor/Product: 1050/0111 
(Yubico Yubikey NEO OTP+CCID)
00000012 ccid_usb.c:623:OpenUSBByName() Using USB bus/device: 2/4
00000010 ccid_usb.c:680:OpenUSBByName() bNumDataRatesSupported is 0
00001997 ccid_usb.c:1244:InterruptRead() before (0)
00103904 ccid_usb.c:1290:InterruptRead() after (0) (2)
00000072 -> 000000 65 00 00 00 00 00 00 00 00 00
00002614 <- 000000 81 00 00 00 00 00 00 00 00 00
00000050 -> 000000 65 00 00 00 00 00 01 00 00 00
00103063 ccid_usb.c:836:ReadUSB() read failed (2/4): -7 LIBUSB_ERROR_TIMEOUT
00000224 -> 000000 65 00 00 00 00 00 02 00 00 00
05002241 ccid_usb.c:797:WriteUSB() write failed (2/4): -7 
LIBUSB_ERROR_TIMEOUT
00000242 ifdhandler.c:188:CreateChannelByNameOrChannel() failed
00000159 ccid_usb.c:879:CloseUSB() Closing USB device: 2/4
00000151 ccid_usb.c:889:CloseUSB() Last slot closed. Release resources
00000240 ccid_usb.c:189:close_libusb_if_needed() libusb_exit
00000476 readerfactory.c:1110:RFInitializeReader() Open Port 0x200000 
Failed (usb:1050/0111:libudev:1:/dev/bus/usb/002/004)
00000161 readerfactory.c:375:RFAddReader() Yubico Yubikey NEO OTP+CCID 
init failed.
```

ReadUSB returns immediately with the TIMEOUT error (isn't that weird ?), 
while the WriteUSB times out after 5 seconds. I'm not sure what to do to 
further debug this. Any hint as to what I could do to figure out where 
the issue is coming from ?

Additional info :

# Versions

- CCID driver version : 1.4.25

- pcsc-lite version : 1.8.20

- smart card reader : Yubico Yubikey NEO OTP+CCID

- output of /usr/sbin/pcscd --version :
```
pcsc-lite version 1.8.20.
Copyright (C) 1999-2002 by David Corcoran <[email protected]>.
Copyright (C) 2001-2015 by Ludovic Rousseau <[email protected]>.
Copyright (C) 2003-2004 by Damien Sauveron <[email protected]>.
Report bugs to <[email protected]>.
Enabled features: Linux x86_64-pc-linux-gnu serial usb libudev 
usbdropdir=/usr/lib/pcsc/drivers ipcdir=/run/pcscd 
configdir=/etc/reader.conf.d
```

- OS: ArchLinux in a VM, kernel version 4.4.38-11.pvops.qubes.x86_64

_______________________________________________
Pcsclite-muscle mailing list
[email protected]
http://lists.alioth.debian.org/cgi-bin/mailman/listinfo/pcsclite-muscle

log.txt (text/plain, 7.9 KB)

00000000 debuglog.c:289:DebugLogSetLevel() debug level=debug
00000275 debuglog.c:310:DebugLogSetCategory() Debug options: APDU
[36m00000029[0m [34mpcscdaemon.c:351:main() Force colored logs[0m
[36m00000428[0m configfile.l:282:DBGetReaderListDir() Parsing conf directory: /etc/reader.conf.d
[36m00000063[0m configfile.l:319:DBGetReaderListDir() Skipping non regular file: ..
[36m00000014[0m configfile.l:319:DBGetReaderListDir() Skipping non regular file: .
[36m00000013[0m configfile.l:358:DBGetReaderList() Parsing conf file: /etc/reader.conf.d/libccidtwin
[36m00000201[0m [34mpcscdaemon.c:655:main() pcsc-lite 1.8.20 daemon ready.[0m
[36m00006163[0m hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
[36m00000661[0m hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/002/001
[36m13709193[0m [34mhotplug_libudev.c:648:HPEstablishUSBNotifications() USB Device add[0m
[36m00000196[0m hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x1050, PID: 0x0111, path: /dev/bus/usb/002/004
[36m00000014[0m [34mhotplug_libudev.c:433:HPAddDevice() Adding USB device: Yubico Yubikey NEO OTP+CCID[0m
[36m00000060[0m [34mreaderfactory.c:1079:RFInitializeReader() Attempting startup of Yubico Yubikey NEO OTP+CCID 00 00 using /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so[0m
[36m00049489[0m [34mreaderfactory.c:954:RFBindFunctions() Loading IFD Handler 3.0[0m
[36m00000115[0m [34mifdhandler.c:1953:init_driver() Driver version: 1.4.25[0m
[36m00000818[0m [34mifdhandler.c:1970:init_driver() LogLevel: 0x0003[0m
[36m00000033[0m [34mifdhandler.c:1981:init_driver() DriverOptions: 0x0000[0m
[36m00000164[0m [34mifdhandler.c:1994:init_driver() LogLevel from LIBCCID_ifdLogLevel: 0x000F[0m
[36m00000011[0m [34mifdhandler.c:110:CreateChannelByNameOrChannel() Lun: 0, device: usb:1050/0111:libudev:0:/dev/bus/usb/002/004[0m
[36m00000009[0m ccid_usb.c:237:OpenUSBByName() Reader index: 0, Device: usb:1050/0111:libudev:0:/dev/bus/usb/002/004
[36m00000030[0m ccid_usb.c:269:OpenUSBByName() interface_number: 0
[36m00000042[0m ccid_usb.c:270:OpenUSBByName() usb bus/device: 2/4
[36m00000035[0m [34mccid_usb.c:287:OpenUSBByName() Using: /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist[0m
[36m00000474[0m [34mccid_usb.c:305:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau ([email protected])[0m
[36m00000010[0m [34mccid_usb.c:306:OpenUSBByName() ifdProductString: Generic CCID driver[0m
[36m00000007[0m [34mccid_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.[0m
[36m00001679[0m ccid_usb.c:391:OpenUSBByName() Try device: 2/4
[36m00000016[0m ccid_usb.c:401:OpenUSBByName() vid/pid : 1050/0111
[36m00000005[0m ccid_usb.c:448:OpenUSBByName() Checking device: 2/4
[36m00000004[0m ccid_usb.c:519:OpenUSBByName() Trying to open USB bus/device: 2/4
[36m00000085[0m [34mccid_usb.c:599:OpenUSBByName() Found interface 1 but expecting 0[0m
[36m00000051[0m [34mccid_usb.c:601:OpenUSBByName() Wrong interface for USB device 2/4. Checking next one.[0m
[36m00000081[0m [34mccid_usb.c:189:close_libusb_if_needed() libusb_exit[0m
[36m00000147[0m [34mccid_usb.c:749:OpenUSBByName() Device not found?[0m
[36m00000014[0m [01;31mifdhandler.c:144:CreateChannelByNameOrChannel() failed[0m
[36m00000014[0m [01;31mreaderfactory.c:1110:RFInitializeReader() Open Port 0x200000 Failed (usb:1050/0111:libudev:0:/dev/bus/usb/002/004)[0m
[36m00000008[0m [35mreaderfactory.c:375:RFAddReader() Yubico Yubikey NEO OTP+CCID init failed.[0m
[36m00000013[0m readerfactory.c:608:RFRemoveReader() UnrefReader() count was: 1
[36m00000015[0m [34mreaderfactory.c:1130:RFUnInitializeReader() Attempting shutdown of Yubico Yubikey NEO OTP+CCID 00 00.[0m
[36m00000005[0m [34mreaderfactory.c:991:RFUnloadReader() Unloading reader driver.[0m
[36m00000232[0m [34mhotplug_libudev.c:648:HPEstablishUSBNotifications() USB Device add[0m
[36m00000200[0m hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x1050, PID: 0x0111, path: /dev/bus/usb/002/004
[36m00000018[0m [34mhotplug_libudev.c:433:HPAddDevice() Adding USB device: Yubico Yubikey NEO OTP+CCID[0m
[36m00000074[0m [34mreaderfactory.c:1079:RFInitializeReader() Attempting startup of Yubico Yubikey NEO OTP+CCID 00 00 using /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so[0m
[36m00000435[0m [34mreaderfactory.c:954:RFBindFunctions() Loading IFD Handler 3.0[0m
[36m00000047[0m [34mifdhandler.c:1953:init_driver() Driver version: 1.4.25[0m
[36m00000703[0m [34mifdhandler.c:1970:init_driver() LogLevel: 0x0003[0m
[36m00000016[0m [34mifdhandler.c:1981:init_driver() DriverOptions: 0x0000[0m
[36m00000223[0m [34mifdhandler.c:1994:init_driver() LogLevel from LIBCCID_ifdLogLevel: 0x000F[0m
[36m00000014[0m [34mifdhandler.c:110:CreateChannelByNameOrChannel() Lun: 0, device: usb:1050/0111:libudev:1:/dev/bus/usb/002/004[0m
[36m00000012[0m ccid_usb.c:237:OpenUSBByName() Reader index: 0, Device: usb:1050/0111:libudev:1:/dev/bus/usb/002/004
[36m00000016[0m ccid_usb.c:269:OpenUSBByName() interface_number: 1
[36m00000007[0m ccid_usb.c:270:OpenUSBByName() usb bus/device: 2/4
[36m00000008[0m [34mccid_usb.c:287:OpenUSBByName() Using: /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist[0m
[36m00000893[0m [34mccid_usb.c:305:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau ([email protected])[0m
[36m00000024[0m [34mccid_usb.c:306:OpenUSBByName() ifdProductString: Generic CCID driver[0m
[36m00000015[0m [34mccid_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.[0m
[36m00003468[0m ccid_usb.c:391:OpenUSBByName() Try device: 2/4
[36m00000030[0m ccid_usb.c:401:OpenUSBByName() vid/pid : 1050/0111
[36m00000013[0m ccid_usb.c:448:OpenUSBByName() Checking device: 2/4
[36m00000020[0m ccid_usb.c:519:OpenUSBByName() Trying to open USB bus/device: 2/4
[36m00000206[0m [34mccid_usb.c:621:OpenUSBByName() Found Vendor/Product: 1050/0111 (Yubico Yubikey NEO OTP+CCID)[0m
[36m00000012[0m [34mccid_usb.c:623:OpenUSBByName() Using USB bus/device: 2/4[0m
[36m00000010[0m [34mccid_usb.c:680:OpenUSBByName() bNumDataRatesSupported is 0[0m
[36m00001997[0m ccid_usb.c:1244:InterruptRead() before (0)
[36m00103904[0m ccid_usb.c:1290:InterruptRead() after (0) (2)
[36m00000072[0m -> 000000 65 00 00 00 00 00 00 00 00 00 
[36m00002614[0m <- 000000 81 00 00 00 00 00 00 00 00 00 
[36m00000050[0m -> 000000 65 00 00 00 00 00 01 00 00 00 
[36m00103063[0m [01;31mccid_usb.c:836:ReadUSB() read failed (2/4): -7 LIBUSB_ERROR_TIMEOUT[0m
[36m00000224[0m -> 000000 65 00 00 00 00 00 02 00 00 00 
[36m05002241[0m [01;31mccid_usb.c:797:WriteUSB() write failed (2/4): -7 LIBUSB_ERROR_TIMEOUT[0m
[36m00000242[0m [01;31mifdhandler.c:188:CreateChannelByNameOrChannel() failed[0m
[36m00000159[0m ccid_usb.c:879:CloseUSB() Closing USB device: 2/4
[36m00000151[0m ccid_usb.c:889:CloseUSB() Last slot closed. Release resources
[36m00000240[0m [34mccid_usb.c:189:close_libusb_if_needed() libusb_exit[0m
[36m00000476[0m [01;31mreaderfactory.c:1110:RFInitializeReader() Open Port 0x200000 Failed (usb:1050/0111:libudev:1:/dev/bus/usb/002/004)[0m
[36m00000161[0m [35mreaderfactory.c:375:RFAddReader() Yubico Yubikey NEO OTP+CCID init failed.[0m
[36m00000133[0m readerfactory.c:608:RFRemoveReader() UnrefReader() count was: 1
[36m00000127[0m [34mreaderfactory.c:1130:RFUnInitializeReader() Attempting shutdown of Yubico Yubikey NEO OTP+CCID 00 00.[0m
[36m00000123[0m [34mreaderfactory.c:991:RFUnloadReader() Unloading reader driver.[0m
[36m00000695[0m [35mhotplug_libudev.c:520:HPAddDevice() Failed adding USB device: Yubico Yubikey NEO OTP+CCID[0m