[Pcsclite-muscle] Different behaviour with Select MF on Omnikey 5427 and 5022
Stephan Guilloux
stephan.guilloux at crisalid.com
Wed Nov 4 05:14:17 EST 2020
Here you are.
I took the opportunity to update PCSC and CCID to the latest versions
available (1.9.0 and 1.4.33).
Results are the same.
To reproduce, I ran the last official scard_example.go and rebuilt it
with the libs above.
scard_example output is inserted in each PCSC log file.
For comparison, the same process is used with a 5427 and a 5022.
5427 logs are attached in this mail.
5022 will be sent in a second mail.
Stephan.
Le mar. 3 nov. 2020 à 18:41, Ludovic Rousseau
<ludovic.rousseau at gmail.com> a écrit :
>
> Le mar. 3 nov. 2020 à 15:52, Stephan Guilloux
> <stephan.guilloux at crisalid.com> a écrit :
> >
> > Spent some time to reduce the code to the strict minimum, and it comes
> > almost the same as
> > https://github.com/ebfe/scard/blob/master/example_test.go
> > (traces are a bit different though)
> >
> > APDU is take from the same example:
> > 0x00, 0xa4, 0x00, 0x0c, 0x02, 0x3f, 0x00
>
> The next step is to generate a pcscd trace as documented in
> https://pcsclite.apdu.fr/#support
>
> Bye
>
> --
> Dr. Ludovic Rousseau
>
> _______________________________________________
> pcsclite-muscle mailing list
> pcsclite-muscle at lists.infradead.org
> http://lists.infradead.org/mailman/listinfo/pcsclite-muscle
-------------- next part --------------
[root at Rasp-8AC500 ~]$ ./scard-example
Found 1 readers:
[0] HID OMNIKEY 5427 CK (01010053484D37353001395E34176930) 00 00
Waiting for a Card
Connecting to card in HID OMNIKEY 5427 CK (01010053484D37353001395E34176930) 00 00
Card status:
reader: HID OMNIKEY 5427 CK (01010053484D37353001395E34176930) 00 00
state: 20034
active protocol: 2
atr: 3b 8f 80 01 80 4f 0c a0 00 00 03 06 03 00 01 00 00 00 00 6a
Transmit:
c-apdu: 00 a4 00 0c 02 3f 00
scard: Transaction failed.
[root at Rasp-8AC500 ~]$
----------------------------------------------------------------------
00000000 debuglog.c:299:DebugLogSetLevel() debug level=debug
00000137 debuglog.c:320:DebugLogSetCategory() Debug options: APDU
[36m00000024[0m [1996345344] [34mpcscdaemon.c:353:main() Force colored logs[0m
[36m00001132[0m [1996345344] configfile.l:293:DBGetReaderListDir() Parsing conf directory: /etc/reader.conf.d
[36m00000110[0m [1996345344] configfile.l:330:DBGetReaderListDir() Skipping non regular file: ..
[36m00000086[0m [1996345344] configfile.l:330:DBGetReaderListDir() Skipping non regular file: .
[36m00000079[0m [1996345344] [34mpcscdaemon.c:663:main() pcsc-lite 1.9.0 daemon ready.[0m
[36m00026387[0m [1982112704] [34mhotplug_libusb.c:538:HPAddHotPluggable() Adding USB device: 1:11:0[0m
[36m00003831[0m [1982112704] [34mreaderfactory.c:1075:RFInitializeReader() Attempting startup of HID OMNIKEY 5427 CK (01010053484D37353001395E34176930) 00 00 using /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so[0m
[36m00000944[0m [1982112704] [34mreaderfactory.c:950:RFBindFunctions() Loading IFD Handler 3.0[0m
[36m00000191[0m [1982112704] [34mifdhandler.c:2008:init_driver() Driver version: 1.4.33[0m
[36m00007374[0m [1982112704] [34mifdhandler.c:2025:init_driver() LogLevel: 0x0003[0m
[36m00000048[0m [1982112704] [34mifdhandler.c:2036:init_driver() DriverOptions: 0x0000[0m
[36m00001435[0m [1982112704] [34mifdhandler.c:2049:init_driver() LogLevel from LIBCCID_ifdLogLevel: 0x000F[0m
[36m00000044[0m [1982112704] [34mifdhandler.c:110:CreateChannelByNameOrChannel() Lun: 0, device: usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0[0m
[36m00000055[0m [1982112704] ccid_usb.c:237:OpenUSBByName() Reader index: 0, Device: usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0
[36m00000064[0m [1982112704] [34mccid_usb.c:302:OpenUSBByName() Using: /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist[0m
[36m00007404[0m [1982112704] [34mccid_usb.c:320:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau (ludovic.rousseau at free.fr)[0m
[36m00000050[0m [1982112704] [34mccid_usb.c:321:OpenUSBByName() ifdProductString: Generic CCID driver[0m
[36m00000034[0m [1982112704] [34mccid_usb.c:322: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
[36m00011281[0m [1982112704] ccid_usb.c:406:OpenUSBByName() Try device: 1/11
[36m00000050[0m [1982112704] ccid_usb.c:416:OpenUSBByName() vid/pid : 076B/5427
[36m00000021[0m [1982112704] ccid_usb.c:483:OpenUSBByName() Checking device: 1/11
[36m00000022[0m [1982112704] ccid_usb.c:554:OpenUSBByName() Trying to open USB bus/device: 1/11
[36m00000431[0m [1982112704] [34mccid_usb.c:660:OpenUSBByName() Found Vendor/Product: 076B/5427 (HID OMNIKEY 5427 CK)[0m
[36m00000025[0m [1982112704] [34mccid_usb.c:662:OpenUSBByName() Using USB bus/device: 1/11[0m
[36m00000022[0m [1982112704] [34mccid_usb.c:722:OpenUSBByName() bNumDataRatesSupported is 0[0m
[36m00004629[0m [1982112704] ccid_usb.c:1327:InterruptRead() before (0), timeout: 100 ms
[36m00100275[0m [1982112704] ccid_usb.c:1373:InterruptRead() after (0) (2)
[36m00000080[0m [1982112704] -> 000000 65 00 00 00 00 00 00 00 00 00
[36m00205778[0m [1982112704] <- 000000 81 00 00 00 00 00 00 01 00 01
[36m00000073[0m [1982112704] -> 000000 65 00 00 00 00 00 01 00 00 00
[36m00000790[0m [1982112704] <- 000000 81 00 00 00 00 00 01 01 00 01
[36m00000052[0m [1982112704] [34mifdhandler.c:381:IFDHGetCapabilities() tag: 0xFB3, usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)[0m
[36m00000028[0m [1982112704] [34mreaderfactory.c:396:RFAddReader() Using the reader polling thread[0m
[36m00000025[0m [1982112704] ifdhandler.c:1868:IFDHICCPresence() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)
[36m00000037[0m [1982112704] -> 000000 65 00 00 00 00 00 02 00 00 00
[36m00000717[0m [1982112704] <- 000000 81 00 00 00 00 00 02 01 00 01
[36m00000038[0m [1982112704] ifdhandler.c:1989:IFDHICCPresence() Card present
[36m00000289[0m [1982112704] [34mifdhandler.c:381:IFDHGetCapabilities() tag: 0xFAE, usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)[0m
[36m00000030[0m [1982112704] [34mifdhandler.c:476:IFDHGetCapabilities() Reader supports 1 slot(s)[0m
[36m00000044[0m [1982112704] [34mhotplug_libusb.c:538:HPAddHotPluggable() Adding USB device: 1:11:1[0m
[36m00000030[0m [1963975616] ifdhandler.c:1868:IFDHICCPresence() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)
[36m00000047[0m [1963975616] -> 000000 65 00 00 00 00 00 03 00 00 00
[36m00002089[0m [1963975616] <- 000000 81 00 00 00 00 00 03 01 00 01
[36m00000046[0m [1963975616] ifdhandler.c:1989:IFDHICCPresence() Card present
[36m00000037[0m [1963975616] ifdhandler.c:1868:IFDHICCPresence() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)
[36m00000039[0m [1963975616] -> 000000 65 00 00 00 00 00 04 00 00 00
[36m00001820[0m [1963975616] <- 000000 81 00 00 00 00 00 04 01 00 01
[36m00000037[0m [1963975616] ifdhandler.c:1989:IFDHICCPresence() Card present
[36m00000040[0m [1963975616] [34mifdhandler.c:1167:IFDHPowerICC() action: PowerUp, usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)[0m
[36m00000965[0m [1963975616] -> 000000 62 00 00 00 00 00 05 00 00 00
[36m00217134[0m [1963975616] <- 000000 80 00 00 00 00 00 05 42 FE 00
[36m00000052[0m [1963975616] [35mcommands.c:243:CmdPowerOn Card absent or mute[0m
[36m00000031[0m [1963975616] [01;31mifdhandler.c:1234:IFDHPowerICC() PowerUp failed[0m
[36m00000038[0m [1963975616] eventhandler.c:304:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED
[36m00000038[0m [1982112704] [34mifdhandler.c:381:IFDHGetCapabilities() tag: 0xFAF, usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)[0m
[36m00001226[0m [1963975616] [35meventhandler.c:305:EHStatusHandlerThread() Error powering up card: -2146435050 0x80100016[0m
[36m00000089[0m [1982112704] [34mreaderfactory.c:727:RFSetReaderName() Support 16 simultaneous readers[0m
[36m00000058[0m [1982112704] [34mifdhandler.c:381:IFDHGetCapabilities() tag: 0xFAD, usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)[0m
[36m00000025[0m [1982112704] [34mreaderfactory.c:338:RFAddReader() Driver is thread safe[0m
[36m00000027[0m [1982112704] [34mreaderfactory.c:1075:RFInitializeReader() Attempting startup of HID OMNIKEY 5427 CK (01010053484D37353001395E34176930) 01 00 using /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so[0m
[36m00000023[0m [1982112704] [34mreaderfactory.c:864:RFLoadReader() Reusing already loaded driver for /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Linux/libccid.so[0m
[36m00000078[0m [1982112704] [34mreaderfactory.c:950:RFBindFunctions() Loading IFD Handler 3.0[0m
[36m00000147[0m [1982112704] [34mifdhandler.c:110:CreateChannelByNameOrChannel() Lun: 10000, device: usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if1[0m
[36m00000034[0m [1982112704] ccid_usb.c:237:OpenUSBByName() Reader index: 1, Device: usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if1
[36m00000057[0m [1982112704] [34mccid_usb.c:302:OpenUSBByName() Using: /usr/lib/pcsc/drivers/ifd-ccid.bundle/Contents/Info.plist[0m
[36m00000684[0m [1963975616] ifdhandler.c:1868:IFDHICCPresence() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)
[36m00000072[0m [1963975616] -> 000000 65 00 00 00 00 00 06 00 00 00
[36m00004540[0m [1963975616] <- 000000 81 00 00 00 00 00 06 02 00 01
[36m00000059[0m [1963975616] ifdhandler.c:1989:IFDHICCPresence() Card absent
[36m00000034[0m [1963975616] [34meventhandler.c:358:EHStatusHandlerThread() Card Removed From HID OMNIKEY 5427 CK (01010053484D37353001395E34176930) 00 00[0m
[36m00000030[0m [1963975616] [34mifdhandler.c:310:IFDHPolling() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0) 600000 ms[0m
[36m00000026[0m [1963975616] ccid_usb.c:1327:InterruptRead() before (0), timeout: 600000 ms
[36m00000838[0m [1963975616] ccid_usb.c:1373:InterruptRead() after (0) (0)
[36m00000045[0m [1963975616] NotifySlotChange: 50 02
[36m00000029[0m [1963975616] ifdhandler.c:1868:IFDHICCPresence() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)
[36m00000041[0m [1963975616] -> 000000 65 00 00 00 00 00 07 00 00 00
[36m00000927[0m [1963975616] <- 000000 81 00 00 00 00 00 07 02 00 01
[36m00000047[0m [1963975616] ifdhandler.c:1989:IFDHICCPresence() Card absent
[36m00000030[0m [1963975616] [34mifdhandler.c:310:IFDHPolling() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0) 600000 ms[0m
[36m00000027[0m [1963975616] ccid_usb.c:1327:InterruptRead() before (0), timeout: 600000 ms
[36m00000227[0m [1982112704] [34mccid_usb.c:320:OpenUSBByName() ifdManufacturerString: Ludovic Rousseau (ludovic.rousseau at free.fr)[0m
[36m00000033[0m [1982112704] [34mccid_usb.c:321:OpenUSBByName() ifdProductString: Generic CCID driver[0m
[36m00000028[0m [1982112704] [34mccid_usb.c:322: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
[36m00000593[0m [1982112704] ccid_usb.c:406:OpenUSBByName() Try device: 1/11
[36m00000037[0m [1982112704] ccid_usb.c:416:OpenUSBByName() vid/pid : 076B/5427
[36m00000023[0m [1982112704] ccid_usb.c:483:OpenUSBByName() Checking device: 1/11
[36m00000026[0m [1982112704] [34mccid_usb.c:547:OpenUSBByName() USB device 1/11 already in use. Checking next one.[0m
[36m00000022[0m [1982112704] ccid_usb.c:406:OpenUSBByName() Try device: 1/5
[36m00000022[0m [1982112704] ccid_usb.c:416:OpenUSBByName() vid/pid : 0424/7800
[36m00000021[0m [1982112704] ccid_usb.c:406:OpenUSBByName() Try device: 1/3
[36m00000022[0m [1982112704] ccid_usb.c:416:OpenUSBByName() vid/pid : 0424/2514
[36m00000021[0m [1982112704] ccid_usb.c:406:OpenUSBByName() Try device: 1/2
[36m00000022[0m [1982112704] ccid_usb.c:416:OpenUSBByName() vid/pid : 0424/2514
[36m00000022[0m [1982112704] ccid_usb.c:406:OpenUSBByName() Try device: 1/1
[36m00000022[0m [1982112704] ccid_usb.c:416:OpenUSBByName() vid/pid : 1D6B/0002
[36m00001827[0m [1982112704] [34mccid_usb.c:799:OpenUSBByName() Device not found?[0m
[36m00000040[0m [1982112704] [01;31mifdhandler.c:150:CreateChannelByNameOrChannel() failed[0m
[36m00000031[0m [1982112704] [01;31mreaderfactory.c:1106:RFInitializeReader() Open Port 0x200001 Failed (usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if1)[0m
[36m00000024[0m [1982112704] [35mreaderfactory.c:376:RFAddReader() HID OMNIKEY 5427 CK (01010053484D37353001395E34176930) init failed.[0m
[36m00000032[0m [1982112704] readerfactory.c:610:RFRemoveReader() UnrefReader() count was: 1
[36m00000024[0m [1982112704] [34mreaderfactory.c:1126:RFUnInitializeReader() Attempting shutdown of HID OMNIKEY 5427 CK (01010053484D37353001395E34176930) 01 00.[0m
[36m00001242[0m [1982112704] [34mhotplug_libusb.c:442:HPEstablishUSBNotifications() Driver ifd-ccid.bundle does not support IFD_GENERATE_HOTPLUG. Using active polling instead.[0m
[36m00000038[0m [1982112704] [34mhotplug_libusb.c:451:HPEstablishUSBNotifications() Polling forced every 1 second(s)[0m
[36m06161187[0m [1996345344] winscard_msg_srv.c:256:ProcessEventsServer() Common channel packet arrival
[36m00000168[0m [1996345344] winscard_msg_srv.c:268:ProcessEventsServer() ProcessCommonChannelRequest detects: 6
[36m00000029[0m [1996345344] pcscdaemon.c:133:SVCServiceRunLoop() A new context thread creation is requested: 6
[36m00000301[0m [1953493952] winscard_svc.c:340:ContextThread() Authorized PC/SC client
[36m00000030[0m [1953493952] winscard_svc.c:344:ContextThread() Thread is started: dwClientID=6, threadContext @0x8d9740
[36m00000066[0m [1953493952] winscard_svc.c:362:ContextThread() Received command: CMD_VERSION from client 6
[36m00000065[0m [1953493952] winscard_svc.c:374:ContextThread() Client is protocol version 4:4
[36m00000026[0m [1953493952] winscard_svc.c:396:ContextThread() CMD_VERSION rv=0x0 for client 6
[36m00000917[0m [1953493952] winscard_svc.c:362:ContextThread() Received command: ESTABLISH_CONTEXT from client 6
[36m00000074[0m [1953493952] winscard.c:215:SCardEstablishContext() Establishing Context: 0x67F55A20
[36m00000028[0m [1953493952] winscard_svc.c:461:ContextThread() ESTABLISH_CONTEXT rv=0x0 for client 6
[36m00000421[0m [1953493952] winscard_svc.c:362:ContextThread() Received command: CMD_GET_READERS_STATE from client 6
[36m00000298[0m [1953493952] winscard_svc.c:362:ContextThread() Received command: CMD_GET_READERS_STATE from client 6
[36m00000927[0m [1953493952] winscard_svc.c:362:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 6
[36m00000394[0m [1953493952] winscard_svc.c:834:MSGSendReaderStates() Send reader states: 6
[36m00000261[0m [1953493952] winscard_svc.c:362:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 6
[36m00000034[0m [1953493952] winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 6
[36m00000200[0m [1953493952] winscard_svc.c:362:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 6
[36m00000031[0m [1953493952] winscard_svc.c:834:MSGSendReaderStates() Send reader states: 6
[36m01381723[0m [1963975616] ccid_usb.c:1373:InterruptRead() after (0) (0)
[36m00000066[0m [1963975616] NotifySlotChange: 50 03
[36m00000032[0m [1963975616] ifdhandler.c:1868:IFDHICCPresence() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)
[36m00000040[0m [1963975616] -> 000000 65 00 00 00 00 00 08 00 00 00
[36m00001447[0m [1963975616] <- 000000 81 00 00 00 00 00 08 01 00 01
[36m00000037[0m [1963975616] ifdhandler.c:1989:IFDHICCPresence() Card present
[36m00000028[0m [1963975616] ifdhandler.c:1868:IFDHICCPresence() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)
[36m00000037[0m [1963975616] -> 000000 65 00 00 00 00 00 09 00 00 00
[36m00001115[0m [1963975616] <- 000000 81 00 00 00 00 00 09 01 00 01
[36m00000033[0m [1963975616] ifdhandler.c:1989:IFDHICCPresence() Card present
[36m00000027[0m [1963975616] [34mifdhandler.c:1167:IFDHPowerICC() action: PowerUp, usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)[0m
[36m00000038[0m [1963975616] -> 000000 62 00 00 00 00 00 0A 00 00 00
[36m00255935[0m [1963975616] <- 000000 80 14 00 00 00 00 0A 00 00 00 3B 8F 80 01 80 4F 0C A0 00 00 03 06 03 00 01 00 00 00 00 6A
[36m00000096[0m [1963975616] eventhandler.c:406:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
[36m00000027[0m [1963975616] [34meventhandler.c:423:EHStatusHandlerThread() Card inserted into HID OMNIKEY 5427 CK (01010053484D37353001395E34176930) 00 00[0m
[36m00000025[0m [1963975616] winscard_svc.c:822:MSGSignalClient() Signal client: 6
[36m00000023[0m [1963975616] winscard_svc.c:825:MSGSignalClient() SIGNAL rv=0x0 for client 6
[36m00000098[0m [1963975616] [34mCard ATR: 3B 8F 80 01 80 4F 0C A0 00 00 03 06 03 00 01 00 00 00 00 6A [0m
[36m00000030[0m [1963975616] [34mifdhandler.c:310:IFDHPolling() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0) 5000 ms[0m
[36m00000024[0m [1963975616] ccid_usb.c:1327:InterruptRead() before (0), timeout: 5000 ms
[36m00000084[0m [1953493952] winscard_svc.c:362:ContextThread() Received command: CMD_WAIT_READER_STATE_CHANGE from client 6
[36m00000035[0m [1953493952] winscard_svc.c:834:MSGSendReaderStates() Send reader states: 6
[36m00000183[0m [1953493952] winscard_svc.c:362:ContextThread() Received command: CMD_STOP_WAITING_READER_STATE_CHANGE from client 6
[36m00000031[0m [1953493952] winscard_svc.c:442:ContextThread() CMD_STOP_WAITING_READER_STATE_CHANGE rv=0x0 for client 6
[36m00000433[0m [1953493952] winscard_svc.c:362:ContextThread() Received command: CONNECT from client 6
[36m00000057[0m [1953493952] winscard_svc.c:499:ContextThread() Authorized client for 'HID OMNIKEY 5427 CK (01010053484D37353001395E34176930) 00 00'
[36m00000025[0m [1953493952] winscard.c:259:SCardConnect() Attempting Connect to HID OMNIKEY 5427 CK (01010053484D37353001395E34176930) 00 00 using protocol: 3
[36m00000024[0m [1953493952] readerfactory.c:821:RFReaderInfo() RefReader() count was: 1
[36m00000023[0m [1953493952] winscard.c:352:SCardConnect() powerState: POWER_STATE_IN_USE
[36m00000026[0m [1953493952] [34mprothandler.c:108:PHSetProtocol() Attempting PTS to T=1[0m
[36m00000030[0m [1953493952] [34mifdhandler.c:708:IFDHSetProtocolParameters() protocol T=1, usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)[0m
[36m00000034[0m [1953493952] ifdhandler.c:1030:IFDHSetProtocolParameters() Timeout: 167723 ms
[36m00000023[0m [1953493952] commands.c:2265:SetParameters() length: 7 bytes
[36m00000050[0m [1953493952] -> 000000 61 07 00 00 00 00 0B 01 00 00 11 10 00 4D 00 20 00
[36m00003171[0m [1953493952] <- 000000 82 07 00 00 00 00 0B 00 00 01 11 10 00 4D 00 20 00
[36m00000053[0m [1953493952] ifdhandler.c:1100:IFDHSetProtocolParameters() T=1: IFSC=32, IFSD=254
[36m00000033[0m [1953493952] winscard.c:431:SCardConnect() Active Protocol: T=1
[36m00000032[0m [1953493952] winscard.c:456:SCardConnect() hCard Identity: 69e5dda9
[36m00000033[0m [1953493952] winscard.c:518:SCardConnect() UnrefReader() count was: 2
[36m00000030[0m [1953493952] winscard_svc.c:513:ContextThread() CONNECT rv=0x0 for client 6
[36m00001438[0m [1953493952] winscard_svc.c:362:ContextThread() Received command: CMD_GET_READERS_STATE from client 6
[36m00000420[0m [1953493952] winscard_svc.c:362:ContextThread() Received command: STATUS from client 6
[36m00000062[0m [1953493952] readerfactory.c:848:RFReaderInfoById() RefReader() count was: 1
[36m00000025[0m [1953493952] winscard.c:1300:SCardStatus() UnrefReader() count was: 2
[36m00000025[0m [1953493952] winscard_svc.c:632:ContextThread() STATUS rv=0x0 for client 6
[36m00013245[0m [1953493952] winscard_svc.c:362:ContextThread() Received command: TRANSMIT from client 6
[36m00000105[0m [1953493952] readerfactory.c:848:RFReaderInfoById() RefReader() count was: 1
[36m00000027[0m [1953493952] winscard.c:1595:SCardTransmit() Send Protocol: T=1
[36m00000034[0m [1953493952] [34mAPDU: 00 A4 00 0C 02 3F 00 [0m
[36m00000028[0m [1953493952] [34mifdhandler.c:1316:IFDHTransmitToICC() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)[0m
[36m00000046[0m [1953493952] commands.c:1634:CmdXfrBlockAPDU_extended() T=0 (extended): 7 bytes
[36m00000053[0m [1953493952] -> 000000 6F 07 00 00 00 00 0C 00 00 00 00 A4 00 0C 02 3F 00
[36m00039734[0m [1953493952] <- 000000 80 00 00 00 00 00 0C 40 FE 00
[36m00000069[0m [1953493952] [35mcommands.c:1534:CCID_Receive Card absent or mute[0m
[36m00000024[0m [1953493952] [34mSW: [0m
[36m00000024[0m [1953493952] [35mifdwrapper.c:543:IFDTransmit() Card not transacted: 612[0m
[36m00000024[0m [1953493952] [35mwinscard.c:1620:SCardTransmit() Card not transacted: 0x80100016[0m
[36m00000021[0m [1953493952] winscard.c:1640:SCardTransmit() UnrefReader() count was: 2
[36m00000026[0m [1953493952] winscard_svc.c:685:ContextThread() TRANSMIT rv=0x80100016 for client 6
[36m00003189[0m [1953493952] winscard_svc.c:354:ContextThread() Client die: 6
[36m00000186[0m [1953493952] winscard.c:229:SCardReleaseContext() Releasing Context: 0x67F55A20
[36m00000034[0m [1953493952] readerfactory.c:848:RFReaderInfoById() RefReader() count was: 1
[36m00000026[0m [1953493952] readerfactory.c:848:RFReaderInfoById() RefReader() count was: 2
[36m00000025[0m [1953493952] winscard.c:1300:SCardStatus() UnrefReader() count was: 3
[36m00000065[0m [1953493952] readerfactory.c:848:RFReaderInfoById() RefReader() count was: 2
[36m00000024[0m [1953493952] winscard.c:881:SCardDisconnect() Active Contexts: -1
[36m00000021[0m [1953493952] winscard.c:882:SCardDisconnect() dwDisposition: 1
[36m00000029[0m [1953493952] ifdhandler.c:1868:IFDHICCPresence() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)
[36m00000042[0m [1953493952] -> 000000 65 00 00 00 00 00 0D 00 00 00
[36m00000905[0m [1953493952] <- 000000 81 00 00 00 00 00 0D 00 00 01
[36m00000047[0m [1953493952] ifdhandler.c:1989:IFDHICCPresence() Card present
[36m00000030[0m [1953493952] [34mifdhandler.c:1167:IFDHPowerICC() action: Reset, usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)[0m
[36m00000088[0m [1953493952] -> 000000 62 00 00 00 00 00 0E 00 00 00
[36m00158114[0m [1953493952] <- 000000 80 14 00 00 00 00 0E 00 00 00 3B 8F 80 01 80 4F 0C A0 00 00 03 06 03 00 01 00 00 00 00 6A
[36m00000058[0m [1953493952] winscard.c:920:SCardDisconnect() Reset complete.
[36m00000052[0m [1953493952] Card ATR: 3B 8F 80 01 80 4F 0C A0 00 00 03 06 03 00 01 00 00 00 00 6A
[36m00000083[0m [1953493952] winscard.c:1017:SCardDisconnect() powerState: POWER_STATE_GRACE_PERIOD
[36m00000030[0m [1953493952] [34mifdhandler.c:381:IFDHGetCapabilities() tag: 0xFB2, usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)[0m
[36m00000023[0m [1953493952] [34mwinscard.c:1030:SCardDisconnect() Stopping polling thread[0m
[36m00000024[0m [1953493952] [34mifdhandler.c:346:IFDHStopPolling() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)[0m
[36m00000192[0m [1953493952] winscard.c:1043:SCardDisconnect() UnrefReader() count was: 3
[36m00000049[0m [1963975616] ccid_usb.c:1373:InterruptRead() after (0) (3)
[36m00000051[0m [1963975616] ccid_usb.c:1388:InterruptRead() InterruptRead (1/11): 3
[36m00000003[0m [1953493952] winscard_svc.c:931:MSGRemoveContext() UnrefReader() count was: 2
[36m00000116[0m [1953493952] winscard_svc.c:1057:MSGCleanupClient() Thread is stopping: dwClientID=6, threadContext @0x8d9740
[36m00000059[0m [1953493952] winscard_svc.c:1063:MSGCleanupClient() Freeing SCONTEXT @0x8d9740
[36m00400015[0m [1963975616] eventhandler.c:494:EHStatusHandlerThread() powerState: POWER_STATE_POWERED
[36m00000062[0m [1963975616] ifdhandler.c:1868:IFDHICCPresence() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)
[36m00000043[0m [1963975616] -> 000000 65 00 00 00 00 00 0F 00 00 00
[36m00001910[0m [1963975616] <- 000000 81 00 00 00 00 00 0F 00 00 01
[36m00000044[0m [1963975616] ifdhandler.c:1989:IFDHICCPresence() Card present
[36m00000029[0m [1963975616] [34mifdhandler.c:310:IFDHPolling() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0) 5000 ms[0m
[36m00000028[0m [1963975616] ccid_usb.c:1327:InterruptRead() before (0), timeout: 5000 ms
[36m02945300[0m [1963975616] ccid_usb.c:1373:InterruptRead() after (0) (0)
[36m00000058[0m [1963975616] NotifySlotChange: 50 02
[36m00000038[0m [1963975616] ifdhandler.c:1868:IFDHICCPresence() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)
[36m00000040[0m [1963975616] -> 000000 65 00 00 00 00 00 10 00 00 00
[36m00001827[0m [1963975616] <- 000000 81 00 00 00 00 00 10 02 00 01
[36m00000044[0m [1963975616] ifdhandler.c:1989:IFDHICCPresence() Card absent
[36m00000027[0m [1963975616] eventhandler.c:482:EHStatusHandlerThread() powerState: POWER_STATE_UNPOWERED
[36m00000028[0m [1963975616] ifdhandler.c:1868:IFDHICCPresence() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0)
[36m00000043[0m [1963975616] -> 000000 65 00 00 00 00 00 11 00 00 00
[36m00001838[0m [1963975616] <- 000000 81 00 00 00 00 00 11 02 00 01
[36m00000036[0m [1963975616] ifdhandler.c:1989:IFDHICCPresence() Card absent
[36m00000025[0m [1963975616] [34meventhandler.c:358:EHStatusHandlerThread() Card Removed From HID OMNIKEY 5427 CK (01010053484D37353001395E34176930) 00 00[0m
[36m00000030[0m [1963975616] [34mifdhandler.c:310:IFDHPolling() usb:076b/5427:libhal:/org/freedesktop/Hal/devices/usb_device_076b_5427_serialnotneeded_if0 (lun: 0) 600000 ms[0m
[36m00000105[0m [1963975616] ccid_usb.c:1327:InterruptRead() before (0), timeout: 600000 ms
More information about the pcsclite-muscle
mailing list