From owner-freebsd-usb@FreeBSD.ORG Thu Jul 21 14:03:09 2005 Return-Path: X-Original-To: freebsd-usb@freebsd.org Delivered-To: freebsd-usb@freebsd.org Received: from mx1.FreeBSD.org (mx1.freebsd.org [216.136.204.125]) by hub.freebsd.org (Postfix) with ESMTP id 01A2416A4D6; Thu, 21 Jul 2005 14:03:09 +0000 (GMT) (envelope-from mohacsi@scone.ki.iif.hu) Received: from scone.ki.iif.hu (scone.ki.iif.hu [193.6.222.31]) by mx1.FreeBSD.org (Postfix) with ESMTP id 722D843D5C; Thu, 21 Jul 2005 14:03:05 +0000 (GMT) (envelope-from mohacsi@scone.ki.iif.hu) Received: (from mohacsi@localhost) by scone.ki.iif.hu (8.13.4/8.13.4) id j6LE30X6001116; Thu, 21 Jul 2005 16:03:00 +0200 (CEST) (envelope-from mohacsi) Date: Thu, 21 Jul 2005 16:03:00 +0200 (CEST) Message-Id: <200507211403.j6LE30X6001116@scone.ki.iif.hu> To: FreeBSD-gnats-submit@freebsd.org From: Janos Mohacsi X-send-pr-version: 3.113 X-GNATS-Notify: Cc: freebsd-usb@freebsd.org Subject: Communication problem between opensc/openct via USB with e-gate smart-card. X-BeenThere: freebsd-usb@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list Reply-To: Janos Mohacsi List-Id: FreeBSD support for USB List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Thu, 21 Jul 2005 14:03:09 -0000 >Submitter-Id: current-users >Originator: Janos Mohacsi >Organization: NIIF/HUNGARNET >Confidential: no >Synopsis: Communication problem between opensc/openct via USB with e-gate smart-card. >Severity: non-critical >Priority: low >Category: usb >Class: sw-bug >Release: FreeBSD 7.0-CURRENT i386 >Environment: System: FreeBSD scone.ki.iif.hu 7.0-CURRENT FreeBSD 7.0-CURRENT #2: Thu Jul 21 12:52:16 CEST 2005 root@scone.ki.iif.hu:/usr/obj/usr/src/sys/SCONE i386 >Description: I tried to used opensc 0.9.6 with openct 0.6.5 on FreeBSD 6.0 (and later FreeBSD 7.0-CURRENT.). To be able to understand this is the layering structure of different components: [opensc - provides pkcs11 interface]------\ | \ [openct - interface several smart-card] \ | | \ (usb interface) (serial interface) (pcsc-lite interface) | (usb) I have problem with the usb interface as described in the thread http://opensc.org/pipermail/opensc-user/2005-July/000258.html The opensc experts and developers believe the problem is lying in the FreeBSD kernel... Therefore I compiled a kernel with USB_DEBUG. and set sysctl hw.usb.ugen.debug. I think this problem is similar to http://www.freebsd.org/cgi/query-pr.cgi?pr=kern/71417 I am willing to debug it if somebedy can give me a helping hand..... debug log output with some comments: Startup of the kernel mohacsi@scone> sudo dmesg -a |grep usb uhci0: port 0xbf80-0xbf9f irq 11 at device 29.0 on pci0 usb0: on uhci0 usb0: USB revision 1.0 uhci1: port 0xbf40-0xbf5f irq 11 at device 29.1 on pci0 usb1: on uhci1 usb1: USB revision 1.0 uhci2: port 0xbf20-0xbf3f irq 11 at device 29.2 on pci0 usb2: on uhci2 usb2: USB revision 1.0 pci0: at device 29.7 (no driver attached) ums0: Logitech USB Mouse, rev 1.10/6.20, addr 2, iclass 3/1 Starting usbd. Startup of openct - no smart-card attached. ifd_driver_add_id: ifd_driver_add_id(usb:0973/0001, egate) ifd_driver_add_id: ifd_driver_add_id(usb:0529/050c, etoken) ifd_driver_add_id: ifd_driver_add_id(usb:0529/0514, etoken) ifd_driver_add_id: ifd_driver_add_id(usb:073d/0005, eutron) ifd_driver_add_id: ifd_driver_add_id(usb:04b9/1202, ikey2k) ifd_driver_add_id: ifd_driver_add_id(usb:04b9/1300, ikey3k) ifd_driver_add_id: ifd_driver_add_id(usb:08e6/3437, ccid) ifd_driver_add_id: ifd_driver_add_id(usb:08e6/3438, ccid) ifd_driver_add_id: ifd_driver_add_id(usb:08e6/4433, ccid) ifd_driver_add_id: ifd_driver_add_id(usb:04e6/5115, ccid) ifd_driver_add_id: ifd_driver_add_id(usb:04e6/E001, ccid) ifd_driver_add_id: ifd_driver_add_id(usb:04e6/E003, ccid) ifd_driver_add_id: ifd_driver_add_id(usb:076b/3021, ccid) ifd_driver_add_id: ifd_driver_add_id(usb:076b/5121, ccid) ifd_driver_add_id: ifd_driver_add_id(usb:0783/0003, ccid) ifd_scan_usb: BSD: ifd_scan_usb Attaching the smart-card. mohacsi@scone> sudo dmesg -a | grep -i ugen ugen0: SchlumbergerSema SchlumbergerSema Cryptoflex e-gate, rev 1.10/1.00, addr 2 ugen_set_config: ugen0 to configno 1, sc=0xc2389000 ugen_set_config: ifaceno 0 ugen_set_config: ifaceno 0 Starting the openct framework. mohacsi@scone> sudo /usr/local/etc/rc.d/openct.sh start Starting smart card terminal framework: OpenCTDebug: ifd_driver_add_id: ifd_driver_add_id(usb:0973/0001, egate) Debug: ifd_driver_add_id: ifd_driver_add_id(usb:0529/050c, etoken) Debug: ifd_driver_add_id: ifd_driver_add_id(usb:0529/0514, etoken) Debug: ifd_driver_add_id: ifd_driver_add_id(usb:073d/0005, eutron) Debug: ifd_driver_add_id: ifd_driver_add_id(usb:04b9/1202, ikey2k) Debug: ifd_driver_add_id: ifd_driver_add_id(usb:04b9/1300, ikey3k) Debug: ifd_driver_add_id: ifd_driver_add_id(usb:08e6/3437, ccid) Debug: ifd_driver_add_id: ifd_driver_add_id(usb:08e6/3438, ccid) Debug: ifd_driver_add_id: ifd_driver_add_id(usb:08e6/4433, ccid) Debug: ifd_driver_add_id: ifd_driver_add_id(usb:04e6/5115, ccid) Debug: ifd_driver_add_id: ifd_driver_add_id(usb:04e6/E001, ccid) Debug: ifd_driver_add_id: ifd_driver_add_id(usb:04e6/E003, ccid) Debug: ifd_driver_add_id: ifd_driver_add_id(usb:076b/3021, ccid) Debug: ifd_driver_add_id: ifd_driver_add_id(usb:076b/5121, ccid) Debug: ifd_driver_add_id: ifd_driver_add_id(usb:0783/0003, ccid) Debug: ifd_scan_usb: BSD: ifd_scan_usb Debug: ifd_scan_usb: BSD: ifd_scan_usb: ifd_driver_for(SchlumbergerSema[0x0973].SchlumbergerSema Cryptoflex e-gate[0x0001) Debug: ifd_spawn_handler: driver=egate, device=/dev/ugen0, index=-1 . e-gate smart card found! mohacsi@scone> dmesg -a | grep -i ugen ugenopen: flag=2051, mode=8192, unit=0 endpt=0 ATR command succesful form openct-tool. mohacsi@scone> sudo openct-tool atr Detected Schlumberger E-Gate Card present, status changed ATR: 3b 95 18 40 ff 62 01 02 01 04 the kernel messages from ugen: ugenioctl: cmd=80045572 ugenioctl: cmd=c018556f ugenioctl: cmd=80045572 ugenioctl: cmd=c018556f ugenioctl: cmd=80045572 ugenioctl: cmd=c018556f opensc-tool -a already fails... mohacsi@scone> sudo opensc-tool -a 3B 95 18 40 FF 62 01 02 01 04 ;..@.b.... card.c:203:sc_transceive: Unable to transmit: Generic reader error card.c:238:sc_transmit_apdu: transceive() failed: Generic reader error card-flex.c:1316:flex_logout: APDU transmit failed: Generic reader error kernel messages from ugen: ugenioctl: cmd=80045572 ugenioctl: cmd=c018556f ugenioctl: cmd=80045572 ugenioctl: cmd=c018556f ugenioctl: cmd=80045572 ugenioctl: cmd=c018556f ugenioctl: cmd=80045572 ugenioctl: cmd=c018556f ugenioctl: cmd=80045572 ugenioctl: cmd=c018556f p15dump also fails: mohacsi@scone> sudo ./p15dump Using libopensc version 0.9.6. Card detected in reader 'Schlumberger E-Gate' Connecting... connected. ATR = 3B:95:18:40:FF:62:01:02:01:04 Looking for a PKCS#15 compatible Smart Card... pkcs15.c:480:sc_pkcs15_bind_internal: unable to enumerate apps: Generic reader error pkcs15.c:647:sc_pkcs15_bind: returning with: Wrong card failed: Wrong card kernel messages: ugenioctl: cmd=80045572 ugenioctl: cmd=c018556f ugenioctl: cmd=80045572 ugenioctl: cmd=c018556f ugenioctl: cmd=80045572 ugenioctl: cmd=c018556f ugenioctl: cmd=80045572 ugenioctl: cmd=c018556f ugenioctl: cmd=80045572 ugenioctl: cmd=c018556f debug messages: mohacsi@scone> cat /var/log/debug.log Jul 21 12:34:39 scone ifdhandler[677]: ifd_open: trying to open egate@/dev/ugen0 Jul 21 12:34:39 scone ifdhandler[677]: eg_open: device=/dev/ugen0 Jul 21 12:34:39 scone ifdhandler[677]: ifd_sysdep_device_type: BSD: ifd_sysdep_device_type(/dev/ugen0) Jul 21 12:34:39 scone ifdhandler[677]: ifd_sysdep_device_type: BSD: returning IFD_DEVICE_TYPE_USB Jul 21 12:34:39 scone ifdhandler[677]: eg_activate: called. Jul 21 12:34:39 scone ifdhandler[677]: eg_card_status: slot=0 Jul 21 12:34:39 scone ifdhandler[677]: ifdhandler_poll_presence: card status change: 0 -> 1 Jul 21 12:34:40 scone ifdhandler[677]: eg_card_status: slot=0 Jul 21 12:35:01 scone last message repeated 21 times Jul 21 12:35:01 scone ifdhandler[677]: ifdhandler_process: ifdhandler_process(cmd=CT_CMD_LOCK, unit=0) Jul 21 12:35:01 scone ifdhandler[677]: ifdhandler_lock: granted shared lock 0 for slot 0 by uid=4294967294 Jul 21 12:35:01 scone ifdhandler[677]: ifdhandler_process: ifdhandler_process(cmd=CT_CMD_RESET, unit=0) Jul 21 12:35:01 scone ifdhandler[677]: eg_card_reset: called. Jul 21 12:35:01 scone ifdhandler[677]: ifd_usb_control: usb req type=x40 req=x90 val=x0000 ind=x0000 len=0 Jul 21 12:35:01 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ifd_sysdep_usb_control(0x90) Jul 21 12:35:01 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL bmRequestType 0x40 bRequest 0x90 wValue 0x0 wIndex 0x0 wLength 0x0 Jul 21 12:35:01 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ctrl.ucr_data == NULL Jul 21 12:35:01 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ifd_sysdep_usb_control(0xa0) Jul 21 12:35:01 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL bmRequestType 0xc0 bRequest 0xa0 wValue 0x0 wIndex 0x0 wLength 0x1 Jul 21 12:35:01 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL SEND data a8 Jul 21 12:35:01 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL RECV data 00 Jul 21 12:35:01 scone ifdhandler[677]: ifd_usb_control: usb req type=xc0 req=xa0 val=x0000 ind=x0000 len=1 Jul 21 12:35:01 scone ifdhandler[677]: ifd_usb_control: recv 00 Jul 21 12:35:01 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ifd_sysdep_usb_control(0x83) Jul 21 12:35:01 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL bmRequestType 0xc0 bRequest 0x83 wValue 0x0 wIndex 0x0 wLength 0x23 Jul 21 12:35:01 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL SEND data 01 00 00 00 14 ac bf bf 00 01 07 28 81 23 05 01 64 ca 56 0d 66 84 07 28 00 01 07 28 b0 ab bf bf 05 00 00 Jul 21 12:35:01 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL RECV data 3b 95 18 40 ff 62 01 02 01 04 Jul 21 12:35:01 scone ifdhandler[677]: ifd_usb_control: usb req type=xc0 req=x83 val=x0000 ind=x0000 len=10 Jul 21 12:35:01 scone ifdhandler[677]: ifd_usb_control: recv 3b 95 18 40 ff 62 01 02 01 04 Jul 21 12:35:01 scone ifdhandler[677]: ifd_protocol_select: atr= 3b 95 18 40 ff 62 01 02 01 04 Jul 21 12:35:01 scone ifdhandler[677]: ifd_protocol_select: default T=0, supported protocols=0x1 Jul 21 12:35:01 scone ifdhandler[677]: eg_set_protocol: proto=0 Jul 21 12:35:01 scone ifdhandler[677]: ifdhandler_process: ifdhandler_process(cmd=CT_CMD_UNLOCK, unit=0) Jul 21 12:35:01 scone ifdhandler[677]: ifdhandler_unlock: released shared lock 0 for slot 0 by uid=4294967294 Jul 21 12:35:02 scone ifdhandler[677]: eg_card_status: slot=0 Jul 21 12:35:33 scone last message repeated 31 times Jul 21 12:36:09 scone last message repeated 36 times Jul 21 12:36:09 scone ifdhandler[677]: ifdhandler_process: ifdhandler_process(cmd=CT_CMD_RESET, unit=0) Jul 21 12:36:09 scone ifdhandler[677]: eg_card_reset: called. Jul 21 12:36:09 scone ifdhandler[677]: ifd_usb_control: usb req type=x40 req=x90 val=x0000 ind=x0000 len=0 Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ifd_sysdep_usb_control(0x90) Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL bmRequestType 0x40 bRequest 0x90 wValue 0x0 wIndex 0x0 wLength 0x0 Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ctrl.ucr_data == NULL Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ifd_sysdep_usb_control(0xa0) Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL bmRequestType 0xc0 bRequest 0xa0 wValue 0x0 wIndex 0x0 wLength 0x1 Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL SEND data 44 Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL RECV data 00 Jul 21 12:36:09 scone ifdhandler[677]: ifd_usb_control: usb req type=xc0 req=xa0 val=x0000 ind=x0000 len=1 Jul 21 12:36:09 scone ifdhandler[677]: ifd_usb_control: recv 00 Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ifd_sysdep_usb_control(0x83) Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL bmRequestType 0xc0 bRequest 0x83 wValue 0x0 wIndex 0x0 wLength 0x23 Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL SEND data 01 00 00 00 f4 ab bf bf 01 00 00 00 00 00 00 00 01 00 00 00 00 01 07 28 1f de 11 28 3c 38 09 28 60 d3 04 Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL RECV data 3b 95 18 40 ff 62 01 02 01 04 Jul 21 12:36:09 scone ifdhandler[677]: ifd_usb_control: usb req type=xc0 req=x83 val=x0000 ind=x0000 len=10 Jul 21 12:36:09 scone ifdhandler[677]: ifd_usb_control: recv 3b 95 18 40 ff 62 01 02 01 04 Jul 21 12:36:09 scone ifdhandler[677]: ifd_protocol_select: atr= 3b 95 18 40 ff 62 01 02 01 04 Jul 21 12:36:09 scone ifdhandler[677]: ifd_protocol_select: default T=0, supported protocols=0x1 Jul 21 12:36:09 scone ifdhandler[677]: eg_set_protocol: proto=0 Jul 21 12:36:09 scone ifdhandler[677]: ifdhandler_process: ifdhandler_process(cmd=CT_CMD_LOCK, unit=0) Jul 21 12:36:09 scone ifdhandler[677]: ifdhandler_lock: granted excl lock 1 for slot 0 by uid=4294967294 Jul 21 12:36:09 scone ifdhandler[677]: ifdhandler_process: ifdhandler_process(cmd=CT_CMD_TRANSACT, unit=0) Jul 21 12:36:09 scone ifdhandler[677]: ifd_protocol_transceive: cmd: f0 22 07 00 Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ifd_sysdep_usb_control(0xa0) Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL bmRequestType 0xc0 bRequest 0xa0 wValue 0x0 wIndex 0x0 wLength 0x1 Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL SEND data 28 Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL RECV data 00 Jul 21 12:36:09 scone ifdhandler[677]: ifd_usb_control: usb req type=xc0 req=xa0 val=x0000 ind=x0000 len=1 Jul 21 12:36:09 scone ifdhandler[677]: ifd_usb_control: recv 00 Jul 21 12:36:09 scone ifdhandler[677]: ifd_usb_control: usb req type=x40 req=x80 val=x0000 ind=x0000 len=5 Jul 21 12:36:09 scone ifdhandler[677]: ifd_usb_control: send f0 22 07 00 00 Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ifd_sysdep_usb_control(0x80) Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL bmRequestType 0x40 bRequest 0x80 wValue 0x0 wIndex 0x0 wLength 0x5 Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL SEND data f0 22 07 00 00 Jul 21 12:36:09 scone ifdhandler[677]: ifd_sysdep_usb_control: USB_DO_REQUEST failed: -1 Jul 21 12:36:09 scone ifdhandler[677]: ifd_protocol_transceive: transceive error: Communication error Jul 21 12:36:09 scone ifdhandler[677]: ifdhandler_process: ifdhandler_process(cmd=CT_CMD_UNLOCK, unit=0) Jul 21 12:36:09 scone ifdhandler[677]: ifdhandler_unlock: released excl lock 1 for slot 0 by uid=4294967294 Jul 21 12:36:10 scone ifdhandler[677]: eg_card_status: slot=0 Jul 21 12:36:41 scone last message repeated 31 times Jul 21 12:37:34 scone last message repeated 53 times Jul 21 12:37:34 scone ifdhandler[677]: ifdhandler_process: ifdhandler_process(cmd=CT_CMD_RESET, unit=0) Jul 21 12:37:34 scone ifdhandler[677]: eg_card_reset: called. Jul 21 12:37:34 scone ifdhandler[677]: ifd_usb_control: usb req type=x40 req=x90 val=x0000 ind=x0000 len=0 Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ifd_sysdep_usb_control(0x90) Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL bmRequestType 0x40 bRequest 0x90 wValue 0x0 wIndex 0x0 wLength 0x0 Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ctrl.ucr_data == NULL Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ifd_sysdep_usb_control(0xa0) Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL bmRequestType 0xc0 bRequest 0xa0 wValue 0x0 wIndex 0x0 wLength 0x1 Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL SEND data c4 Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL RECV data 00 Jul 21 12:37:34 scone ifdhandler[677]: ifd_usb_control: usb req type=xc0 req=xa0 val=x0000 ind=x0000 len=1 Jul 21 12:37:34 scone ifdhandler[677]: ifd_usb_control: recv 00 Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ifd_sysdep_usb_control(0x83) Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL bmRequestType 0xc0 bRequest 0x83 wValue 0x0 wIndex 0x0 wLength 0x23 Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL SEND data d1 a9 09 28 e9 a9 09 28 fd a9 09 28 0d aa 09 28 23 aa 09 28 35 aa 09 28 1f de 11 28 3c 38 09 28 60 d3 04 Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL RECV data 3b 95 18 40 ff 62 01 02 01 04 Jul 21 12:37:34 scone ifdhandler[677]: ifd_usb_control: usb req type=xc0 req=x83 val=x0000 ind=x0000 len=10 Jul 21 12:37:34 scone ifdhandler[677]: ifd_usb_control: recv 3b 95 18 40 ff 62 01 02 01 04 Jul 21 12:37:34 scone ifdhandler[677]: ifd_protocol_select: atr= 3b 95 18 40 ff 62 01 02 01 04 Jul 21 12:37:34 scone ifdhandler[677]: ifd_protocol_select: default T=0, supported protocols=0x1 Jul 21 12:37:34 scone ifdhandler[677]: eg_set_protocol: proto=0 Jul 21 12:37:34 scone ifdhandler[677]: ifdhandler_process: ifdhandler_process(cmd=CT_CMD_LOCK, unit=0) Jul 21 12:37:34 scone ifdhandler[677]: ifdhandler_lock: granted excl lock 2 for slot 0 by uid=4294967294 Jul 21 12:37:34 scone ifdhandler[677]: ifdhandler_process: ifdhandler_process(cmd=CT_CMD_TRANSACT, unit=0) Jul 21 12:37:34 scone ifdhandler[677]: ifd_protocol_transceive: cmd: c0 a4 00 00 02 3f 00 Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ifd_sysdep_usb_control(0xa0) Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL bmRequestType 0xc0 bRequest 0xa0 wValue 0x0 wIndex 0x0 wLength 0x1 Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL SEND data 28 Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL RECV data 00 Jul 21 12:37:34 scone ifdhandler[677]: ifd_usb_control: usb req type=xc0 req=xa0 val=x0000 ind=x0000 len=1 Jul 21 12:37:34 scone ifdhandler[677]: ifd_usb_control: recv 00 Jul 21 12:37:34 scone ifdhandler[677]: ifd_usb_control: usb req type=x40 req=x80 val=x0000 ind=x0000 len=5 Jul 21 12:37:34 scone ifdhandler[677]: ifd_usb_control: send c0 a4 00 00 02 Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: ifd_sysdep_usb_control(0x80) Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL bmRequestType 0x40 bRequest 0x80 wValue 0x0 wIndex 0x0 wLength 0x5 Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: BSD: CTRL SEND data c0 a4 00 00 02 Jul 21 12:37:34 scone ifdhandler[677]: ifd_sysdep_usb_control: USB_DO_REQUEST failed: -1 Jul 21 12:37:34 scone ifdhandler[677]: ifd_protocol_transceive: transceive error: Communication error Jul 21 12:37:34 scone ifdhandler[677]: ifdhandler_unlock_all: released excl lock 2 for slot 0 by uid=4294967294 Jul 21 12:37:35 scone ifdhandler[677]: eg_card_status: slot=0 Jul 21 12:38:06 scone last message repeated 31 times >How-To-Repeat: Try executing command "opensc-tool -a" >Fix: unknown yet...