|
From: Daniel J. <Dan...@e-...> - 2013-07-01 09:34:54
|
Anders,
Thanks for your explanation, My problem with clientToolBox is solved.
But now, I have another problem when I create a CA :
sun.security.pkcs11.wrapper.PKCS11Exception: CKR_FUNCTION_FAILED
Do you see anything ?
I use Jboss 6.1.0, EJBCA 4.0.13 and MySQL 5.1.66.
the log is:
2013-07-01 09:06:18,387 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46975])
Removing old and adding new accessrules and admin entitites to admin group
Public Web Users
2013-07-01 09:06:18,387 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46975])
removing entities and rules for Public Web Users
2013-07-01 09:06:18,387 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46975])
create public web group
2013-07-01 09:06:18,387 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46975])
Created admin entity UNUSED
2013-07-01 09:06:18,392 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46975])
Created accessrule : /public_web_user
2013-07-01 09:06:18,392 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46975])
Created accessrule : /ca_functionality/basic_functions
2013-07-01 09:06:18,392 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46975])
Created accessrule : /ca_functionality/view_certificate
2013-07-01 09:06:18,392 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46975])
Created accessrule : /ca_functionality/create_certificate
2013-07-01 09:06:18,392 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46975])
Created accessrule : /ca_functionality/store_certificate
2013-07-01 09:06:18,393 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46975])
Created accessrule : /ra_functionality/view_end_entity
2013-07-01 09:06:18,393 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46975])
Created accessrule : /ca
2013-07-01 09:06:18,393 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46975])
Created accessrule : /endentityprofilesrules
2013-07-01 09:06:18,459 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
Checking if update neccessary
2013-07-01 09:06:18,460 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
updateAuthorizationTree
2013-07-01 09:06:18,469 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
Is special user: 2001
2013-07-01 09:06:18,472 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
CA Token is CATOKENTYPE_HSM
2013-07-01 09:06:18,472 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
>init: sSlotLabelKey=slot, Signaturealg=SHA1WithRSA
2013-07-01 09:06:18,472 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
Prop: {attributesFile=/opt/ejbca_4_0_13/conf/ocs-sunpkcs11_4.cfg,
hardTokenEncrypt=cryptRoot,
sharedLibrary=/opt/nfast/toolkits/pkcs11/libcknfast.so, pin=hidden,
defaultKey=defaultRoot , slotListIndex=1 , keyEncryptKey=cryptRoot,
testKey=testRoot}
2013-07-01 09:06:18,472 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
MaxAllowedKeyLength for DES is: 2147483647
2013-07-01 09:06:18,473 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
Using cleartext autoactivation pin
2013-07-01 09:06:18,473 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
<init: sSlotLabelKey=slot, Signaturealg=SHA1WithRSA
2013-07-01 09:06:18,484 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
Failed to initialize PKCS11 provider slot '1'.
2013-07-01 09:06:18,484 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
java.security.KeyStoreException: KeyStore instantiation failed
2013-07-01 09:06:18,484 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at java.security.KeyStore$Builder$2.getKeyStore(KeyStore.java:1722)
2013-07-01 09:06:18,484 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.ejbca.core.model.ca.catoken.PKCS11CAToken.activate(PKCS11CAToken.java:74)
2013-07-01 09:06:18,484 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.ejbca.core.model.ca.catoken.CATokenContainerImpl.activate(CATokenContainerImpl.java:302)
2013-07-01 09:06:18,484 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.ejbca.core.ejb.ca.caadmin.CAAdminSessionBean.createCA(CAAdminSessionBean.java:249)
2013-07-01 09:06:18,484 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
2013-07-01 09:06:18,484 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
2013-07-01 09:06:18,484 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
2013-07-01 09:06:18,484 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at java.lang.reflect.Method.invoke(Method.java:616)
2013-07-01 09:06:18,484 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeTarget(MethodInvocation.java:122)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:111)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.interceptors.container.ContainerMethodInvocationWrapper.invokeNext(ContainerMethodInvocationWrapper.java:72)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.interceptors.aop.InterceptorSequencer.invoke(InterceptorSequencer.java:76)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.interceptors.aop.InterceptorSequencer.aroundInvoke(InterceptorSequencer.java:62)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.reflect.GeneratedMethodAccessor384.invoke(Unknown Source)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at java.lang.reflect.Method.invoke(Method.java:616)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.advice.PerJoinpointAdvice.invoke(PerJoinpointAdvice.java:174)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor.fillMethod(InvocationContextInterceptor.java:74)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.advice.org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor_z_fillMethod_659873291.invoke(InvocationContextInterceptor_z_fillMethod_659873291.java)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor.setup(InvocationContextInterceptor.java:90)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.advice.org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor_z_setup_659873291.invoke(InvocationContextInterceptor_z_setup_659873291.java)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,485 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.async.impl.interceptor.AsynchronousServerInterceptor.invoke(AsynchronousServerInterceptor.java:128)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.connectionmanager.CachedConnectionInterceptor.invoke(CachedConnectionInterceptor.java:62)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.entity.TransactionScopedEntityManagerInterceptor.invoke(TransactionScopedEntityManagerInterceptor.java:56)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.AllowedOperationsInterceptor.invoke(AllowedOperationsInterceptor.java:47)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at org.jboss.ejb3.tx.NullInterceptor.invoke(NullInterceptor.java:42)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.stateless.StatelessInstanceInterceptor.invoke(StatelessInstanceInterceptor.java:68)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.core.context.SessionInvocationContextAdapter.proceed(SessionInvocationContextAdapter.java:95)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.tx2.impl.CMTTxInterceptor.invokeInOurTx(CMTTxInterceptor.java:247)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.tx2.impl.CMTTxInterceptor.required(CMTTxInterceptor.java:349)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.tx2.impl.CMTTxInterceptor.invoke(CMTTxInterceptor.java:209)
2013-07-01 09:06:18,486 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.tx2.aop.CMTTxInterceptorWrapper.invoke(CMTTxInterceptorWrapper.java:52)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aspects.tx.TxPropagationInterceptor.invoke(TxPropagationInterceptor.java:76)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at org.jboss.ejb3.tx.NullInterceptor.invoke(NullInterceptor.java:42)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.security.Ejb3AuthenticationInterceptorv2.invoke(Ejb3AuthenticationInterceptorv2.java:182)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.ENCPropagationInterceptor.invoke(ENCPropagationInterceptor.java:41)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.BlockContainerShutdownInterceptor.invoke(BlockContainerShutdownInterceptor.java:67)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.core.context.CurrentInvocationContextInterceptor.invoke(CurrentInvocationContextInterceptor.java:47)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aspects.currentinvocation.CurrentInvocationInterceptor.invoke(CurrentInvocationInterceptor.java:67)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,487 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.interceptor.EJB3TCCLInterceptor.invoke(EJB3TCCLInterceptor.java:86)
2013-07-01 09:06:18,488 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,488 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.stateless.StatelessContainer.dynamicInvoke(StatelessContainer.java:392)
2013-07-01 09:06:18,488 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.session.InvokableContextClassProxyHack._dynamicInvoke(InvokableContextClassProxyHack.java:53)
2013-07-01 09:06:18,488 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at org.jboss.aop.Dispatcher.invoke(Dispatcher.java:91)
2013-07-01 09:06:18,488 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aspects.remoting.AOPRemotingInvocationHandler.invoke(AOPRemotingInvocationHandler.java:82)
2013-07-01 09:06:18,488 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at org.jboss.remoting.ServerInvoker.invoke(ServerInvoker.java:967)
2013-07-01 09:06:18,488 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.remoting.transport.socket.ServerThread.completeInvocation(ServerThread.java:791)
2013-07-01 09:06:18,488 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.remoting.transport.socket.ServerThread.processInvocation(ServerThread.java:744)
2013-07-01 09:06:18,488 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.remoting.transport.socket.ServerThread.dorun(ServerThread.java:548)
2013-07-01 09:06:18,488 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.remoting.transport.socket.ServerThread.run(ServerThread.java:234)
2013-07-01 09:06:18,488 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
Caused by: java.io.IOException: load failed
2013-07-01 09:06:18,488 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.security.pkcs11.P11KeyStore.engineLoad(P11KeyStore.java:864)
2013-07-01 09:06:18,488 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at java.security.KeyStore.load(KeyStore.java:1235)
2013-07-01 09:06:18,488 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at java.security.KeyStore$Builder$2$1.run(KeyStore.java:1684)
2013-07-01 09:06:18,488 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at java.security.KeyStore$Builder$2$1.run(KeyStore.java:1673)
2013-07-01 09:06:18,489 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at java.security.AccessController.doPrivileged(Native Method)
2013-07-01 09:06:18,489 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at java.security.KeyStore$Builder$2.getKeyStore(KeyStore.java:1719)
2013-07-01 09:06:18,489 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
... 66 more
2013-07-01 09:06:18,489 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
Caused by: javax.security.auth.login.LoginException
2013-07-01 09:06:18,489 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.security.pkcs11.SunPKCS11.login(SunPKCS11.java:1132)
2013-07-01 09:06:18,489 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.security.pkcs11.P11KeyStore.login(P11KeyStore.java:874)
2013-07-01 09:06:18,489 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.security.pkcs11.P11KeyStore.engineLoad(P11KeyStore.java:855)
2013-07-01 09:06:18,489 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
... 71 more
2013-07-01 09:06:18,489 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
Caused by: sun.security.pkcs11.wrapper.PKCS11Exception:
CKR_FUNCTION_FAILED
2013-07-01 09:06:18,489 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.security.pkcs11.wrapper.PKCS11.C_Login(Native Method)
2013-07-01 09:06:18,489 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.security.pkcs11.SunPKCS11.login(SunPKCS11.java:1116)
2013-07-01 09:06:18,489 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
... 73 more
2013-07-01 09:06:18,497 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
2013-07-01 09:06:18+00:00, CAId : 0, CA, EVENT_ERROR_CACREATED,
Administrator : CACMDLINE, User : No user involved, Certificate : No
certificate involved, Comment : Error when creating hard CA token.
Authorization code was wrong.
2013-07-01 09:06:18,498 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
Exception :
2013-07-01 09:06:18,498 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
org.ejbca.core.model.ca.catoken.CATokenAuthenticationFailedException:
Failed to initialize PKCS11 provider slot '1'.
2013-07-01 09:06:18,498 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.ejbca.core.model.ca.catoken.PKCS11CAToken.activate(PKCS11CAToken.java:99)
2013-07-01 09:06:18,498 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.ejbca.core.model.ca.catoken.CATokenContainerImpl.activate(CATokenContainerImpl.java:302)
2013-07-01 09:06:18,498 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.ejbca.core.ejb.ca.caadmin.CAAdminSessionBean.createCA(CAAdminSessionBean.java:249)
2013-07-01 09:06:18,499 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
2013-07-01 09:06:18,499 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
2013-07-01 09:06:18,499 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
2013-07-01 09:06:18,499 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeTarget(MethodInvocation.java:122)
2013-07-01 09:06:18,499 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:111)
2013-07-01 09:06:18,499 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.interceptors.container.ContainerMethodInvocationWrapper.invokeNext(ContainerMethodInvocationWrapper.java:72)
2013-07-01 09:06:18,499 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.interceptors.aop.InterceptorSequencer.invoke(InterceptorSequencer.java:76)
2013-07-01 09:06:18,499 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.interceptors.aop.InterceptorSequencer.aroundInvoke(InterceptorSequencer.java:62)
2013-07-01 09:06:18,499 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.reflect.GeneratedMethodAccessor384.invoke(Unknown Source)
2013-07-01 09:06:18,499 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
2013-07-01 09:06:18,499 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at java.lang.reflect.Method.invoke(Method.java:616)
2013-07-01 09:06:18,499 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.advice.PerJoinpointAdvice.invoke(PerJoinpointAdvice.java:174)
2013-07-01 09:06:18,499 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,499 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor.fillMethod(InvocationContextInterceptor.java:74)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.advice.org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor_z_fillMethod_659873291.invoke(InvocationContextInterceptor_z_fillMethod_659873291.java)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor.setup(InvocationContextInterceptor.java:90)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.advice.org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor_z_setup_659873291.invoke(InvocationContextInterceptor_z_setup_659873291.java)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.async.impl.interceptor.AsynchronousServerInterceptor.invoke(AsynchronousServerInterceptor.java:128)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.connectionmanager.CachedConnectionInterceptor.invoke(CachedConnectionInterceptor.java:62)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.entity.TransactionScopedEntityManagerInterceptor.invoke(TransactionScopedEntityManagerInterceptor.java:56)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.AllowedOperationsInterceptor.invoke(AllowedOperationsInterceptor.java:47)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at org.jboss.ejb3.tx.NullInterceptor.invoke(NullInterceptor.java:42)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,500 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.stateless.StatelessInstanceInterceptor.invoke(StatelessInstanceInterceptor.java:68)
2013-07-01 09:06:18,501 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,501 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.core.context.SessionInvocationContextAdapter.proceed(SessionInvocationContextAdapter.java:95)
2013-07-01 09:06:18,501 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.tx2.impl.CMTTxInterceptor.invokeInOurTx(CMTTxInterceptor.java:247)
2013-07-01 09:06:18,501 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.tx2.impl.CMTTxInterceptor.required(CMTTxInterceptor.java:349)
2013-07-01 09:06:18,501 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.tx2.impl.CMTTxInterceptor.invoke(CMTTxInterceptor.java:209)
2013-07-01 09:06:18,501 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.tx2.aop.CMTTxInterceptorWrapper.invoke(CMTTxInterceptorWrapper.java:52)
2013-07-01 09:06:18,501 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,501 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aspects.tx.TxPropagationInterceptor.invoke(TxPropagationInterceptor.java:76)
2013-07-01 09:06:18,501 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,501 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at org.jboss.ejb3.tx.NullInterceptor.invoke(NullInterceptor.java:42)
2013-07-01 09:06:18,501 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,501 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.security.Ejb3AuthenticationInterceptorv2.invoke(Ejb3AuthenticationInterceptorv2.java:182)
2013-07-01 09:06:18,501 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,501 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.ENCPropagationInterceptor.invoke(ENCPropagationInterceptor.java:41)
2013-07-01 09:06:18,501 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.BlockContainerShutdownInterceptor.invoke(BlockContainerShutdownInterceptor.java:67)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.core.context.CurrentInvocationContextInterceptor.invoke(CurrentInvocationContextInterceptor.java:47)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aspects.currentinvocation.CurrentInvocationInterceptor.invoke(CurrentInvocationInterceptor.java:67)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.interceptor.EJB3TCCLInterceptor.invoke(EJB3TCCLInterceptor.java:86)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.stateless.StatelessContainer.dynamicInvoke(StatelessContainer.java:392)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.ejb3.session.InvokableContextClassProxyHack._dynamicInvoke(InvokableContextClassProxyHack.java:53)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at org.jboss.aop.Dispatcher.invoke(Dispatcher.java:91)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.aspects.remoting.AOPRemotingInvocationHandler.invoke(AOPRemotingInvocationHandler.java:82)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at org.jboss.remoting.ServerInvoker.invoke(ServerInvoker.java:967)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.remoting.transport.socket.ServerThread.completeInvocation(ServerThread.java:791)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.remoting.transport.socket.ServerThread.processInvocation(ServerThread.java:744)
2013-07-01 09:06:18,502 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.remoting.transport.socket.ServerThread.dorun(ServerThread.java:548)
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.jboss.remoting.transport.socket.ServerThread.run(ServerThread.java:234)
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
Caused by: java.security.KeyStoreException: KeyStore instantiation failed
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at java.security.KeyStore$Builder$2.getKeyStore(KeyStore.java:1722)
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at
org.ejbca.core.model.ca.catoken.PKCS11CAToken.activate(PKCS11CAToken.java:74)
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
... 65 more
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
Caused by: java.io.IOException: load failed
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.security.pkcs11.P11KeyStore.engineLoad(P11KeyStore.java:864)
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at java.security.KeyStore.load(KeyStore.java:1235)
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at java.security.KeyStore$Builder$2$1.run(KeyStore.java:1684)
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at java.security.KeyStore$Builder$2$1.run(KeyStore.java:1673)
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at java.security.AccessController.doPrivileged(Native Method)
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at java.security.KeyStore$Builder$2.getKeyStore(KeyStore.java:1719)
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
... 66 more
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
Caused by: javax.security.auth.login.LoginException
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.security.pkcs11.SunPKCS11.login(SunPKCS11.java:1132)
2013-07-01 09:06:18,503 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.security.pkcs11.P11KeyStore.login(P11KeyStore.java:874)
2013-07-01 09:06:18,504 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.security.pkcs11.P11KeyStore.engineLoad(P11KeyStore.java:855)
2013-07-01 09:06:18,504 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
... 71 more
2013-07-01 09:06:18,504 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
Caused by: sun.security.pkcs11.wrapper.PKCS11Exception:
CKR_FUNCTION_FAILED
2013-07-01 09:06:18,504 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.security.pkcs11.wrapper.PKCS11.C_Login(Native Method)
2013-07-01 09:06:18,504 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
at sun.security.pkcs11.SunPKCS11.login(SunPKCS11.java:1116)
2013-07-01 09:06:18,504 INFO [STDOUT] (WorkerThread#0[127.0.0.1:46977])
... 73 more
Kind regards
Daniel JAMET
Direction DPM
Tél : +33 1 55 23 31 70
dan...@e-...
____________________________
Société d'Exploitation de Réseaux et de Services Sécurisés
Immeuble "Le Linéa"
1, rue du Général Leclerc
92800 PUTEAUX
De : ejbca-support <ejb...@pr...>
A : ejb...@li...
Cc : Tomas Gustavsson <to...@pr...>, Daniel JAMET
<Dan...@e-...>
Date : 25/06/2013 15:36
Objet : Re: [Ejbca-develop] EJBCA - create key whith clientToolBox
It looks like the java installation already contains a provider
definition which makes your new definition ignored.
Cheers
Anders
tech support
On 2013-06-25 15:26, Daniel JAMET wrote:
> clientToolBox run fine when you give it the path of library
libcknfast.so ant slotListIndex=1
>
> clientToolBox is in error when you give the path of configuration file :
ocs-sunpkcs11.cfg
>
> ocs-sunpkcs11.cfg:
>
> *name=NFastJava*
> *library=/opt/nfast/toolkits/pkcs11/libcknfast.so*
> *slotListIndex=1*
>
> *attributes(*, *, *) = {*
> * CKA_TOKEN = true*
> *}*
>
> *attributes(*, CKO_PUBLIC_KEY, * ) = {*
> * CKA_ENCRYPT = true*
> * CKA_WRAP = true *
> * CKA_VERIFY = true*
> *}*
>
> *attributes( *, CKO_PRIVATE_KEY, *) = {*
> * CKA_PRIVATE = false *
> * CKA_SENSITIVE = true*
> * CKA_SIGN = true*
> * CKA_DECRYPT = true*
> * CKA_EXTRACTABLE = false *
> * CKA_UNWRAP = true*
> *}*
>
> The log trace:
>
>
> *2013-06-25 13:23:47,115 INFO [org.ejbca.util.keystore.KeyTools] Using
SUN PKCS11 provider: sun.security.pkcs11.SunPKCS11*
> *2013-06-25 13:23:47,123 DEBUG
[org.ejbca.util.keystore.KeyStoreContainerP11] Adding provider with name:
SunPKCS11-NFastJava*
> *2013-06-25 13:23:47,123 DEBUG
[org.ejbca.util.keystore.KeyStoreContainerP11] Provider already exists,
not adding.*
> *2013-06-25 13:23:47,132 DEBUG
[org.ejbca.util.keystore.KeyStoreContainerBase] generating...*
> *2013-06-25 13:23:52,920 DEBUG
[org.ejbca.util.keystore.KeyStoreContainerBase] keystore signing algorithm
SHA1withRSA*
> *2013-06-25 13:23:52,953 ERROR [org.ejbca.ui.cli.HSMKeyTool] Command
'PKCS11HSMKeyTool generate /opt/ejbca/conf/sunpkcs11.cfg null pkcs11 4096
defaultTEST' could not be executed.*
> *java.security.ProviderException: Initialization failed*
> * at
sun.security.pkcs11.P11Signature.initialize(P11Signature.java:312)*
> * at
sun.security.pkcs11.P11Signature.engineInitSign(P11Signature.java:393)*
> * at
java.security.Signature$Delegate.engineInitSign(Signature.java:1113)*
> * at java.security.Signature.initSign(Signature.java:497)*
> * at org.bouncycastle.x509.X509Util.calculateSignature(Unknown
Source)*
> * at
org.bouncycastle.x509.X509V3CertificateGenerator.generate(Unknown Source)*
> * at
org.bouncycastle.x509.X509V3CertificateGenerator.generate(Unknown Source)*
> * at
org.ejbca.util.keystore.KeyStoreContainerBase.getSelfCertificate(KeyStoreContainerBase.java:144)*
> * at
org.ejbca.util.keystore.KeyStoreContainerBase.generate(KeyStoreContainerBase.java:285)*
> * at
org.ejbca.util.keystore.KeyStoreContainerBase.generateRSA(KeyStoreContainerBase.java:202)*
> * at
org.ejbca.util.keystore.KeyStoreContainerBase.generate(KeyStoreContainerBase.java:234)*
> * at org.ejbca.ui.cli.HSMKeyTool.doIt(HSMKeyTool.java:139)*
> * at org.ejbca.ui.cli.HSMKeyTool.execute(HSMKeyTool.java:290)*
> * at
org.ejbca.ui.cli.PKCS11HSMKeyTool.execute(PKCS11HSMKeyTool.java:47)*
> * at
org.ejbca.ui.cli.ClientToolBox.executeIfSelected(ClientToolBox.java:40)*
> * at org.ejbca.ui.cli.ClientToolBox.main(ClientToolBox.java:70)*
> *Caused by: sun.security.pkcs11.wrapper.PKCS11Exception:
CKR_KEY_FUNCTION_NOT_PERMITTED*
> * at sun.security.pkcs11.wrapper.PKCS11.C_SignInit(Native
Method)*
> * at
sun.security.pkcs11.P11Signature.initialize(P11Signature.java:304)*
> * ... 15 more*
>
>
> How explain this ?
>
> kind regards
>
> Daniel JAMET
> Direction DPM
> Tél : +33 1 55 23 31 70
> dan...@e-...
> ____________________________
> Société d'Exploitation de Réseaux et de Services Sécurisés
> Immeuble "Le Linéa"
> 1, rue du Général Leclerc
> 92800 PUTEAUX
>
>
>
------------------------------------------------------------------------------
> This SF.net email is sponsored by Windows:
>
> Build for Windows Store.
>
> http://p.sf.net/sfu/windows-dev2dev
>
>
>
> _______________________________________________
> Ejbca-develop mailing list
> Ejb...@li...
> https://lists.sourceforge.net/lists/listinfo/ejbca-develop
>
------------------------------------------------------------------------------
This SF.net email is sponsored by Windows:
Build for Windows Store.
http://p.sf.net/sfu/windows-dev2dev
_______________________________________________
Ejbca-develop mailing list
Ejb...@li...
https://lists.sourceforge.net/lists/listinfo/ejbca-develop
|