Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Broadcom 0a5c:5832 error messages #14

Closed
nunojpg opened this issue Oct 14, 2016 · 4 comments
Closed

Broadcom 0a5c:5832 error messages #14

nunojpg opened this issue Oct 14, 2016 · 4 comments

Comments

@nunojpg
Copy link

nunojpg commented Oct 14, 2016

After my report at https://bugs.launchpad.net/ubuntu/+source/pcsc-lite/+bug/1596662 that the broadcom 0a5c:5832 was working after the firmware update, but I had some kernel messages, I've now tested after a clean install of Ubuntu 16.10+CCID(git HEAD)+PCSC(git HEAD):

When pcscd starts:

00000000 ifdhandler.c:144:CreateChannelByNameOrChannel() failed
00000018 readerfactory.c:1110:RFInitializeReader() Open Port 0x200000 Failed (usb:0a5c/5832:libudev:0:/dev/bus/usb/001/005)
00000004 readerfactory.c:375:RFAddReader() Broadcom Corp 5880 Broadcom USH init failed.

When I read anything from a card:

kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?

Following the log with pcscd --debug and the kernel messages in-line:

:36 pcscd[2811]: 04370016 winscard_msg_srv.c:251:ProcessEventsServer() Common channel packet arrival
:36 pcscd[2811]: 00000035 winscard_msg_srv.c:263:ProcessEventsServer() ProcessCommonChannelRequest detects: 14
:36 pcscd[2811]: 00000006 pcscdaemon.c:132:SVCServiceRunLoop() A new context thread creation is requested: 14
:36 pcscd[2811]: 00000962 winscard_svc.c:329:ContextThread() Authorized PC/SC client
:36 pcscd[2811]: 00000017 winscard_svc.c:333:ContextThread() Thread is started: dwClientID=14, threadContext @0x55590883be80
:36 pcscd[2811]: 00000015 winscard_svc.c:351:ContextThread() Received command: CMD_VERSION from client 14
:36 pcscd[2811]: 00000008 winscard_svc.c:363:ContextThread() Client is protocol version 4:3
:36 pcscd[2811]: 00000005 winscard_svc.c:383:ContextThread() CMD_VERSION rv=0x0 for client 14
:36 pcscd[2811]: 00000141 winscard_svc.c:351:ContextThread() Received command: ESTABLISH_CONTEXT from client 14
:36 pcscd[2811]: 00000019 winscard.c:215:SCardEstablishContext() Establishing Context: 0x12149BCA
:36 pcscd[2811]: 00000005 winscard_svc.c:444:ContextThread() ESTABLISH_CONTEXT rv=0x0 for client 14
:36 pcscd[2811]: 00000105 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:36 pcscd[2811]: 00000138 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:36 pcscd[2811]: 00000123 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:36 pcscd[2811]: 00000084 winscard_svc.c:351:ContextThread() Received command: CONNECT from client 14
:36 pcscd[2811]: 00000012 winscard_svc.c:482:ContextThread() Authorized client for 'Broadcom Corp 5880 Contacted SmartCard 00 00'
:36 pcscd[2811]: 00000006 winscard.c:256:SCardConnect() Attempting Connect to Broadcom Corp 5880 Contacted SmartCard 00 00 using protocol: 3
:36 pcscd[2811]: 00000006 readerfactory.c:825:RFReaderInfo() RefReader() count was: 1
:36 pcscd[2811]: 00002961 ifdhandler.c:1151:IFDHPowerICC() action: PowerUp, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 pcscd[2811]: 00045796 winscard.c:329:SCardConnect() power up complete.
:36 pcscd[2811]: 00000035 Card ATR: 3B 7D 95 00 00 80 31 80 65 B0 83 11 00 C8 83 00 90 00
:36 pcscd[2811]: 00000008 winscard.c:349:SCardConnect() powerState: POWER_STATE_INUSE
:36 pcscd[2811]: 00000007 prothandler.c:108:PHSetProtocol() Attempting PTS to T=0
:36 pcscd[2811]: 00000009 ifdhandler.c:689:IFDHSetProtocolParameters() protocol T=0, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 pcscd[2811]: 00000008 ifdhandler.c:2078:extra_egt() Extra EGT patch applied
:36 pcscd[2811]: 00031850 winscard.c:428:SCardConnect() Active Protocol: T=0
:36 pcscd[2811]: 00000028 winscard.c:453:SCardConnect() hCard Identity: 23918606
:36 pcscd[2811]: 00000009 winscard.c:517:SCardConnect() UnrefReader() count was: 2
:36 pcscd[2811]: 00000017 winscard_svc.c:496:ContextThread() CONNECT rv=0x0 for client 14
:36 pcscd[2811]: 00000081 winscard_svc.c:351:ContextThread() Received command: CONTROL from client 14
:36 pcscd[2811]: 00000013 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000007 ifdhandler.c:1408:IFDHControl() ControlCode: 0x42000D48, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 pcscd[2811]: 00000003 Control TxBuffer:
:36 pcscd[2811]: 00000014 Control RxBuffer: 12 04 42 33 00 12
:36 pcscd[2811]: 00000005 winscard.c:1369:SCardControl() UnrefReader() count was: 2
:36 pcscd[2811]: 00000004 winscard_svc.c:705:ContextThread() CONTROL rv=0x0 for client 14
:36 pcscd[2811]: 00000047 winscard_svc.c:351:ContextThread() Received command: CONTROL from client 14
:36 pcscd[2811]: 00000011 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000005 ifdhandler.c:1408:IFDHControl() ControlCode: 0x42330012, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 pcscd[2811]: 00000003 Control TxBuffer:
:36 pcscd[2811]: 00000010 Control RxBuffer: 01 02 00 00 03 01 00 09 01 00 0B 02 5C 0A 0C 02 32 58 0A 04 00 00 01 00
:36 pcscd[2811]: 00000004 winscard.c:1369:SCardControl() UnrefReader() count was: 2
:36 pcscd[2811]: 00000004 winscard_svc.c:705:ContextThread() CONTROL rv=0x0 for client 14
:36 pcscd[2811]: 00000051 winscard_svc.c:351:ContextThread() Received command: CONTROL from client 14
:36 pcscd[2811]: 00000010 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000006 ifdhandler.c:1408:IFDHControl() ControlCode: 0x42330012, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 pcscd[2811]: 00000003 Control TxBuffer:
:36 pcscd[2811]: 00000010 Control RxBuffer: 01 02 00 00 03 01 00 09 01 00 0B 02 5C 0A 0C 02 32 58 0A 04 00 00 01 00
:36 pcscd[2811]: 00000004 winscard.c:1369:SCardControl() UnrefReader() count was: 2
:36 pcscd[2811]: 00000003 winscard_svc.c:705:ContextThread() CONTROL rv=0x0 for client 14
:36 pcscd[2811]: 00000043 winscard_svc.c:351:ContextThread() Received command: GET_ATTRIB from client 14
:36 pcscd[2811]: 00000011 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000005 ifdhandler.c:379:IFDHGetCapabilities() tag: 0x10100, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 pcscd[2811]: 00000005 winscard.c:1444:SCardGetAttrib() UnrefReader() count was: 2
:36 pcscd[2811]: 00000004 winscard_svc.c:734:ContextThread() GET_ATTRIB rv=0x0 for client 14
:36 pcscd[2811]: 00000040 winscard_svc.c:351:ContextThread() Received command: GET_ATTRIB from client 14
:36 pcscd[2811]: 00000010 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000004 ifdhandler.c:379:IFDHGetCapabilities() tag: 0x10102, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 pcscd[2811]: 00000004 winscard.c:1444:SCardGetAttrib() UnrefReader() count was: 2
:36 pcscd[2811]: 00000004 winscard_svc.c:734:ContextThread() GET_ATTRIB rv=0x0 for client 14
:36 pcscd[2811]: 00000034 winscard_svc.c:351:ContextThread() Received command: DISCONNECT from client 14
:36 pcscd[2811]: 00000010 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000004 winscard.c:877:SCardDisconnect() Active Contexts: 1
:36 pcscd[2811]: 00000004 winscard.c:878:SCardDisconnect() dwDisposition: 0
:36 pcscd[2811]: 00000006 winscard.c:1024:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD
:36 pcscd[2811]: 00000004 ifdhandler.c:379:IFDHGetCapabilities() tag: 0xFB2, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 pcscd[2811]: 00000004 winscard.c:1037:SCardDisconnect() Stopping polling thread
:36 pcscd[2811]: 00000004 ifdhandler.c:344:IFDHStopPolling() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 pcscd[2811]: 00000101 winscard.c:1050:SCardDisconnect() UnrefReader() count was: 2
:36 pcscd[2811]: 00000006 winscard_svc.c:533:ContextThread() DISCONNECT rv=0x0 for client 14
:36 pcscd[2811]: 00000046 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:36 pcscd[2811]: 00000048 winscard_svc.c:351:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14
:36 pcscd[2811]: 00000025 winscard_svc.c:351:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14
:36 pcscd[2811]: 00000012 winscard_svc.c:425:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14
:36 pcscd[2811]: 00000028 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:36 pcscd[2811]: 00000054 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:36 pcscd[2811]: 00000031 winscard_svc.c:351:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14
:36 pcscd[2811]: 00000016 winscard_svc.c:351:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14
:36 pcscd[2811]: 00000010 winscard_svc.c:425:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14
:36 pcscd[2811]: 00000027 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:36 pcscd[2811]: 00000037 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:36 pcscd[2811]: 00000029 winscard_svc.c:351:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14
:36 pcscd[2811]: 00000016 winscard_svc.c:351:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14
:36 pcscd[2811]: 00000008 winscard_svc.c:425:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14
:36 pcscd[2811]: 00000030 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:36 pcscd[2811]: 00000037 winscard_svc.c:351:ContextThread() Received command: CONNECT from client 14
:36 pcscd[2811]: 00000010 winscard_svc.c:482:ContextThread() Authorized client for 'Broadcom Corp 5880 Contacted SmartCard 00 00'
:36 pcscd[2811]: 00000005 winscard.c:256:SCardConnect() Attempting Connect to Broadcom Corp 5880 Contacted SmartCard 00 00 using protocol: 3
:36 pcscd[2811]: 00000004 readerfactory.c:825:RFReaderInfo() RefReader() count was: 1
:36 pcscd[2811]: 00000005 winscard.c:349:SCardConnect() powerState: POWER_STATE_INUSE
:36 pcscd[2811]: 00000004 winscard.c:428:SCardConnect() Active Protocol: T=0
:36 pcscd[2811]: 00000004 winscard.c:453:SCardConnect() hCard Identity: 1676ca03
:36 pcscd[2811]: 00000004 winscard.c:517:SCardConnect() UnrefReader() count was: 2
:36 pcscd[2811]: 00000005 winscard_svc.c:496:ContextThread() CONNECT rv=0x0 for client 14
:36 pcscd[2811]: 00000039 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000014 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000005 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00043859 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000020 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000162 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000024 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000007 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000007 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00016711 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000016 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000134 winscard_svc.c:351:ContextThread() Received command: BEGIN_TRANSACTION from client 14
:36 pcscd[2811]: 00000019 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000007 winscard.c:1089:SCardBeginTransaction() Status: 0x00000000
:36 pcscd[2811]: 00000004 winscard.c:1092:SCardBeginTransaction() UnrefReader() count was: 2
:36 pcscd[2811]: 00000005 winscard_svc.c:548:ContextThread() BEGIN_TRANSACTION rv=0x0 for client 14
:36 pcscd[2811]: 00000119 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000030 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000016 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000008 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00008940 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000016 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000127 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000024 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00021553 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000016 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000121 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000024 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000005 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000008 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00007634 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000016 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000124 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000023 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00022513 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000016 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000069 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000018 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000005 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00007655 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000015 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000083 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000016 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000005 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000005 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00030911 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000016 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000120 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000024 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000005 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000009 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00021514 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000018 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000071 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000021 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000007 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000008 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00008024 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000020 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000162 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000024 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00031359 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000019 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000130 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000024 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000007 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00021939 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000016 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000067 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000020 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000008 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000009 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00007848 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000016 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000118 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000024 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000005 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00040816 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000015 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000130 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000018 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000005 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000007 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00022590 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000024 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000172 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000026 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000007 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00007383 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000025 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000199 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000026 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000008 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00042192 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000017 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000196 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000016 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000005 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00021558 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000015 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000139 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000023 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00007026 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000016 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000144 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000024 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00052279 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000020 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000210 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000021 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00003950 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00021458 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000024 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000100 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000018 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000005 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000007 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00008503 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000020 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000148 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000023 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000007 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00055815 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000024 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000188 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000023 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000009 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00024867 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000027 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000280 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000026 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000007 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000013 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00012655 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000020 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000133 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000020 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000007 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000009 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00012618 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000010 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000080 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:36 pcscd[2811]: 00000012 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000005 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:36 pcscd[2811]: 00000004 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 5 ep 4 with no TDs queued?
:36 pcscd[2811]: 00012896 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:36 pcscd[2811]: 00000011 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:36 pcscd[2811]: 00000159 winscard_svc.c:351:ContextThread() Received command: END_TRANSACTION from client 14
:36 pcscd[2811]: 00000010 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000005 winscard.c:1244:SCardEndTransaction() Status: 0x00000000
:36 pcscd[2811]: 00000004 winscard.c:1247:SCardEndTransaction() UnrefReader() count was: 2
:36 pcscd[2811]: 00000004 winscard_svc.c:564:ContextThread() END_TRANSACTION rv=0x0 for client 14
:36 pcscd[2811]: 00008796 winscard_svc.c:351:ContextThread() Received command: DISCONNECT from client 14
:36 pcscd[2811]: 00000012 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:36 pcscd[2811]: 00000005 winscard.c:877:SCardDisconnect() Active Contexts: 1
:36 pcscd[2811]: 00000003 winscard.c:878:SCardDisconnect() dwDisposition: 1
:36 pcscd[2811]: 00004097 ifdhandler.c:1151:IFDHPowerICC() action: Reset, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 pcscd[2811]: 00045359 winscard.c:932:SCardDisconnect() Reset complete.
:36 pcscd[2811]: 00000017 Card ATR: 3B 7D 95 00 00 80 31 80 65 B0 83 11 00 C8 83 00 90 00
:36 pcscd[2811]: 00000006 winscard.c:1024:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD
:36 pcscd[2811]: 00000006 ifdhandler.c:379:IFDHGetCapabilities() tag: 0xFB2, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 pcscd[2811]: 00000003 winscard.c:1037:SCardDisconnect() Stopping polling thread
:36 pcscd[2811]: 00000004 ifdhandler.c:344:IFDHStopPolling() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:36 pcscd[2811]: 00000095 winscard.c:1050:SCardDisconnect() UnrefReader() count was: 2
:36 pcscd[2811]: 00000008 winscard_svc.c:533:ContextThread() DISCONNECT rv=0x0 for client 14
:36 pcscd[2811]: 00000116 winscard_svc.c:351:ContextThread() Received command: RELEASE_CONTEXT from client 14
:36 pcscd[2811]: 00000009 winscard.c:226:SCardReleaseContext() Releasing Context: 0x12149BCA
:36 pcscd[2811]: 00000006 winscard_svc.c:459:ContextThread() RELEASE_CONTEXT rv=0x0 for client 14
:36 pcscd[2811]: 00000097 winscard_svc.c:343:ContextThread() Client die: 14
:36 pcscd[2811]: 00000020 winscard_svc.c:986:MSGCleanupClient() Thread is stopping: dwClientID=14, threadContext @0x55590883be80
:36 pcscd[2811]: 00000005 winscard_svc.c:992:MSGCleanupClient() Freeing SCONTEXT @0x55590883be80
:36 pcscd[2811]: 00000005 winscard_svc.c:1007:MSGCleanupClient() Starting suicide alarm in 60 seconds
:37 pcscd[2811]: 00399977 eventhandler.c:491:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
:42 pcscd[2811]: 05008011 ifdhandler.c:1151:IFDHPowerICC() action: PowerDown, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/005 (lun: 0)
:42 pcscd[2811]: 00000472 eventhandler.c:479:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED
@LudovicRousseau
Copy link
Owner

I need a complete pcscd trace from the start of pcscd.
Your trace is truncated and is then not helpful.

@nunojpg
Copy link
Author

nunojpg commented Oct 14, 2016

Sorry:

:30 systemd[1]: Started PC/SC Smart Card Daemon.
:30 pcscd[13256]: 00000000 debuglog.c:289:DebugLogSetLevel() debug level=debug
:30 pcscd[13256]: 00000117 pcscdaemon.c:405:main() Auto exit after 60 seconds of inactivity
:30 pcscd[13256]: 00000027 pcscdaemon.c:444:main() Started by systemd
:30 pcscd[13256]: 00000109 configfile.l:358:DBGetReaderList() Parsing conf file: /usr/local/etc/reader.conf.d
:30 pcscd[13256]: 00000017 pcscdaemon.c:655:main() pcsc-lite 1.8.18 daemon ready.
:30 pcscd[13256]: 00007768 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
:30 pcscd[13256]: 00000223 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
:30 pcscd[13256]: 00000191 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x04E8, PID: 0x6860, path: /dev/bus/usb/001/002
:30 pcscd[13256]: 00000166 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
:30 pcscd[13256]: 00000175 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x0A5C, PID: 0x5832, path: /dev/bus/usb/001/006
:30 pcscd[13256]: 00000011 hotplug_libudev.c:433:HPAddDevice() Adding USB device: Broadcom Corp 5880
:30 pcscd[13256]: 00000122 readerfactory.c:1079:RFInitializeReader() Attempting startup of Broadcom Corp 5880 Broadcom USH 00 00 using /usr/local/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so
:30 pcscd[13256]: 00001632 readerfactory.c:954:RFBindFunctions() Loading IFD Handler 3.0
:30 pcscd[13256]: 00000059 ifdhandler.c:1958:init_driver() Driver version: 1.4.25
:30 pcscd[13256]: 00001247 ifdhandler.c:1975:init_driver() LogLevel: 0x0003
:30 pcscd[13256]: 00000017 ifdhandler.c:1986:init_driver() DriverOptions: 0x0000
:30 pcscd[13256]: 00000356 ifdhandler.c:110:CreateChannelByNameOrChannel() Lun: 0, device: usb:0a5c/5832:libudev:0:/dev/bus/usb/001/006
:30 pcscd[13256]: 00000033 ccid_usb.c:287:OpenUSBByName() Using: /usr/local/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist
:30 pcscd[13256]: 00001219 ccid_usb.c:305:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau ([email protected])
:30 pcscd[13256]: 00000013 ccid_usb.c:306:OpenUSBByName() ifdProductString: Generic CCID driver
:30 pcscd[13256]: 00000006 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.
:30 pcscd[13256]: 00007524 ccid_usb.c:599:OpenUSBByName() Found interface 1 but expecting 0
:30 pcscd[13256]: 00000017 ccid_usb.c:601:OpenUSBByName() Wrong interface for USB device 1/6. Checking next one.
:30 pcscd[13256]: 00000244 ccid_usb.c:189:close_libusb_if_needed() libusb_exit
:30 pcscd[13256]: 00000191 ccid_usb.c:749:OpenUSBByName() Device not found?
:30 pcscd[13256]: 00000015 ifdhandler.c:144:CreateChannelByNameOrChannel() failed
:30 pcscd[13256]: 00000009 readerfactory.c:1110:RFInitializeReader() Open Port 0x200000 Failed (usb:0a5c/5832:libudev:0:/dev/bus/usb/001/006)
:30 pcscd[13256]: 00000005 readerfactory.c:375:RFAddReader() Broadcom Corp 5880 Broadcom USH init failed.
:30 pcscd[13256]: 00000005 readerfactory.c:608:RFRemoveReader() UnrefReader() count was: 1
:30 pcscd[13256]: 00000006 readerfactory.c:1130:RFUnInitializeReader() Attempting shutdown of Broadcom Corp 5880 Broadcom USH 00 00.
:30 pcscd[13256]: 00000004 readerfactory.c:991:RFUnloadReader() Unloading reader driver.
:30 pcscd[13256]: 00000325 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x0A5C, PID: 0x5832, path: /dev/bus/usb/001/006
:30 pcscd[13256]: 00000012 hotplug_libudev.c:433:HPAddDevice() Adding USB device: Broadcom Corp 5880
:30 pcscd[13256]: 00000100 readerfactory.c:1079:RFInitializeReader() Attempting startup of Broadcom Corp 5880 Contacted SmartCard 00 00 using /usr/local/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so
:30 pcscd[13256]: 00000252 readerfactory.c:954:RFBindFunctions() Loading IFD Handler 3.0
:30 pcscd[13256]: 00000039 ifdhandler.c:1958:init_driver() Driver version: 1.4.25
:30 pcscd[13256]: 00001252 ifdhandler.c:1975:init_driver() LogLevel: 0x0003
:30 pcscd[13256]: 00000011 ifdhandler.c:1986:init_driver() DriverOptions: 0x0000
:30 pcscd[13256]: 00000354 ifdhandler.c:110:CreateChannelByNameOrChannel() Lun: 0, device: usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006
:30 pcscd[13256]: 00000026 ccid_usb.c:287:OpenUSBByName() Using: /usr/local/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist
:30 pcscd[13256]: 00001229 ccid_usb.c:305:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau ([email protected])
:30 pcscd[13256]: 00000009 ccid_usb.c:306:OpenUSBByName() ifdProductString: Generic CCID driver
:30 pcscd[13256]: 00000006 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.
:30 pcscd[13256]: 00005407 ccid_usb.c:621:OpenUSBByName() Found Vendor/Product: 0A5C/5832 (Broadcom Corp 5880)
:30 pcscd[13256]: 00000013 ccid_usb.c:623:OpenUSBByName() Using USB bus/device: 1/6
:30 pcscd[13256]: 00000005 ccid_usb.c:680:OpenUSBByName() bNumDataRatesSupported is 0
:30 pcscd[13256]: 00029129 ifdhandler.c:379:IFDHGetCapabilities() tag: 0xFB3, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 pcscd[13256]: 00000012 readerfactory.c:395:RFAddReader() Using the reader polling thread
:30 pcscd[13256]: 00002997 ifdhandler.c:379:IFDHGetCapabilities() tag: 0xFAE, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 pcscd[13256]: 00000019 ifdhandler.c:470:IFDHGetCapabilities() Reader supports 1 slot(s)
:30 pcscd[13256]: 00000368 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
:30 pcscd[13256]: 00000181 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x1BCF, PID: 0x28B8, path: /dev/bus/usb/001/008
:30 pcscd[13256]: 00000218 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x1BCF, PID: 0x28B8, path: /dev/bus/usb/001/008
:30 pcscd[13256]: 00000157 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
:30 pcscd[13256]: 00000159 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x045E, PID: 0x07A5, path: /dev/bus/usb/001/003
:30 pcscd[13256]: 00000158 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x045E, PID: 0x07A5, path: /dev/bus/usb/001/003
:30 pcscd[13256]: 00000158 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x045E, PID: 0x07A5, path: /dev/bus/usb/001/003
:30 pcscd[13256]: 00000144 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
:30 pcscd[13256]: 00000158 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x413C, PID: 0x2513, path: /dev/bus/usb/001/004
:30 pcscd[13256]: 00000145 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0002, path: /dev/bus/usb/001/001
:30 pcscd[13256]: 00000158 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x413C, PID: 0x2134, path: /dev/bus/usb/001/005
:30 pcscd[13256]: 00000171 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x0424, PID: 0x2514, path: /dev/bus/usb/001/010
:30 pcscd[13256]: 00000180 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA503, path: /dev/bus/usb/001/011
:30 pcscd[13256]: 00000176 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA503, path: /dev/bus/usb/001/011
:30 pcscd[13256]: 00000176 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA503, path: /dev/bus/usb/001/011
:30 pcscd[13256]: 00000174 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x413C, PID: 0xA503, path: /dev/bus/usb/001/011
:30 pcscd[13256]: 00000231 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x0424, PID: 0x2514, path: /dev/bus/usb/001/010
:30 pcscd[13256]: 00000165 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x413C, PID: 0x2134, path: /dev/bus/usb/001/005
:30 pcscd[13256]: 00000233 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0003, path: /dev/bus/usb/002/001
:30 pcscd[13256]: 00000145 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x1D6B, PID: 0x0003, path: /dev/bus/usb/002/001
:30 pcscd[13256]: 00000156 hotplug_libudev.c:294:get_driver() Looking for a driver for VID: 0x413C, PID: 0x5534, path: /dev/bus/usb/002/002
:30 pcscd[13256]: 00000382 readerfactory.c:1420:RFWaitForReaderInit() Waiting init for reader: Broadcom Corp 5880 Contacted SmartCard 00 00
:30 pcscd[13256]: 00001702 ifdhandler.c:1151:IFDHPowerICC() action: PowerUp, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 pcscd[13256]: 00008410 readerfactory.c:1420:RFWaitForReaderInit() Waiting init for reader: Broadcom Corp 5880 Contacted SmartCard 00 00
:30 pcscd[13256]: 00010259 readerfactory.c:1420:RFWaitForReaderInit() Waiting init for reader: Broadcom Corp 5880 Contacted SmartCard 00 00
:30 pcscd[13256]: 00010250 readerfactory.c:1420:RFWaitForReaderInit() Waiting init for reader: Broadcom Corp 5880 Contacted SmartCard 00 00
:30 pcscd[13256]: 00010240 readerfactory.c:1420:RFWaitForReaderInit() Waiting init for reader: Broadcom Corp 5880 Contacted SmartCard 00 00
:30 pcscd[13256]: 00007533 eventhandler.c:286:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
:30 pcscd[13256]: 00000036 Card ATR: 3B 7D 95 00 00 80 31 80 65 B0 83 11 00 C8 83 00 90 00
:30 pcscd[13256]: 00002677 winscard_msg_srv.c:251:ProcessEventsServer() Common channel packet arrival
:30 pcscd[13256]: 00000049 winscard_msg_srv.c:263:ProcessEventsServer() ProcessCommonChannelRequest detects: 14
:30 pcscd[13256]: 00000007 pcscdaemon.c:132:SVCServiceRunLoop() A new context thread creation is requested: 14
:30 pcscd[13256]: 00000126 winscard_svc.c:329:ContextThread() Authorized PC/SC client
:30 pcscd[13256]: 00000020 winscard_svc.c:333:ContextThread() Thread is started: dwClientID=14, threadContext @0x55d1c1a5de70
:30 pcscd[13256]: 00000023 winscard_svc.c:351:ContextThread() Received command: CMD_VERSION from client 14
:30 pcscd[13256]: 00000012 winscard_svc.c:363:ContextThread() Client is protocol version 4:3
:30 pcscd[13256]: 00000008 winscard_svc.c:383:ContextThread() CMD_VERSION rv=0x0 for client 14
:30 pcscd[13256]: 00000133 winscard_svc.c:351:ContextThread() Received command: ESTABLISH_CONTEXT from client 14
:30 pcscd[13256]: 00000023 winscard.c:215:SCardEstablishContext() Establishing Context: 0x32E3B907
:30 pcscd[13256]: 00000011 winscard_svc.c:444:ContextThread() ESTABLISH_CONTEXT rv=0x0 for client 14
:30 pcscd[13256]: 00000132 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:30 pcscd[13256]: 00000128 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:30 pcscd[13256]: 00000193 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:30 pcscd[13256]: 00000141 winscard_svc.c:351:ContextThread() Received command: CONNECT from client 14
:30 pcscd[13256]: 00000016 winscard_svc.c:482:ContextThread() Authorized client for 'Broadcom Corp 5880 Contacted SmartCard 00 00'
:30 pcscd[13256]: 00000008 winscard.c:256:SCardConnect() Attempting Connect to Broadcom Corp 5880 Contacted SmartCard 00 00 using protocol: 3
:30 pcscd[13256]: 00000008 readerfactory.c:825:RFReaderInfo() RefReader() count was: 1
:30 pcscd[13256]: 00000010 winscard.c:349:SCardConnect() powerState: POWER_STATE_INUSE
:30 pcscd[13256]: 00003798 prothandler.c:108:PHSetProtocol() Attempting PTS to T=0
:30 pcscd[13256]: 00000016 ifdhandler.c:689:IFDHSetProtocolParameters() protocol T=0, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 pcscd[13256]: 00000016 ifdhandler.c:2078:extra_egt() Extra EGT patch applied
:30 pcscd[13256]: 00028058 winscard.c:428:SCardConnect() Active Protocol: T=0
:30 pcscd[13256]: 00000022 winscard.c:453:SCardConnect() hCard Identity: 17182447
:30 pcscd[13256]: 00000008 winscard.c:517:SCardConnect() UnrefReader() count was: 2
:30 pcscd[13256]: 00000009 winscard_svc.c:496:ContextThread() CONNECT rv=0x0 for client 14
:30 pcscd[13256]: 00000115 winscard_svc.c:351:ContextThread() Received command: CONTROL from client 14
:30 pcscd[13256]: 00000017 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000009 ifdhandler.c:1408:IFDHControl() ControlCode: 0x42000D48, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 pcscd[13256]: 00000008 Control TxBuffer:
:30 pcscd[13256]: 00000017 Control RxBuffer: 12 04 42 33 00 12
:30 pcscd[13256]: 00000007 winscard.c:1369:SCardControl() UnrefReader() count was: 2
:30 pcscd[13256]: 00000007 winscard_svc.c:705:ContextThread() CONTROL rv=0x0 for client 14
:30 pcscd[13256]: 00000116 winscard_svc.c:351:ContextThread() Received command: CONTROL from client 14
:30 pcscd[13256]: 00000013 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000008 ifdhandler.c:1408:IFDHControl() ControlCode: 0x42330012, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 pcscd[13256]: 00000005 Control TxBuffer:
:30 pcscd[13256]: 00000017 Control RxBuffer: 01 02 00 00 03 01 00 09 01 00 0B 02 5C 0A 0C 02 32 58 0A 04 00 00 01 00
:30 pcscd[13256]: 00000006 winscard.c:1369:SCardControl() UnrefReader() count was: 2
:30 pcscd[13256]: 00000006 winscard_svc.c:705:ContextThread() CONTROL rv=0x0 for client 14
:30 pcscd[13256]: 00000140 winscard_svc.c:351:ContextThread() Received command: CONTROL from client 14
:30 pcscd[13256]: 00000016 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000007 ifdhandler.c:1408:IFDHControl() ControlCode: 0x42330012, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 pcscd[13256]: 00000004 Control TxBuffer:
:30 pcscd[13256]: 00000019 Control RxBuffer: 01 02 00 00 03 01 00 09 01 00 0B 02 5C 0A 0C 02 32 58 0A 04 00 00 01 00
:30 pcscd[13256]: 00000005 winscard.c:1369:SCardControl() UnrefReader() count was: 2
:30 pcscd[13256]: 00000006 winscard_svc.c:705:ContextThread() CONTROL rv=0x0 for client 14
:30 pcscd[13256]: 00000044 winscard_svc.c:351:ContextThread() Received command: GET_ATTRIB from client 14
:30 pcscd[13256]: 00000014 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000012 ifdhandler.c:379:IFDHGetCapabilities() tag: 0x10100, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 pcscd[13256]: 00000012 winscard.c:1444:SCardGetAttrib() UnrefReader() count was: 2
:30 pcscd[13256]: 00000008 winscard_svc.c:734:ContextThread() GET_ATTRIB rv=0x0 for client 14
:30 pcscd[13256]: 00000048 winscard_svc.c:351:ContextThread() Received command: GET_ATTRIB from client 14
:30 pcscd[13256]: 00000015 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000007 ifdhandler.c:379:IFDHGetCapabilities() tag: 0x10102, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 pcscd[13256]: 00000006 winscard.c:1444:SCardGetAttrib() UnrefReader() count was: 2
:30 pcscd[13256]: 00000006 winscard_svc.c:734:ContextThread() GET_ATTRIB rv=0x0 for client 14
:30 pcscd[13256]: 00000045 winscard_svc.c:351:ContextThread() Received command: DISCONNECT from client 14
:30 pcscd[13256]: 00000016 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000006 winscard.c:877:SCardDisconnect() Active Contexts: 1
:30 pcscd[13256]: 00000006 winscard.c:878:SCardDisconnect() dwDisposition: 0
:30 pcscd[13256]: 00000006 winscard.c:1024:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD
:30 pcscd[13256]: 00000007 ifdhandler.c:379:IFDHGetCapabilities() tag: 0xFB2, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 pcscd[13256]: 00000012 winscard.c:1037:SCardDisconnect() Stopping polling thread
:30 pcscd[13256]: 00000007 ifdhandler.c:344:IFDHStopPolling() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 pcscd[13256]: 00000077 winscard.c:1050:SCardDisconnect() UnrefReader() count was: 2
:30 pcscd[13256]: 00000012 winscard_svc.c:533:ContextThread() DISCONNECT rv=0x0 for client 14
:30 pcscd[13256]: 00000085 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:30 pcscd[13256]: 00000113 winscard_svc.c:351:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14
:30 pcscd[13256]: 00000021 winscard_svc.c:351:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14
:30 pcscd[13256]: 00000012 winscard_svc.c:425:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14
:30 pcscd[13256]: 00000046 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:30 pcscd[13256]: 00000072 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:30 pcscd[13256]: 00000041 winscard_svc.c:351:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14
:30 pcscd[13256]: 00000018 winscard_svc.c:351:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14
:30 pcscd[13256]: 00000013 winscard_svc.c:425:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14
:30 pcscd[13256]: 00000039 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:30 pcscd[13256]: 00000072 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:30 pcscd[13256]: 00000045 winscard_svc.c:351:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 14
:30 pcscd[13256]: 00000018 winscard_svc.c:351:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 14
:30 pcscd[13256]: 00000012 winscard_svc.c:425:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 14
:30 pcscd[13256]: 00000037 winscard_svc.c:351:ContextThread() Received command: CMD_GET_READERS_STATE from client 14
:30 pcscd[13256]: 00000041 winscard_svc.c:351:ContextThread() Received command: CONNECT from client 14
:30 pcscd[13256]: 00000013 winscard_svc.c:482:ContextThread() Authorized client for 'Broadcom Corp 5880 Contacted SmartCard 00 00'
:30 pcscd[13256]: 00000006 winscard.c:256:SCardConnect() Attempting Connect to Broadcom Corp 5880 Contacted SmartCard 00 00 using protocol: 3
:30 pcscd[13256]: 00000008 readerfactory.c:825:RFReaderInfo() RefReader() count was: 1
:30 pcscd[13256]: 00000006 winscard.c:349:SCardConnect() powerState: POWER_STATE_INUSE
:30 pcscd[13256]: 00000006 winscard.c:428:SCardConnect() Active Protocol: T=0
:30 pcscd[13256]: 00000007 winscard.c:453:SCardConnect() hCard Identity: 117e626b
:30 pcscd[13256]: 00000006 winscard.c:517:SCardConnect() UnrefReader() count was: 2
:30 pcscd[13256]: 00000008 winscard_svc.c:496:ContextThread() CONNECT rv=0x0 for client 14
:30 pcscd[13256]: 00000309 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000021 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000009 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000010 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00043483 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000026 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00001832 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000032 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000007 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000007 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00017134 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000025 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000313 winscard_svc.c:351:ContextThread() Received command: BEGIN_TRANSACTION from client 14
:30 pcscd[13256]: 00000023 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000007 winscard.c:1089:SCardBeginTransaction() Status: 0x00000000
:30 pcscd[13256]: 00000005 winscard.c:1092:SCardBeginTransaction() UnrefReader() count was: 2
:30 pcscd[13256]: 00000005 winscard_svc.c:548:ContextThread() BEGIN_TRANSACTION rv=0x0 for client 14
:30 pcscd[13256]: 00000660 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000025 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000007 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00008348 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000016 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000523 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000023 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000007 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00021359 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000026 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000272 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000025 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000009 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00006845 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000016 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000141 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000017 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000005 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000005 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00021250 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000021 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000125 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000027 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000009 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000010 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00006846 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000017 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000120 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000017 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000005 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00030277 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000024 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000265 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000026 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000008 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000015 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00021549 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000018 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000126 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000022 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000007 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00007842 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000025 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000154 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000025 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000008 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00031760 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000028 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000280 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000029 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000007 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000007 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00021516 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000017 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000145 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000024 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000008 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00007771 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000024 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000161 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000025 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00041439 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000017 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000267 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000023 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000007 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00021610 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000017 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000087 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000022 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000005 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00007212 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000016 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000090 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000017 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000008 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00041884 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000023 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000224 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000022 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00021274 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000029 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000157 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000019 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000007 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000008 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00006973 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000020 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000101 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000018 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000005 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00052078 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000026 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000281 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000023 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00003855 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00023378 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000029 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000196 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000027 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000007 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000007 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:30 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:30 pcscd[13256]: 00008467 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:30 pcscd[13256]: 00000018 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:30 pcscd[13256]: 00000128 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:30 pcscd[13256]: 00000014 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:30 pcscd[13256]: 00000005 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:30 pcscd[13256]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:31 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:31 pcscd[13256]: 00055692 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:31 pcscd[13256]: 00000023 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:31 pcscd[13256]: 00000152 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:31 pcscd[13256]: 00000024 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:31 pcscd[13256]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:31 pcscd[13256]: 00000009 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:31 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:31 pcscd[13256]: 00025195 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:31 pcscd[13256]: 00000023 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:31 pcscd[13256]: 00000266 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:31 pcscd[13256]: 00000025 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:31 pcscd[13256]: 00000007 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:31 pcscd[13256]: 00000006 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:31 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:31 pcscd[13256]: 00013692 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:31 pcscd[13256]: 00000028 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:31 pcscd[13256]: 00000173 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:31 pcscd[13256]: 00000020 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:31 pcscd[13256]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:31 pcscd[13256]: 00000007 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:31 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:31 pcscd[13256]: 00013155 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:31 pcscd[13256]: 00000027 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:31 pcscd[13256]: 00000194 winscard_svc.c:351:ContextThread() Received command: TRANSMIT from client 14
:31 pcscd[13256]: 00000026 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:31 pcscd[13256]: 00000006 winscard.c:1605:SCardTransmit() Send Protocol: T=0
:31 pcscd[13256]: 00000007 ifdhandler.c:1300:IFDHTransmitToICC() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:31 kernel: xhci_hcd 0000:00:14.0: WARN Event TRB for slot 6 ep 4 with no TDs queued?
:31 pcscd[13256]: 00013225 winscard.c:1650:SCardTransmit() UnrefReader() count was: 2
:31 pcscd[13256]: 00000023 winscard_svc.c:661:ContextThread() TRANSMIT rv=0x0 for client 14
:31 pcscd[13256]: 00001424 winscard_svc.c:351:ContextThread() Received command: END_TRANSACTION from client 14
:31 pcscd[13256]: 00000025 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:31 pcscd[13256]: 00000008 winscard.c:1244:SCardEndTransaction() Status: 0x00000000
:31 pcscd[13256]: 00000004 winscard.c:1247:SCardEndTransaction() UnrefReader() count was: 2
:31 pcscd[13256]: 00000005 winscard_svc.c:564:ContextThread() END_TRANSACTION rv=0x0 for client 14
:31 pcscd[13256]: 00009013 winscard_svc.c:351:ContextThread() Received command: DISCONNECT from client 14
:31 pcscd[13256]: 00000028 readerfactory.c:852:RFReaderInfoById() RefReader() count was: 1
:31 pcscd[13256]: 00000006 winscard.c:877:SCardDisconnect() Active Contexts: 1
:31 pcscd[13256]: 00000005 winscard.c:878:SCardDisconnect() dwDisposition: 1
:31 pcscd[13256]: 00004133 ifdhandler.c:1151:IFDHPowerICC() action: Reset, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:31 pcscd[13256]: 00045593 winscard.c:932:SCardDisconnect() Reset complete.
:31 pcscd[13256]: 00000037 Card ATR: 3B 7D 95 00 00 80 31 80 65 B0 83 11 00 C8 83 00 90 00
:31 pcscd[13256]: 00000010 winscard.c:1024:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD
:31 pcscd[13256]: 00000007 ifdhandler.c:379:IFDHGetCapabilities() tag: 0xFB2, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:31 pcscd[13256]: 00000004 winscard.c:1037:SCardDisconnect() Stopping polling thread
:31 pcscd[13256]: 00000005 ifdhandler.c:344:IFDHStopPolling() usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:31 pcscd[13256]: 00000151 winscard.c:1050:SCardDisconnect() UnrefReader() count was: 2
:31 pcscd[13256]: 00000022 winscard_svc.c:533:ContextThread() DISCONNECT rv=0x0 for client 14
:31 pcscd[13256]: 00000209 winscard_svc.c:351:ContextThread() Received command: RELEASE_CONTEXT from client 14
:31 pcscd[13256]: 00000020 winscard.c:226:SCardReleaseContext() Releasing Context: 0x32E3B907
:31 pcscd[13256]: 00000013 winscard_svc.c:459:ContextThread() RELEASE_CONTEXT rv=0x0 for client 14
:31 pcscd[13256]: 00000142 winscard_svc.c:343:ContextThread() Client die: 14
:31 pcscd[13256]: 00000032 winscard_svc.c:986:MSGCleanupClient() Thread is stopping: dwClientID=14, threadContext @0x55d1c1a5de70
:31 pcscd[13256]: 00000006 winscard_svc.c:992:MSGCleanupClient() Freeing SCONTEXT @0x55d1c1a5de70
:31 pcscd[13256]: 00000007 winscard_svc.c:1007:MSGCleanupClient() Starting suicide alarm in 60 seconds
:31 pcscd[13256]: 00399769 eventhandler.c:491:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
:36 pcscd[13256]: 05008331 ifdhandler.c:1151:IFDHPowerICC() action: PowerDown, usb:0a5c/5832:libudev:1:/dev/bus/usb/001/006 (lun: 0)
:36 pcscd[13256]: 00000526 eventhandler.c:479:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED

@LudovicRousseau
Copy link
Owner

The Broadcom device is a composite device with different interfaces.
The interface "Broadcom Corp 5880 Broadcom USH" is not a CCID interface and can't be used by the CCID driver.
Every thing is working as expected.

Regarding the kernel messages I can't help. It looks like a firmware bug at the USB layer.

@nunojpg
Copy link
Author

nunojpg commented Oct 14, 2016

Thanks. Let's hope Broadcom takes care of it.

@nunojpg nunojpg closed this as completed Oct 14, 2016
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@LudovicRousseau @nunojpg