Hi all,

I am trying to get opensc pkcs15-init running with muscle applet using
a gemalto card.  I was hoping someone might be able to offer some
help.

I have followed the instructions at
http://www.opensc-project.org/opensc/wiki/MuscleApplet,
but I'm getting stuck at a few places.

I cloned Martin's github code for CardEdge.  Since I'm using javacard
tools that don't support the extended APDU, I removed the specific
code for that and I am able to install the app onto my card fine.

https://github.com/joelhockey/salsa/blob/master/src/main/java/com/musclecard/CardEdge/CardEdge.java

When running the APDUs to select and setup the applet though I had
failures because the Java code is getting a null pointer in the
CardEdge#setup method when it references the pin object which is not
created.

https://github.com/martinpaljak/MuscleApplet/blob/master/src/com/musclecard/CardEdge/CardEdge.java#L422

>From looking at old versions of the CardEdge file at
http://anonscm.debian.org/viewvc/muscleplugins/MCardApplet/CardEdge.java?revision=1.4&view=markup
I figured that the applet constructor should probably initialise the
'pins' array and create the pins[0] object.

I have made that change and I'm able to setup the applet now.

I installed the latest windows opensc (0.12.2) and ran 'pkcs15-init
-C', however it fails with the log shown below.

I noticed that the profiles directory does not include
'muscle.profile', so I reverted back to 0.12.0 that I found on the
website which got a little further in that it prompted me for
passwords.  Output for 0.12.0 is below.

In both cases, I can see the APDU with ins 0x58 to list objects, and I
can see the code in muscle applet that returns SW 9c12 since it has no
objects.

I'd love to hear if anyone has suggestions.  I would like to
initialise the applet, load some keys and then use firefox and my
smartcard to do a client ssl connection.

Thanks,

Joel

=====
output from 0.12.2
=====


2011-12-03 01:13:53.711 [pkcs15-init] sc.c:195:sc_detect_card_presence: called
2011-12-03 01:13:53.712 [pkcs15-init]
reader-pcsc.c:364:pcsc_detect_card_presence: called
2011-12-03 01:13:53.712 Gemplus USB Smart Card Reader 0 check
2011-12-03 01:13:53.712 [pkcs15-init]
reader-pcsc.c:293:refresh_attributes: returning with: 0 (Success)
2011-12-03 01:13:53.712 [pkcs15-init]
reader-pcsc.c:369:pcsc_detect_card_presence: returning with: 5
2011-12-03 01:13:53.712 [pkcs15-init]
sc.c:200:sc_detect_card_presence: returning with: 5
2011-12-03 01:13:53.712 [pkcs15-init] card.c:115:sc_connect_card: called
2011-12-03 01:13:53.712 [pkcs15-init] reader-pcsc.c:444:pcsc_connect: called
2011-12-03 01:13:53.712 Gemplus USB Smart Card Reader 0 check
2011-12-03 01:13:53.713 [pkcs15-init]
reader-pcsc.c:293:refresh_attributes: returning with: 0 (Success)
2011-12-03 01:13:53.713 Initial protocol: T=1
2011-12-03 01:13:53.713 ATR     :
3b:fd:96:00:00:81:31:80:43:80:31:80:65:b0:85:01:00:d6:83:01:90:00:bc
2011-12-03 01:13:53.713 ATR try :
3b:6e:00:ff:45:73:74:45:49:44:20:76:65:72:20:31:2e:30
2011-12-03 01:13:53.713 ignored - wrong length

... (lots of ATR checking) ...

2011-12-03 01:13:53.717 ATR try :
3b:9f:94:80:1f:c3:00:68:11:44:05:01:46:49:53:45:31:c8:00:00:00:00
2011-12-03 01:13:53.717 ignored - wrong length
2011-12-03 01:13:53.717 [pkcs15-init] apdu.c:525:sc_transmit_apdu: called
2011-12-03 01:13:53.717 [pkcs15-init] card.c:292:sc_lock: called
2011-12-03 01:13:53.718 [pkcs15-init] reader-pcsc.c:511:pcsc_lock: called
2011-12-03 01:13:53.718 reader 'Gemplus USB Smart Card Reader 0'
2011-12-03 01:13:53.718
Outgoing APDU data [    5 bytes] =====================================
00 CA DF 30 05 ...0.
======================================================================
2011-12-03 01:13:53.718 [pkcs15-init]
reader-pcsc.c:176:pcsc_internal_transmit: called
2011-12-03 01:13:53.738
Incoming APDU data [    2 bytes] =====================================
6E 00 n.
======================================================================
2011-12-03 01:13:53.738 [pkcs15-init] card.c:330:sc_unlock: called
2011-12-03 01:13:53.738 [pkcs15-init] reader-pcsc.c:548:pcsc_unlock: called
2011-12-03 01:13:53.738 [pkcs15-init] apdu.c:525:sc_transmit_apdu: called
2011-12-03 01:13:53.738 [pkcs15-init] card.c:292:sc_lock: called
2011-12-03 01:13:53.738 [pkcs15-init] reader-pcsc.c:511:pcsc_lock: called
2011-12-03 01:13:53.738 reader 'Gemplus USB Smart Card Reader 0'
2011-12-03 01:13:53.738
Outgoing APDU data [   10 bytes] =====================================
00 A4 04 00 05 A0 00 00 00 01 ..........
======================================================================
2011-12-03 01:13:53.738 [pkcs15-init]
reader-pcsc.c:176:pcsc_internal_transmit: called
2011-12-03 01:13:53.751
Incoming APDU data [    2 bytes] =====================================
90 00 ..
======================================================================
2011-12-03 01:13:53.751 [pkcs15-init] card.c:330:sc_unlock: called
2011-12-03 01:13:53.751 [pkcs15-init] reader-pcsc.c:548:pcsc_unlock: called
2011-12-03 01:13:53.751 [pkcs15-init] apdu.c:525:sc_transmit_apdu: called
2011-12-03 01:13:53.751 [pkcs15-init] card.c:292:sc_lock: called
2011-12-03 01:13:53.751 [pkcs15-init] reader-pcsc.c:511:pcsc_lock: called
2011-12-03 01:13:53.751 reader 'Gemplus USB Smart Card Reader 0'
2011-12-03 01:13:53.751
Outgoing APDU data [    5 bytes] =====================================
B0 3C 00 00 40 .<..@
======================================================================
2011-12-03 01:13:53.751 [pkcs15-init]
reader-pcsc.c:176:pcsc_internal_transmit: called
2011-12-03 01:13:53.764
Incoming APDU data [   18 bytes] =====================================
01 03 00 09 00 00 17 70 00 00 17 6E 02 00 00 00 .......p...n....
90 00                                           ..
======================================================================
2011-12-03 01:13:53.764 [pkcs15-init] card.c:330:sc_unlock: called
2011-12-03 01:13:53.764 [pkcs15-init] reader-pcsc.c:548:pcsc_unlock: called
2011-12-03 01:13:53.764 ATR     :
3b:fd:96:00:00:81:31:80:43:80:31:80:65:b0:85:01:00:d6:83:01:90:00:bc
2011-12-03 01:13:53.764 ATR try : 3b:d5:18:00:81:31:3a:7d:80:73:c8:21:10:30
2011-12-03 01:13:53.764 ignored - wrong length
2011-12-03 01:13:53.764 ATR try :
3b:f8:13:00:00:81:31:fe:45:4a:43:4f:50:76:32:34:31:b7
2011-12-03 01:13:53.764 ignored - wrong length
2011-12-03 01:13:53.764 ATR try : 3b:88:80:01:4a:43:4f:50:76:32:34:31:5e
2011-12-03 01:13:53.764 ignored - wrong length
2011-12-03 01:13:53.764 card info name:'MuscleApplet', type:15002,
flags:0x2, max_send/recv_size:0/0
2011-12-03 01:13:53.764 [pkcs15-init] card.c:225:sc_connect_card:
returning with: 0 (Success)
2011-12-03 01:13:53.764 [pkcs15-init] card.c:292:sc_lock: called
2011-12-03 01:13:53.764 [pkcs15-init] reader-pcsc.c:511:pcsc_lock: called
2011-12-03 01:13:53.764 [pkcs15-init]
pkcs15-lib.c:296:sc_pkcs15init_bind: called
2011-12-03 01:13:53.764 [pkcs15-init] card.c:720:sc_card_ctl: called
2011-12-03 01:13:53.764 card_ctl(4) not supported
2011-12-03 01:13:53.764 called; type=2, path=3f0050154946
2011-12-03 01:13:53.764 [pkcs15-init] apdu.c:525:sc_transmit_apdu: called
2011-12-03 01:13:53.764 [pkcs15-init] card.c:292:sc_lock: called
2011-12-03 01:13:53.764 reader 'Gemplus USB Smart Card Reader 0'
2011-12-03 01:13:53.764
Outgoing APDU data [    5 bytes] =====================================
B0 58 00 00 0E .X...
======================================================================
2011-12-03 01:13:53.764 [pkcs15-init]
reader-pcsc.c:176:pcsc_internal_transmit: called
2011-12-03 01:13:53.771
Incoming APDU data [    2 bytes] =====================================
9C 12 ..
======================================================================
2011-12-03 01:13:53.771 [pkcs15-init] card.c:330:sc_unlock: called
2011-12-03 01:13:53.771 [pkcs15-init] apdu.c:525:sc_transmit_apdu: called
2011-12-03 01:13:53.771 [pkcs15-init] card.c:292:sc_lock: called
2011-12-03 01:13:53.771 reader 'Gemplus USB Smart Card Reader 0'
2011-12-03 01:13:53.771
Outgoing APDU data [    5 bytes] =====================================
B0 58 00 00 0E .X...
======================================================================
2011-12-03 01:13:53.771 [pkcs15-init]
reader-pcsc.c:176:pcsc_internal_transmit: called
2011-12-03 01:13:53.776
Incoming APDU data [    2 bytes] =====================================
9C 12 ..
======================================================================
2011-12-03 01:13:53.778 [pkcs15-init] card.c:330:sc_unlock: called
2011-12-03 01:13:53.778 [pkcs15-init] card-muscle.c:371:select_item:
returning with: -1201 (File not found)
2011-12-03 01:13:53.778 [pkcs15-init]
card-muscle.c:440:muscle_select_file: returning with: -1201 (File not
found)
2011-12-03 01:13:53.778 [pkcs15-init] card.c:597:sc_select_file:
returning with: -1201 (File not found)
2011-12-03 01:13:53.778 [pkcs15-init] profile.c:327:sc_profile_load: called
2011-12-03 01:13:53.778 Using profile directory 'C:\Program
Files\OpenSC Project\OpenSC\profiles'.
2011-12-03 01:13:53.778 Trying profile file C:\Program Files\OpenSC
Project\OpenSC\profiles\pkcs15.profile
2011-12-03 01:13:53.779 profile C:\Program Files\OpenSC
Project\OpenSC\profiles\pkcs15.profile loaded ok
2011-12-03 01:13:53.779 [pkcs15-init] profile.c:380:sc_profile_load:
returning with: 0 (Success)
2011-12-03 01:13:53.779 [pkcs15-init] profile.c:327:sc_profile_load: called
2011-12-03 01:13:53.779 Using profile directory 'C:\Program
Files\OpenSC Project\OpenSC\profiles'.
2011-12-03 01:13:53.779 Trying profile file C:\Program Files\OpenSC
Project\OpenSC\profiles\muscle.profile
2011-12-03 01:13:53.779 profile C:\Program Files\OpenSC
Project\OpenSC\profiles\muscle.profile loaded ok
2011-12-03 01:13:53.779 [pkcs15-init] profile.c:373:sc_profile_load:
returning with: -1201 (File not found)
2011-12-03 01:13:53.779 Failed to load profile 'muscle': File not found
2011-12-03 01:13:53.779 [pkcs15-init]
pkcs15-lib.c:374:sc_pkcs15init_bind: Load profile error: -1201 (File
not found)


=====
output from 0.12.0
=====

2011-12-03 01:18:36.431 [pkcs15-init] sc.c:185:sc_detect_card_presence: called
2011-12-03 01:18:36.432 [pkcs15-init]
reader-pcsc.c:357:pcsc_detect_card_presence: called
2011-12-03 01:18:36.432 [pkcs15-init]
reader-pcsc.c:276:refresh_attributes: Gemplus USB Smart Card Reader 0
check
2011-12-03 01:18:36.432 [pkcs15-init]
reader-pcsc.c:299:refresh_attributes: current  state: 0x00080122
2011-12-03 01:18:36.432 [pkcs15-init]
reader-pcsc.c:300:refresh_attributes: previous state: 0x00080122
2011-12-03 01:18:36.432 [pkcs15-init]
reader-pcsc.c:349:refresh_attributes: card present
2011-12-03 01:18:36.432 [pkcs15-init]
reader-pcsc.c:362:pcsc_detect_card_presence: returning with: 1
2011-12-03 01:18:36.432 [pkcs15-init]
sc.c:190:sc_detect_card_presence: returning with: 1
2011-12-03 01:18:36.432 [pkcs15-init] card.c:115:sc_connect_card: called
2011-12-03 01:18:36.432 [pkcs15-init] reader-pcsc.c:436:pcsc_connect: called
2011-12-03 01:18:36.432 [pkcs15-init]
reader-pcsc.c:276:refresh_attributes: Gemplus USB Smart Card Reader 0
check
2011-12-03 01:18:36.433 [pkcs15-init]
reader-pcsc.c:299:refresh_attributes: current  state: 0x00080122
2011-12-03 01:18:36.433 [pkcs15-init]
reader-pcsc.c:300:refresh_attributes: previous state: 0x00080122
2011-12-03 01:18:36.433 [pkcs15-init]
reader-pcsc.c:349:refresh_attributes: card present
2011-12-03 01:18:36.434 [pkcs15-init] reader-pcsc.c:465:pcsc_connect:
Initial protocol: T=1
2011-12-03 01:18:36.434 [pkcs15-init] card.c:785:match_atr_table: ATR
   : 3b:fd:96:00:00:81:31:80:43:80:31:80:65:b0:85:01:00:d6:83:01:90:00:bc
2011-12-03 01:18:36.434 [pkcs15-init] card.c:796:match_atr_table: ATR
try : 3b:6e:00:ff:45:73:74:45:49:44:20:76:65:72:20:31:2e:30
2011-12-03 01:18:36.434 [pkcs15-init] card.c:799:match_atr_table:
ignored - wrong length

... (lots of ATR checking) ...

2011-12-03 01:18:36.440 [pkcs15-init] apdu.c:527:sc_transmit_apdu: called
2011-12-03 01:18:36.440 [pkcs15-init] card.c:295:sc_lock: called
2011-12-03 01:18:36.440 [pkcs15-init] reader-pcsc.c:503:pcsc_lock: called
2011-12-03 01:18:36.440 [pkcs15-init] reader-pcsc.c:242:pcsc_transmit:
reader 'Gemplus USB Smart Card Reader 0'
2011-12-03 01:18:36.440 [pkcs15-init] apdu.c:187:sc_apdu_log:
Outgoing APDU data [    5 bytes] =====================================
00 CA DF 30 05 ...0.
======================================================================
2011-12-03 01:18:36.440 [pkcs15-init]
reader-pcsc.c:175:pcsc_internal_transmit: called
2011-12-03 01:18:36.459 [pkcs15-init] apdu.c:187:sc_apdu_log:
Incoming APDU data [    2 bytes] =====================================
6E 00 n.
======================================================================
2011-12-03 01:18:36.459 [pkcs15-init] card.c:329:sc_unlock: called
2011-12-03 01:18:36.459 [pkcs15-init] reader-pcsc.c:540:pcsc_unlock: called
2011-12-03 01:18:36.460 [pkcs15-init] apdu.c:527:sc_transmit_apdu: called
2011-12-03 01:18:36.460 [pkcs15-init] card.c:295:sc_lock: called
2011-12-03 01:18:36.460 [pkcs15-init] reader-pcsc.c:503:pcsc_lock: called
2011-12-03 01:18:36.460 [pkcs15-init] reader-pcsc.c:242:pcsc_transmit:
reader 'Gemplus USB Smart Card Reader 0'
2011-12-03 01:18:36.460 [pkcs15-init] apdu.c:187:sc_apdu_log:
Outgoing APDU data [   10 bytes] =====================================
00 A4 04 00 05 A0 00 00 00 01 ..........
======================================================================
2011-12-03 01:18:36.460 [pkcs15-init]
reader-pcsc.c:175:pcsc_internal_transmit: called
2011-12-03 01:18:36.472 [pkcs15-init] apdu.c:187:sc_apdu_log:
Incoming APDU data [    2 bytes] =====================================
90 00 ..
======================================================================
2011-12-03 01:18:36.472 [pkcs15-init] card.c:329:sc_unlock: called
2011-12-03 01:18:36.473 [pkcs15-init] reader-pcsc.c:540:pcsc_unlock: called
2011-12-03 01:18:36.473 [pkcs15-init] apdu.c:527:sc_transmit_apdu: called
2011-12-03 01:18:36.473 [pkcs15-init] card.c:295:sc_lock: called
2011-12-03 01:18:36.473 [pkcs15-init] reader-pcsc.c:503:pcsc_lock: called
2011-12-03 01:18:36.473 [pkcs15-init] reader-pcsc.c:242:pcsc_transmit:
reader 'Gemplus USB Smart Card Reader 0'
2011-12-03 01:18:36.473 [pkcs15-init] apdu.c:187:sc_apdu_log:
Outgoing APDU data [    5 bytes] =====================================
B0 3C 00 00 40 .<..@
======================================================================
2011-12-03 01:18:36.473 [pkcs15-init]
reader-pcsc.c:175:pcsc_internal_transmit: called
2011-12-03 01:18:36.486 [pkcs15-init] apdu.c:187:sc_apdu_log:
Incoming APDU data [   18 bytes] =====================================
01 03 00 09 00 00 17 70 00 00 17 6E 02 00 00 00 .......p...n....
90 00                                           ..
======================================================================
2011-12-03 01:18:36.486 [pkcs15-init] card.c:329:sc_unlock: called
2011-12-03 01:18:36.487 [pkcs15-init] reader-pcsc.c:540:pcsc_unlock: called
2011-12-03 01:18:36.487 [pkcs15-init] card.c:785:match_atr_table: ATR
   : 3b:fd:96:00:00:81:31:80:43:80:31:80:65:b0:85:01:00:d6:83:01:90:00:bc
2011-12-03 01:18:36.487 [pkcs15-init] card.c:796:match_atr_table: ATR
try : 3b:d5:18:00:81:31:3a:7d:80:73:c8:21:10:30
2011-12-03 01:18:36.487 [pkcs15-init] card.c:799:match_atr_table:
ignored - wrong length
2011-12-03 01:18:36.487 [pkcs15-init] card.c:796:match_atr_table: ATR
try : 3b:f8:13:00:00:81:31:fe:45:4a:43:4f:50:76:32:34:31:b7
2011-12-03 01:18:36.487 [pkcs15-init] card.c:799:match_atr_table:
ignored - wrong length
2011-12-03 01:18:36.487 [pkcs15-init] card.c:796:match_atr_table: ATR
try : 3b:88:80:01:4a:43:4f:50:76:32:34:31:5e
2011-12-03 01:18:36.487 [pkcs15-init] card.c:799:match_atr_table:
ignored - wrong length
2011-12-03 01:18:36.487 [pkcs15-init] card.c:232:sc_connect_card: card
info: MuscleApplet, 15002, 0x3
2011-12-03 01:18:36.487 [pkcs15-init] card.c:233:sc_connect_card:
returning with: 0 (Success)
2011-12-03 01:18:36.487 [pkcs15-init] card.c:295:sc_lock: called
2011-12-03 01:18:36.487 [pkcs15-init] reader-pcsc.c:503:pcsc_lock: called
2011-12-03 01:18:36.487 [pkcs15-init]
pkcs15-lib.c:290:sc_pkcs15init_bind: called
2011-12-03 01:18:36.487 [pkcs15-init] card.c:676:sc_card_ctl: called
2011-12-03 01:18:36.488 [pkcs15-init] card.c:683:sc_card_ctl:
card_ctl(4) not supported
2011-12-03 01:18:36.488 [pkcs15-init] card.c:548:sc_select_file:
called; type=2, path=3f0050154946
2011-12-03 01:18:36.488 [pkcs15-init] apdu.c:527:sc_transmit_apdu: called
2011-12-03 01:18:36.488 [pkcs15-init] card.c:295:sc_lock: called
2011-12-03 01:18:36.488 [pkcs15-init] reader-pcsc.c:242:pcsc_transmit:
reader 'Gemplus USB Smart Card Reader 0'
2011-12-03 01:18:36.488 [pkcs15-init] apdu.c:187:sc_apdu_log:
Outgoing APDU data [    5 bytes] =====================================
B0 58 00 00 0E .X...
======================================================================
2011-12-03 01:18:36.488 [pkcs15-init]
reader-pcsc.c:175:pcsc_internal_transmit: called
2011-12-03 01:18:36.493 [pkcs15-init] apdu.c:187:sc_apdu_log:
Incoming APDU data [    2 bytes] =====================================
9C 12 ..
======================================================================
2011-12-03 01:18:36.494 [pkcs15-init] card.c:329:sc_unlock: called
2011-12-03 01:18:36.494 [pkcs15-init] apdu.c:527:sc_transmit_apdu: called
2011-12-03 01:18:36.494 [pkcs15-init] card.c:295:sc_lock: called
2011-12-03 01:18:36.494 [pkcs15-init] reader-pcsc.c:242:pcsc_transmit:
reader 'Gemplus USB Smart Card Reader 0'
2011-12-03 01:18:36.494 [pkcs15-init] apdu.c:187:sc_apdu_log:
Outgoing APDU data [    5 bytes] =====================================
B0 58 00 00 0E .X...
======================================================================
2011-12-03 01:18:36.494 [pkcs15-init]
reader-pcsc.c:175:pcsc_internal_transmit: called
2011-12-03 01:18:36.499 [pkcs15-init] apdu.c:187:sc_apdu_log:
Incoming APDU data [    2 bytes] =====================================
9C 12 ..
======================================================================
2011-12-03 01:18:36.499 [pkcs15-init] card.c:329:sc_unlock: called
2011-12-03 01:18:36.499 [pkcs15-init] card-muscle.c:371:select_item:
returning with: -1201 (File not found)
2011-12-03 01:18:36.499 [pkcs15-init]
card-muscle.c:440:muscle_select_file: returning with: -1201 (File not
found)
2011-12-03 01:18:36.500 [pkcs15-init] card.c:569:sc_select_file:
returning with: -1201 (File not found)
2011-12-03 01:18:36.500 [pkcs15-init] profile.c:353:sc_profile_load:
Using profile directory 'C:\Program Files\OpenSC
Project\OpenSC\profiles'.
2011-12-03 01:18:36.500 [pkcs15-init] profile.c:364:sc_profile_load:
Trying profile file C:\Program Files\OpenSC
Project\OpenSC\profiles\pkcs15.profile
2011-12-03 01:18:36.502 [pkcs15-init] profile.c:370:sc_profile_load:
profile C:\Program Files\OpenSC Project\OpenSC\profiles\pkcs15.profile
loaded ok
2011-12-03 01:18:36.502 [pkcs15-init] profile.c:353:sc_profile_load:
Using profile directory 'C:\Program Files\OpenSC
Project\OpenSC\profiles'.
2011-12-03 01:18:36.502 [pkcs15-init] profile.c:364:sc_profile_load:
Trying profile file C:\Program Files\OpenSC
Project\OpenSC\profiles\muscle.profile
2011-12-03 01:18:36.503 [pkcs15-init] profile.c:370:sc_profile_load:
profile C:\Program Files\OpenSC Project\OpenSC\profiles\muscle.profile
loaded ok
2011-12-03 01:18:36.504 [pkcs15-init]
pkcs15-lib.c:374:sc_pkcs15init_bind: returning with: 0 (Success)
2011-12-03 01:18:43.458 [pkcs15-init]
pkcs15-lib.c:653:sc_pkcs15init_add_app: called
2011-12-03 01:18:43.480 [pkcs15-init]
pkcs15-lib.c:713:sc_pkcs15init_add_app: Add virtual SO_PIN('User
PIN',flags:12,reference:1,path:'3f005015')
2011-12-03 01:18:43.495 [pkcs15-init] card.c:548:sc_select_file:
called; type=2, path=3f00
2011-12-03 01:18:43.495 [pkcs15-init] apdu.c:527:sc_transmit_apdu: called
2011-12-03 01:18:43.495 [pkcs15-init] card.c:295:sc_lock: called
2011-12-03 01:18:43.495 [pkcs15-init] reader-pcsc.c:242:pcsc_transmit:
reader 'Gemplus USB Smart Card Reader 0'
2011-12-03 01:18:43.495 [pkcs15-init] apdu.c:187:sc_apdu_log:
Outgoing APDU data [    5 bytes] =====================================
B0 58 00 00 0E .X...
======================================================================
2011-12-03 01:18:43.495 [pkcs15-init]
reader-pcsc.c:175:pcsc_internal_transmit: called
2011-12-03 01:18:43.502 [pkcs15-init] apdu.c:187:sc_apdu_log:
Incoming APDU data [    2 bytes] =====================================
9C 12 ..
======================================================================
2011-12-03 01:18:43.502 [pkcs15-init] card.c:329:sc_unlock: called
2011-12-03 01:18:43.502 [pkcs15-init] apdu.c:527:sc_transmit_apdu: called
2011-12-03 01:18:43.502 [pkcs15-init] card.c:295:sc_lock: called
2011-12-03 01:18:43.502 [pkcs15-init] reader-pcsc.c:242:pcsc_transmit:
reader 'Gemplus USB Smart Card Reader 0'
2011-12-03 01:18:43.502 [pkcs15-init] apdu.c:187:sc_apdu_log:
Outgoing APDU data [    5 bytes] =====================================
B0 58 00 00 0E .X...
======================================================================
2011-12-03 01:18:43.502 [pkcs15-init]
reader-pcsc.c:175:pcsc_internal_transmit: called
2011-12-03 01:18:43.508 [pkcs15-init] apdu.c:187:sc_apdu_log:
Incoming APDU data [    2 bytes] =====================================
9C 12 ..
======================================================================
2011-12-03 01:18:43.508 [pkcs15-init] card.c:329:sc_unlock: called
2011-12-03 01:18:43.508 [pkcs15-init]
card-muscle.c:440:muscle_select_file: returning with: 0 (Success)
2011-12-03 01:18:43.508 [pkcs15-init] card.c:569:sc_select_file:
returning with: 0 (Success)
2011-12-03 01:18:43.508 [pkcs15-init]
pkcs15-lib.c:3095:sc_pkcs15init_authenticate: called
2011-12-03 01:18:43.508 [pkcs15-init]
pkcs15-lib.c:3100:sc_pkcs15init_authenticate: path=3f00, op=3
2011-12-03 01:18:43.508 [pkcs15-init]
pkcs15-lib.c:3111:sc_pkcs15init_authenticate: r:[0x00000000]
2011-12-03 01:18:43.508 [pkcs15-init]
pkcs15-lib.c:3112:sc_pkcs15init_authenticate: acl:[0x0086d758]
2011-12-03 01:18:43.508 [pkcs15-init]
pkcs15-lib.c:3127:sc_pkcs15init_authenticate: verify
acl(method:1,reference:1)
2011-12-03 01:18:43.509 [pkcs15-init]
pkcs15-lib.c:2966:sc_pkcs15init_verify_secret: called
2011-12-03 01:18:43.509 [pkcs15-init]
pkcs15-lib.c:2970:sc_pkcs15init_verify_secret: get and verify
PIN('PIN',type:0x1,reference:0x1)
2011-12-03 01:18:43.509 [pkcs15-init]
pkcs15-lib.c:1601:sc_pkcs15init_get_pin_reference: called
2011-12-03 01:18:43.509 [pkcs15-init]
pkcs15.c:906:__sc_pkcs15_search_objects: called; class=0x00,
type=0x601
2011-12-03 01:18:43.509 [pkcs15-init]
pkcs15.c:968:__sc_pkcs15_search_objects: returning with: 1
2011-12-03 01:18:43.509 [pkcs15-init]
pkcs15-lib.c:1611:sc_pkcs15init_get_pin_reference: found 1 auth
objects; looking for AUTH object(auth_method:1,reference:1)
2011-12-03 01:18:43.509 [pkcs15-init]
pkcs15-lib.c:1617:sc_pkcs15init_get_pin_reference: check PIN(User
PIN,auth_method:1,type:1,reference:1,flags:12)
2011-12-03 01:18:43.509 [pkcs15-init]
pkcs15-lib.c:1620:sc_pkcs15init_get_pin_reference: returning with: 1
2011-12-03 01:18:43.509 [pkcs15-init]
pkcs15-lib.c:2977:sc_pkcs15init_verify_secret: found PIN reference 1
2011-12-03 01:18:43.509 [pkcs15-init]
pkcs15.c:906:__sc_pkcs15_search_objects: called; class=0x00,
type=0x601
2011-12-03 01:18:43.509 [pkcs15-init]
pkcs15.c:968:__sc_pkcs15_search_objects: returning with: 1
2011-12-03 01:18:43.509 [pkcs15-init]
pkcs15.c:906:__sc_pkcs15_search_objects: called; class=0x00,
type=0x601
2011-12-03 01:18:43.509 [pkcs15-init]
pkcs15.c:968:__sc_pkcs15_search_objects: returning with: 1
2011-12-03 01:18:43.509 [pkcs15-init]
pkcs15-lib.c:3003:sc_pkcs15init_verify_secret: found PIN object 'User
PIN'
2011-12-03 01:18:43.509 [pkcs15-init]
pkcs15-lib.c:3008:sc_pkcs15init_verify_secret: PIN object 'User PIN';
pin_obj->content.len:0
2011-12-03 01:18:46.190 [pkcs15-init]
pkcs15-lib.c:3026:sc_pkcs15init_verify_secret: 'get_pin' callback
returned 0; pinsize:8
2011-12-03 01:18:46.190 [pkcs15-init]
pkcs15-pin.c:218:sc_pkcs15_verify_pin: called
2011-12-03 01:18:46.216 [pkcs15-init]
pkcs15-pin.c:219:sc_pkcs15_verify_pin: PIN(0x22f620;len:8)
2011-12-03 01:18:46.216 [pkcs15-init] card.c:295:sc_lock: called
2011-12-03 01:18:46.216 [pkcs15-init] card.c:548:sc_select_file:
called; type=2, path=3f005015
2011-12-03 01:18:46.216 [pkcs15-init] apdu.c:527:sc_transmit_apdu: called
2011-12-03 01:18:46.216 [pkcs15-init] card.c:295:sc_lock: called
2011-12-03 01:18:46.216 [pkcs15-init] reader-pcsc.c:242:pcsc_transmit:
reader 'Gemplus USB Smart Card Reader 0'
2011-12-03 01:18:46.216 [pkcs15-init] apdu.c:187:sc_apdu_log:
Outgoing APDU data [    5 bytes] =====================================
B0 58 00 00 0E .X...
======================================================================
2011-12-03 01:18:46.216 [pkcs15-init]
reader-pcsc.c:175:pcsc_internal_transmit: called
2011-12-03 01:18:46.223 [pkcs15-init] apdu.c:187:sc_apdu_log:
Incoming APDU data [    2 bytes] =====================================
9C 12 ..
======================================================================
2011-12-03 01:18:46.223 [pkcs15-init] card.c:329:sc_unlock: called
2011-12-03 01:18:46.223 [pkcs15-init] apdu.c:527:sc_transmit_apdu: called
2011-12-03 01:18:46.223 [pkcs15-init] card.c:295:sc_lock: called
2011-12-03 01:18:46.223 [pkcs15-init] reader-pcsc.c:242:pcsc_transmit:
reader 'Gemplus USB Smart Card Reader 0'
2011-12-03 01:18:46.223 [pkcs15-init] apdu.c:187:sc_apdu_log:
Outgoing APDU data [    5 bytes] =====================================
B0 58 00 00 0E .X...
======================================================================
2011-12-03 01:18:46.223 [pkcs15-init]
reader-pcsc.c:175:pcsc_internal_transmit: called
2011-12-03 01:18:46.229 [pkcs15-init] apdu.c:187:sc_apdu_log:
Incoming APDU data [    2 bytes] =====================================
9C 12 ..
======================================================================
2011-12-03 01:18:46.229 [pkcs15-init] card.c:329:sc_unlock: called
2011-12-03 01:18:46.229 [pkcs15-init] card-muscle.c:371:select_item:
returning with: -1201 (File not found)
2011-12-03 01:18:46.229 [pkcs15-init]
card-muscle.c:440:muscle_select_file: returning with: -1201 (File not
found)
2011-12-03 01:18:46.229 [pkcs15-init] card.c:569:sc_select_file:
returning with: -1201 (File not found)
2011-12-03 01:18:46.229 [pkcs15-init] card.c:329:sc_unlock: called
2011-12-03 01:18:46.229 [pkcs15-init]
pkcs15-lib.c:3046:sc_pkcs15init_verify_secret: Cannot validate pkcs15
PIN: -1201 (File not found)
2011-12-03 01:18:46.229 [pkcs15-init]
pkcs15-lib.c:3134:sc_pkcs15init_authenticate: returning with: -1201
(File not found)
2011-12-03 01:18:46.229 [pkcs15-init]
pkcs15-lib.c:731:sc_pkcs15init_add_app: Create 'DIR' error: -1201
(File not found)
Failed to create PKCS #15 meta structure: File not found
2011-12-03 01:18:46.233 [pkcs15-init] card.c:329:sc_unlock: called
2011-12-03 01:18:46.233 [pkcs15-init] reader-pcsc.c:540:pcsc_unlock: called
2011-12-03 01:18:46.234 [pkcs15-init] card.c:246:sc_disconnect_card: called
2011-12-03 01:18:46.234 [pkcs15-init] reader-pcsc.c:490:pcsc_disconnect: called
2011-12-03 01:18:46.285 [pkcs15-init] card.c:261:sc_disconnect_card:
returning with: 0 (Success)
2011-12-03 01:18:46.285 [pkcs15-init] ctx.c:693:sc_release_context: called
2011-12-03 01:18:46.285 [pkcs15-init] reader-pcsc.c:728:pcsc_finish: called
_______________________________________________
opensc-devel mailing list
opensc-devel@lists.opensc-project.org
http://www.opensc-project.org/mailman/listinfo/opensc-devel

Reply via email to