Hi everyone,
I'm asking this question in English since German is not my primary language. I'm interested in the HBCI protocol and I'm currently trying to create a setup where I can run the demo attached with the hbci4java source code. I have performed the following steps: first, I compiled the hbci4java source code. Next, I followed the instructions on the Github repository of hbci4javaserver (https://github.com/thomet/hbci4javaserver). My server is running and I can access the admin panel where I can add and modify users.
Next, I created a passport using the InitAndTest tool. I have used the following parameters when creating the passport:
https://gist.github.com/devos50/e4fa4c8707fa10475548. In summary, I'm trying to create a PinTan passport for the user 'nutzer1' using HBCI+. The biz, host and port corresponds to the configurations of the hbci4javaserver I have setup in the previous step. Finally, I adjusted the hbci4java.properties file to match the location of my passport (see
https://gist.github.com/devos50/08d016dec22eb0175cbf).
Now, when I run the demo (by running 'bash runjobs.sh' in the background), I get the following error in the log of the server:
Code
<WRN> [2015.10.06 17:47:36.537] [RMI Runtime/RMI TCP Connection(25)-10.0.1.129] protocol.MSG: could not insert the following user-defined data into message: DialogInitAnonRes.BPD.Params_6.KUmsZeitPar4.ParKUmsZeit.canallaccounts=J
<ERR> [2015.10.06 17:47:36.541] [RMI Runtime/RMI TCP Connection(25)-10.0.1.129] manager.HBCIUtils: HBCI4Java Exception BEGIN ---error while initializing element DialogInitAnonRes.BPD.Params_18.PinTanPar1.ParPinTan.PinTanGV.needtan
-> invalid argument: value must be J or N
HBCI4Java Exception END ---
HBCI4Java stacktrace BEGIN ---org.kapott.hbci.exceptions.InitializingException: error while initializing element DialogInitAnonRes.BPD.Params_18.PinTanPar1.ParPinTan.PinTanGV.needtan
at org.kapott.hbci.datatypes.factory.SyntaxDEFactory.createSyntaxDE(SyntaxDEFactory.java:92)
at org.kapott.hbci.protocol.DE.setValue(DE.java:183)
at org.kapott.hbci.protocol.DE.propagateValue(DE.java:79)
at org.kapott.hbci.protocol.MultipleSyntaxElements.propagateValue(MultipleSyntaxElements.java:185)
at org.kapott.hbci.protocol.SyntaxElement.propagateValue(SyntaxElement.java:467)
at org.kapott.hbci.protocol.MultipleSyntaxElements.propagateValue(MultipleSyntaxElements.java:185)
at org.kapott.hbci.protocol.SyntaxElement.propagateValue(SyntaxElement.java:467)
at org.kapott.hbci.protocol.MultipleSyntaxElements.propagateValue(MultipleSyntaxElements.java:185)
at org.kapott.hbci.protocol.SyntaxElement.propagateValue(SyntaxElement.java:467)
at org.kapott.hbci.protocol.MultipleSyntaxElements.propagateValue(MultipleSyntaxElements.java:185)
at org.kapott.hbci.protocol.SyntaxElement.propagateValue(SyntaxElement.java:467)
at org.kapott.hbci.protocol.MultipleSyntaxElements.propagateValue(MultipleSyntaxElements.java:185)
at org.kapott.hbci.protocol.SyntaxElement.propagateValue(SyntaxElement.java:467)
at org.kapott.hbci.protocol.MultipleSyntaxElements.propagateValue(MultipleSyntaxElements.java:185)
at org.kapott.hbci.protocol.SyntaxElement.propagateValue(SyntaxElement.java:467)
at org.kapott.hbci.protocol.MSG.propagateUserData(MSG.java:78)
at org.kapott.hbci.protocol.MSG.initData(MSG.java:127)
at org.kapott.hbci.protocol.MSG.init(MSG.java:122)
at org.kapott.hbci.protocol.factory.MSGFactory.createMSG(MSGFactory.java:61)
at org.kapott.hbci.manager.MsgGen.generate(MsgGen.java:107)
at org.kapott.hbci.server.msg.AbstractMsgHandler.createResponseMessage(AbstractMsgHandler.java:396)
at org.kapott.hbci.server.msg.AbstractMsgHandler.handleMessage(AbstractMsgHandler.java:128)
at org.kapott.hbci.server.Dialog.handleMessage(Dialog.java:200)
at org.kapott.hbci.server.DialogMgr.handleMessage(DialogMgr.java:76)
at org.kapott.hbci.server.listener.RMIListenerImpl.handleMessage(RMIListenerImpl.java:58)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:322)
at sun.rmi.transport.Transport$1.run(Transport.java:177)
at sun.rmi.transport.Transport$1.run(Transport.java:174)
at java.security.AccessController.doPrivileged(Native Method)
at sun.rmi.transport.Transport.serviceCall(Transport.java:173)
at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:556)
at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:811)
at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:670)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
Caused by: org.kapott.hbci.exceptions.InvalidArgumentException: invalid argument: value must be J or N
at org.kapott.hbci.datatypes.SyntaxJN.check(SyntaxJN.java:35)
at org.kapott.hbci.datatypes.SyntaxJN.<init>(SyntaxJN.java:41)
at sun.reflect.GeneratedConstructorAccessor8.newInstance(Unknown Source)
at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
at java.lang.reflect.Constructor.newInstance(Constructor.java:526)
at org.kapott.hbci.datatypes.factory.SyntaxDEFactory.createSyntaxDE(SyntaxDEFactory.java:88)
... 39 more
HBCI4Java stacktrace END ---
The content of jobs.log is posted below:
Code
<DBG> [2015.10.06 19:44:55.881] [main/main] manager.HBCIUtils: using default system locale nl_NL
<DBG> [2015.10.06 19:44:55.898] [main/main] manager.HBCIUtils: initialized HBCI4Java for thread group main
<INF> [2015.10.06 19:44:55.899] [main/main] manager.HBCIUtils: This is HBCI4Java-2.5.12
<DBG> [2015.10.06 19:44:55.899] [main/main] manager.HBCIUtils: trying to load BLZ data
<DBG> [2015.10.06 19:44:55.960] [main/main] passport.AbstractHBCIPassport: creating new instance of a PinTan passport
<DBG> [2015.10.06 19:44:55.966] [main/main] passport.HBCIPassportPinTan: loading passport data from file /Users/Martijn/Documents/hbci4java/my_passport_pintan.dat
<DBG> [2015.10.06 19:44:55.966] [main/main] passport.HBCIPassportPinTan: loading data from file /Users/Martijn/Documents/hbci4java/my_passport_pintan.dat
<DBG> [2015.10.06 19:44:56.665] [main/main] manager.HBCIHandler: registering institute
<INF> [2015.10.06 19:44:56.667] [main/main] manager.HBCIInstitute: fetching BPD
<DB2> [2015.10.06 19:44:56.667] [main/main] manager.HBCIKernelImpl: creating new raw message DialogInitAnon
<DB2> [2015.10.06 19:44:56.667] [main/main] manager.HBCIKernelImpl: setting raw property DialogInitAnon.Idn.KIK.blz to "12345678"
<DB2> [2015.10.06 19:44:56.667] [main/main] manager.HBCIKernelImpl: setting raw property DialogInitAnon.Idn.KIK.country to "DE"
<DB2> [2015.10.06 19:44:56.667] [main/main] manager.HBCIKernelImpl: setting raw property DialogInitAnon.ProcPrep.BPD to "0"
<DB2> [2015.10.06 19:44:56.668] [main/main] manager.HBCIKernelImpl: setting raw property DialogInitAnon.ProcPrep.UPD to "0"
<DB2> [2015.10.06 19:44:56.668] [main/main] manager.HBCIKernelImpl: setting raw property DialogInitAnon.ProcPrep.lang to "0"
<DB2> [2015.10.06 19:44:56.668] [main/main] manager.HBCIKernelImpl: setting raw property DialogInitAnon.ProcPrep.prodName to "HBCI4Java"
<DB2> [2015.10.06 19:44:56.668] [main/main] manager.HBCIKernelImpl: setting raw property DialogInitAnon.ProcPrep.prodVersion to "2.5"
<DBG> [2015.10.06 19:44:56.670] [main/main] manager.HBCIKernelImpl: generating raw message DialogInitAnon
<DBG> [2015.10.06 19:44:56.701] [main/main] protocol.MSG: user data: {DialogInitAnon.ProcPrep.UPD=0, DialogInitAnon.Idn.KIK.blz=12345678, DialogInitAnon.ProcPrep.prodVersion=2.5, DialogInitAnon.ProcPrep.lang=0, DialogInitAnon.ProcPrep.prodName=HBCI4Java, DialogInitAnon.ProcPrep.BPD=0, DialogInitAnon.Idn.KIK.country=DE}
<DB2> [2015.10.06 19:44:56.712] [main/main] manager.HBCIKernelImpl: sending message: HNHBK:1:3+000000000111+220+0+1'HKIDN:2:2+280:12345678+9999999999+0+0'HKVVB:3:2+0+0+0+HBCI4Java+2.5'HNHBS:4:1+1'
<DBG> [2015.10.06 19:44:56.713] [main/main] manager.HBCIKernelImpl: communicating dialogid/msgnum 0/1
<DBG> [2015.10.06 19:44:56.715] [main/main] comm.FilterBase64: using filter: MIM (base64)
<INF> [2015.10.06 19:44:56.715] [main/main] comm.CommPinTan: creating a connection to https://127.0.0.1:8443/pintan/PinTanServlet and checking the certificate
<WRN> [2015.10.06 19:44:56.717] [main/main] comm.PinTanSSLSocketFactory: creating socket factory with disabled cert checking
<DBG> [2015.10.06 19:44:56.720] [main/main] comm.CommPinTan: connecting to server
<DBG> [2015.10.06 19:44:56.782] [main/main] comm.CommPinTan: activating modified socket factory for checkCert=false and debugging=false
<DBG> [2015.10.06 19:44:56.782] [main/main] comm.CommPinTan: activating modified hostname verifier because cert checking is disabled
<DB2> [2015.10.06 19:44:56.784] [main/main] comm.PinTanSSLSocketFactory: createSocket()
<DBG> [2015.10.06 19:44:56.839] [main/main] comm.PinTanSSLTrustManager: cert checking disabled -> server cert always OK
<DBG> [2015.10.06 19:44:56.839] [main/main] comm.PinTanSSLTrustManager: cert checking disabled -> will return 'accepted issuers'
<DBG> [2015.10.06 19:44:56.854] [main/main] comm.PinTanSSLHostnameVerifier: cert checking disabled -> hostname always OK
<DBG> [2015.10.06 19:44:56.855] [main/main] comm.CommPinTan: writing data to output stream
<DBG> [2015.10.06 19:44:56.856] [main/main] comm.CommPinTan: closing output stream
<INF> [2015.10.06 19:44:56.856] [main/main] comm.CommPinTan: waiting for response
<DBG> [2015.10.06 19:44:56.950] [main/main] comm.CommPinTan: found messagesize: 240
<DB2> [2015.10.06 19:44:56.950] [main/main] comm.CommPinTan: received 1 bytes
<DB2> [2015.10.06 19:44:56.951] [main/main] comm.CommPinTan: we still need 239 bytes
<DB2> [2015.10.06 19:44:56.951] [main/main] comm.CommPinTan: received 239 bytes
<DB2> [2015.10.06 19:44:56.951] [main/main] comm.CommPinTan: we still need 0 bytes
<DBG> [2015.10.06 19:44:56.951] [main/main] comm.CommPinTan: closing communication line
<DB2> [2015.10.06 19:44:56.952] [main/main] comm.Comm: received message: HNHBK:1:3+000000000179+220+207556572612533274+1+207556572612533274:1'HIRMG:2:2+9800::org.kapott.hbci.exceptions.InitializingException?: error while initializing eleme'HNHBS:3:1+1'
<DBG> [2015.10.06 19:44:56.952] [main/main] comm.Comm: trying to parse message as crypted message
<DBG> [2015.10.06 19:44:56.955] [main/main] comm.Comm: message seems not to be encrypted; tring to parse it as DialogInitAnonRes message
<DB2> [2015.10.06 19:44:57.005] [main/main] manager.HBCIKernelImpl: received message after decryption: HNHBK:1:3+000000000179+220+207556572612533274+1+207556572612533274:1'HIRMG:2:2+9800::org.kapott.hbci.exceptions.InitializingException?: error while initializing eleme'HNHBS:3:1+1'
<DBG> [2015.10.06 19:44:57.006] [main/main] manager.HBCIKernelImpl: extracting data from received message
<ERR> [2015.10.06 19:44:57.006] [main/main] status.HBCIStatus: HBCI error code: 9800:org.kapott.hbci.exceptions.InitializingException: error while initializing eleme
<DBG> [2015.10.06 19:44:57.006] [main/main] manager.HBCIKernelImpl: looking for a signature
<DBG> [2015.10.06 19:44:57.008] [main/main] security.Sig: message does not need a signature
<DBG> [2015.10.06 19:44:57.008] [main/main] manager.HBCIKernelImpl: looking if message is encrypted
<DBG> [2015.10.06 19:44:57.008] [main/main] passport.AbstractPinTanPassport: dialog init ended with errors - searching for return code 'wrong PIN'
<DBG> [2015.10.06 19:44:57.008] [main/main] passport.AbstractPinTanPassport: autosecfunc: search for 3920s in response to detect allowed twostep secmechs
<DBG> [2015.10.06 19:44:57.009] [main/main] manager.HBCIInstitute: extracting BPD from results
<DBG> [2015.10.06 19:44:57.014] [main/main] passport.HBCIPassportPinTan: writing to passport file /Users/Martijn/Documents/hbci4java/my_passport_pintan.dat_7140067065171574008
<DBG> [2015.10.06 19:44:57.015] [main/main] passport.HBCIPassportPinTan: saving two step mechs: []
<DBG> [2015.10.06 19:44:57.016] [main/main] passport.HBCIPassportPinTan: saving current tan method: 999
<DBG> [2015.10.06 19:44:57.016] [main/main] passport.HBCIPassportPinTan: closing output stream
<DBG> [2015.10.06 19:44:57.016] [main/main] passport.HBCIPassportPinTan: deleting old passport file /Users/Martijn/Documents/hbci4java/my_passport_pintan.dat
<DBG> [2015.10.06 19:44:57.016] [main/main] passport.HBCIPassportPinTan: renaming my_passport_pintan.dat_7140067065171574008 to my_passport_pintan.dat
<DB2> [2015.10.06 19:44:57.016] [main/main] manager.HBCIKernelImpl: creating new raw message DialogEndAnon
<DB2> [2015.10.06 19:44:57.017] [main/main] manager.HBCIKernelImpl: setting raw property DialogEndAnon.MsgHead.dialogid to "207556572612533274"
<DB2> [2015.10.06 19:44:57.017] [main/main] manager.HBCIKernelImpl: setting raw property DialogEndAnon.MsgHead.msgnum to "2"
<DB2> [2015.10.06 19:44:57.017] [main/main] manager.HBCIKernelImpl: setting raw property DialogEndAnon.DialogEndS.dialogid to "207556572612533274"
<DB2> [2015.10.06 19:44:57.017] [main/main] manager.HBCIKernelImpl: setting raw property DialogEndAnon.MsgTail.msgnum to "2"
<DBG> [2015.10.06 19:44:57.017] [main/main] manager.HBCIKernelImpl: generating raw message DialogEndAnon
<DBG> [2015.10.06 19:44:57.018] [main/main] protocol.MSG: user data: {DialogEndAnon.MsgTail.msgnum=2, DialogEndAnon.DialogEndS.dialogid=207556572612533274, DialogEndAnon.MsgHead.msgnum=2, DialogEndAnon.MsgHead.dialogid=207556572612533274}
<DB2> [2015.10.06 19:44:57.019] [main/main] manager.HBCIKernelImpl: sending message: HNHBK:1:3+000000000089+220+207556572612533274+2'HKEND:2:1+207556572612533274'HNHBS:3:1+2'
<DBG> [2015.10.06 19:44:57.019] [main/main] manager.HBCIKernelImpl: communicating dialogid/msgnum 207556572612533274/2
<DBG> [2015.10.06 19:44:57.020] [main/main] comm.CommPinTan: connecting to server
<DBG> [2015.10.06 19:44:57.020] [main/main] comm.CommPinTan: activating modified socket factory for checkCert=false and debugging=false
<DBG> [2015.10.06 19:44:57.020] [main/main] comm.CommPinTan: activating modified hostname verifier because cert checking is disabled
<DB2> [2015.10.06 19:44:57.020] [main/main] comm.PinTanSSLSocketFactory: createSocket()
<DBG> [2015.10.06 19:44:57.026] [main/main] comm.PinTanSSLHostnameVerifier: cert checking disabled -> hostname always OK
<DBG> [2015.10.06 19:44:57.026] [main/main] comm.CommPinTan: writing data to output stream
<DBG> [2015.10.06 19:44:57.026] [main/main] comm.CommPinTan: closing output stream
<INF> [2015.10.06 19:44:57.027] [main/main] comm.CommPinTan: waiting for response
<DBG> [2015.10.06 19:44:57.047] [main/main] comm.CommPinTan: found messagesize: 220
<DB2> [2015.10.06 19:44:57.047] [main/main] comm.CommPinTan: received 1 bytes
<DB2> [2015.10.06 19:44:57.047] [main/main] comm.CommPinTan: we still need 219 bytes
<DB2> [2015.10.06 19:44:57.048] [main/main] comm.CommPinTan: received 219 bytes
<DB2> [2015.10.06 19:44:57.048] [main/main] comm.CommPinTan: we still need 0 bytes
<DBG> [2015.10.06 19:44:57.048] [main/main] comm.CommPinTan: closing communication line
<DB2> [2015.10.06 19:44:57.048] [main/main] comm.Comm: received message: HNHBK:1:3+000000000164+220+207556572612533274+1+207556572612533274:1'HIRMG:2:2+9800::org.kapott.hbci.exceptions.HBCI_Exception?: invalid message number'HNHBS:3:1+1'
<DBG> [2015.10.06 19:44:57.049] [main/main] comm.Comm: trying to parse message as crypted message
<DBG> [2015.10.06 19:44:57.049] [main/main] comm.Comm: message seems not to be encrypted; tring to parse it as DialogEndAnonRes message
<DB2> [2015.10.06 19:44:57.055] [main/main] manager.HBCIKernelImpl: received message after decryption: HNHBK:1:3+000000000164+220+207556572612533274+1+207556572612533274:1'HIRMG:2:2+9800::org.kapott.hbci.exceptions.HBCI_Exception?: invalid message number'HNHBS:3:1+1'
<DBG> [2015.10.06 19:44:57.055] [main/main] manager.HBCIKernelImpl: extracting data from received message
<ERR> [2015.10.06 19:44:57.055] [main/main] status.HBCIStatus: HBCI error code: 9800:org.kapott.hbci.exceptions.HBCI_Exception: invalid message number
<ERR> [2015.10.06 19:44:57.056] [main/main] manager.HBCIUtils: org.kapott.hbci.exceptions.HBCI_Exception: received message number (1) in message header does not match sent message number (2)
at org.kapott.hbci.manager.HBCIKernelImpl.rawDoIt(HBCIKernelImpl.java:419)
at org.kapott.hbci.manager.HBCIKernelImpl.rawDoIt(HBCIKernelImpl.java:178)
at org.kapott.hbci.manager.HBCIInstitute.doDialogEnd(HBCIInstitute.java:189)
at org.kapott.hbci.manager.HBCIInstitute.fetchBPD(HBCIInstitute.java:328)
at org.kapott.hbci.manager.HBCIInstitute.register(HBCIInstitute.java:451)
at org.kapott.hbci.manager.HBCIHandler.registerInstitute(HBCIHandler.java:268)
at org.kapott.hbci.manager.HBCIHandler.<init>(HBCIHandler.java:132)
at org.kapott.hbci.tools.HBCIBatch.main(HBCIBatch.java:255)
<ERR> [2015.10.06 19:44:57.056] [main/main] manager.HBCIInstitute: dialog end failed: org.kapott.hbci.exceptions.HBCI_Exception: received message number (1) in message header does not match sent message number (2)
9800:org.kapott.hbci.exceptions.HBCI_Exception: invalid message number
<ERR> [2015.10.06 19:44:57.057] [main/main] manager.HBCIUtils: org.kapott.hbci.exceptions.ProcessException: dialog end failed
at org.kapott.hbci.manager.HBCIInstitute.doDialogEnd(HBCIInstitute.java:198)
at org.kapott.hbci.manager.HBCIInstitute.fetchBPD(HBCIInstitute.java:328)
at org.kapott.hbci.manager.HBCIInstitute.register(HBCIInstitute.java:451)
at org.kapott.hbci.manager.HBCIHandler.registerInstitute(HBCIHandler.java:268)
at org.kapott.hbci.manager.HBCIHandler.<init>(HBCIHandler.java:132)
at org.kapott.hbci.tools.HBCIBatch.main(HBCIBatch.java:255)
<ERR> [2015.10.06 19:44:57.057] [main/main] manager.HBCIInstitute: fetching BPD failed: 9800:org.kapott.hbci.exceptions.InitializingException: error while initializing eleme
<INF> [2015.10.06 19:44:57.057] [main/main] manager.HBCIUtils: org.kapott.hbci.exceptions.ProcessException: fetching BPD failed
at org.kapott.hbci.manager.HBCIInstitute.fetchBPD(HBCIInstitute.java:335)
at org.kapott.hbci.manager.HBCIInstitute.register(HBCIInstitute.java:451)
at org.kapott.hbci.manager.HBCIHandler.registerInstitute(HBCIHandler.java:268)
at org.kapott.hbci.manager.HBCIHandler.<init>(HBCIHandler.java:132)
at org.kapott.hbci.tools.HBCIBatch.main(HBCIBatch.java:255)
<INF> [2015.10.06 19:44:57.057] [main/main] manager.HBCIInstitute: FAILED! - maybe this institute does not support anonymous logins
<INF> [2015.10.06 19:44:57.057] [main/main] manager.HBCIInstitute: we will nevertheless go on
<DBG> [2015.10.06 19:44:57.057] [main/main] manager.HBCIInstitute: checking if requested hbci parameters are supported
<WRN> [2015.10.06 19:44:57.057] [main/main] manager.HBCIInstitute: can not check if requested parameters are supported
<DBG> [2015.10.06 19:44:57.057] [main/main] manager.HBCIHandler: registering user
<INF> [2015.10.06 19:44:57.060] [main/main] manager.HBCIUser: fetching new sys-id from institute
<DBG> [2015.10.06 19:44:57.060] [main/main] manager.HBCIUser: checking whether passport is supported (but ignoring result)
<DBG> [2015.10.06 19:44:57.060] [main/main] manager.HBCIUser: passport supported: true
<DB2> [2015.10.06 19:44:57.060] [main/main] manager.HBCIKernelImpl: creating new raw message Synch
<DB2> [2015.10.06 19:44:57.060] [main/main] manager.HBCIKernelImpl: setting raw property Synch.Idn.KIK.blz to "12345678"
<DB2> [2015.10.06 19:44:57.061] [main/main] manager.HBCIKernelImpl: setting raw property Synch.Idn.KIK.country to "DE"
<DB2> [2015.10.06 19:44:57.061] [main/main] manager.HBCIKernelImpl: setting raw property Synch.Idn.customerid to "XXXXXXX"
<DB2> [2015.10.06 19:44:57.061] [main/main] manager.HBCIKernelImpl: setting raw property Synch.Idn.sysid to "0"
<DB2> [2015.10.06 19:44:57.061] [main/main] manager.HBCIKernelImpl: setting raw property Synch.Idn.sysStatus to "1"
<DB2> [2015.10.06 19:44:57.061] [main/main] manager.HBCIKernelImpl: setting raw property Synch.MsgHead.dialogid to "0"
<DB2> [2015.10.06 19:44:57.061] [main/main] manager.HBCIKernelImpl: setting raw property Synch.MsgHead.msgnum to "1"
<DB2> [2015.10.06 19:44:57.061] [main/main] manager.HBCIKernelImpl: setting raw property Synch.MsgTail.msgnum to "1"
<DB2> [2015.10.06 19:44:57.061] [main/main] manager.HBCIKernelImpl: setting raw property Synch.ProcPrep.BPD to "0"
<DB2> [2015.10.06 19:44:57.062] [main/main] manager.HBCIKernelImpl: setting raw property Synch.ProcPrep.UPD to "0"
<DB2> [2015.10.06 19:44:57.062] [main/main] manager.HBCIKernelImpl: setting raw property Synch.ProcPrep.lang to "0"
<DB2> [2015.10.06 19:44:57.062] [main/main] manager.HBCIKernelImpl: setting raw property Synch.ProcPrep.prodName to "HBCI4Java"
<DB2> [2015.10.06 19:44:57.062] [main/main] manager.HBCIKernelImpl: setting raw property Synch.ProcPrep.prodVersion to "2.5"
<DB2> [2015.10.06 19:44:57.062] [main/main] manager.HBCIKernelImpl: setting raw property Synch.Sync.mode to "0"
<DBG> [2015.10.06 19:44:57.062] [main/main] manager.HBCIKernelImpl: generating raw message Synch
<DBG> [2015.10.06 19:44:57.066] [main/main] protocol.MSG: user data: {Synch.ProcPrep.lang=0, Synch.Idn.customerid=XXXXXXX, Synch.Idn.KIK.country=DE, Synch.Sync.mode=0, Synch.ProcPrep.BPD=0, Synch.MsgHead.dialogid=0, Synch.MsgHead.msgnum=1, Synch.Idn.sysStatus=1, Synch.ProcPrep.UPD=0, Synch.ProcPrep.prodName=HBCI4Java, Synch.Idn.sysid=0, Synch.MsgTail.msgnum=1, Synch.ProcPrep.prodVersion=2.5, Synch.Idn.KIK.blz=12345678}
<DBG> [2015.10.06 19:44:57.068] [main/main] manager.HBCIKernelImpl: trying to insert signature
<DBG> [2015.10.06 19:44:57.069] [main/main] security.Sig: setting secfunc to 999
<DBG> [2015.10.06 19:44:57.069] [main/main] security.Sig: setting cid to
<DBG> [2015.10.06 19:44:57.070] [main/main] security.Sig: setting role to 1
<DBG> [2015.10.06 19:44:57.070] [main/main] security.Sig: setting range to 1
<DBG> [2015.10.06 19:44:57.070] [main/main] security.Sig: setting keyblz to 12345678
<DBG> [2015.10.06 19:44:57.070] [main/main] security.Sig: setting keycountry to DE
<DBG> [2015.10.06 19:44:57.070] [main/main] security.Sig: setting keyuserid to XXXXXXX
<DBG> [2015.10.06 19:44:57.070] [main/main] security.Sig: setting keynum to 0
<DBG> [2015.10.06 19:44:57.070] [main/main] security.Sig: setting keyversion to 0
<DBG> [2015.10.06 19:44:57.070] [main/main] security.Sig: setting sysid to 0
<DBG> [2015.10.06 19:44:57.071] [main/main] security.Sig: setting sigid to 1
<DBG> [2015.10.06 19:44:57.071] [main/main] security.Sig: setting sigalg to 10
<DBG> [2015.10.06 19:44:57.071] [main/main] security.Sig: setting sigmode to 16
<DBG> [2015.10.06 19:44:57.071] [main/main] security.Sig: setting hashalg to 999
<DBG> [2015.10.06 19:44:57.075] [main/main] passport.HBCIPassportPinTan: writing to passport file /Users/Martijn/Documents/hbci4java/my_passport_pintan.dat_7790155181956074736
<DBG> [2015.10.06 19:44:57.075] [main/main] passport.HBCIPassportPinTan: saving two step mechs: []
<DBG> [2015.10.06 19:44:57.076] [main/main] passport.HBCIPassportPinTan: saving current tan method: 999
<DBG> [2015.10.06 19:44:57.076] [main/main] passport.HBCIPassportPinTan: closing output stream
<DBG> [2015.10.06 19:44:57.076] [main/main] passport.HBCIPassportPinTan: deleting old passport file /Users/Martijn/Documents/hbci4java/my_passport_pintan.dat
<DBG> [2015.10.06 19:44:57.076] [main/main] passport.HBCIPassportPinTan: renaming my_passport_pintan.dat_7790155181956074736 to my_passport_pintan.dat
<DBG> [2015.10.06 19:44:57.079] [main/main] passport.HBCIPassportPinTan: onestep method - checking GVs to decide whether or not we need a TAN
<WRN> [2015.10.06 19:44:57.079] [main/main] passport.HBCIPassportPinTan: the job with the code HNSHK seems not to be allowed with PIN/TAN
<WRN> [2015.10.06 19:44:57.080] [main/main] passport.HBCIPassportPinTan: the job with the code HKIDN seems not to be allowed with PIN/TAN
<WRN> [2015.10.06 19:44:57.080] [main/main] passport.HBCIPassportPinTan: the job with the code HKVVB seems not to be allowed with PIN/TAN
<WRN> [2015.10.06 19:44:57.080] [main/main] passport.HBCIPassportPinTan: the job with the code HKSYN seems not to be allowed with PIN/TAN
<DB2> [2015.10.06 19:44:57.082] [main/main] manager.HBCIKernelImpl: sending message: HNHBK:1:3+000000000245+220+0+1'HNSHK:2:3+999+1055507019+1+1+1::0+1+1:20151006:194457+1:999:1+6:10:16+280:XXXXX678:XXXXXXX:S:0:0'HKIDN:3:2+280:XXXXX678+XXXXXXX+0+1'HKVVB:4:2+0+0+0+HBCI4Java+2.5'HKSYN:5:2+0'HNSHA:6:1+1055507019++XXXXX'HNHBS:7:1+1'
<DBG> [2015.10.06 19:44:57.082] [main/main] manager.HBCIKernelImpl: trying to encrypt message
<DBG> [2015.10.06 19:44:57.083] [main/main] security.Crypt: setting secfunc to 998
<DBG> [2015.10.06 19:44:57.083] [main/main] security.Crypt: setting keytype to 5
<DBG> [2015.10.06 19:44:57.084] [main/main] security.Crypt: setting blz to XXXXX678
<DBG> [2015.10.06 19:44:57.084] [main/main] security.Crypt: setting country to DE
<DBG> [2015.10.06 19:44:57.084] [main/main] security.Crypt: setting keyuserid to XXXXXXX
<DBG> [2015.10.06 19:44:57.084] [main/main] security.Crypt: setting keynum to 0
<DBG> [2015.10.06 19:44:57.084] [main/main] security.Crypt: setting keyversion to 0
<DBG> [2015.10.06 19:44:57.084] [main/main] security.Crypt: setting cid to
<DBG> [2015.10.06 19:44:57.084] [main/main] security.Crypt: setting sysId to 0
<DBG> [2015.10.06 19:44:57.084] [main/main] security.Crypt: setting role to 1
<DBG> [2015.10.06 19:44:57.085] [main/main] security.Crypt: setting alg to 13
<DBG> [2015.10.06 19:44:57.085] [main/main] security.Crypt: setting mode to 2
<DBG> [2015.10.06 19:44:57.085] [main/main] security.Crypt: setting compfunc to 0
<DBG> [2015.10.06 19:44:57.087] [main/main] protocol.MSG: user data: {Synch.ProcPrep.lang=0, Crypted.CryptHead.KeyName.KIK.blz=XXXXX678, Crypted.CryptData.data=BHNSHK:2:3+999+1055507019+1+1+1::0+1+1:20151006:194457+1:999:1+6:10:16+280:XXXXX678:XXXXXXX:S:0:0'HKIDN:3:2+280:XXXXX678+XXXXXXX+0+1'HKVVB:4:2+0+0+0+HBCI4Java+2.5'HKSYN:5:2+0'HNSHA:6:1+1055507019++XXXXX', Crypted.CryptHead.SecProfile.method=PIN, Synch.Sync.mode=0, Crypted.CryptHead.secfunc=998, Synch.MsgTail.msgnum=1, Crypted.MsgTail.msgnum=1, Synch.Idn.KIK.blz=XXXXX678, Crypted.CryptHead.CryptAlg.keytype=5, Crypted.CryptHead.role=1, Synch.Idn.sysStatus=1, Synch.ProcPrep.UPD=0, Synch.ProcPrep.prodName=HBCI4Java, Crypted.CryptHead.CryptAlg.enckey=B\00\00\00\00\00\00\00\00, Crypted.CryptHead.KeyName.userid=XXXXXXX, Crypted.CryptHead.SecIdnDetails.sysid=0, Crypted.CryptHead.SecIdnDetails.func=1, Crypted.CryptHead.CryptAlg.alg=13, Synch.ProcPrep.BPD=0, Crypted.CryptHead.CryptAlg.mode=2, Crypted.CryptHead.KeyName.KIK.country=DE, Synch.MsgHead.dialogid=0, Synch.Idn.customerid=XXXXXXX, Crypted.CryptHead.KeyName.keyversion=0, Crypted.CryptHead.SecProfile.version=1, Crypted.CryptHead.SecTimestamp.time=19:44:57, Synch.MsgHead.msgnum=1, Crypted.CryptHead.SecTimestamp.date=2015-10-06, Crypted.CryptHead.KeyName.keynum=0, Synch.ProcPrep.prodVersion=2.5, Crypted.MsgHead.msgnum=1, Crypted.CryptHead.compfunc=0, Synch.Idn.sysid=0, Crypted.MsgHead.dialogid=0, Synch.Idn.KIK.country=DE}
<WRN> [2015.10.06 19:44:57.088] [main/main] protocol.MSG: could not insert the following user-defined data into message: Crypted.CryptHead.SecProfile.method=PIN
<WRN> [2015.10.06 19:44:57.089] [main/main] protocol.MSG: could not insert the following user-defined data into message: Crypted.CryptHead.SecProfile.version=1
<DB2> [2015.10.06 19:44:57.091] [main/main] manager.HBCIKernelImpl: encrypted message to be sent: HNHBK:1:3+000000000356+220+0+1'HNVSK:998:2+998+1+1::0+1:20151006:194457+2:2:13:@8@\00\00\00\00\00\00\00\00:5:1+280:XXXXX678:XXXXXXX:V:0:0+0'HNVSD:999:1+@202@HNSHK:2:3+999+1055507019+1+1+1::0+1+1:20151006:194457+1:999:1+6:10:16+280:XXXXX678:XXXXXXX:S:0:0'HKIDN:3:2+280:XXXXX678+XXXXXXX+0+1'HKVVB:4:2+0+0+0+HBCI4Java+2.5'HKSYN:5:2+0'HNSHA:6:1+1055507019++XXXXX''HNHBS:7:1+1'
<DBG> [2015.10.06 19:44:57.091] [main/main] manager.HBCIKernelImpl: communicating dialogid/msgnum 0/1
<DBG> [2015.10.06 19:44:57.091] [main/main] comm.FilterBase64: using filter: MIM (base64)
<INF> [2015.10.06 19:44:57.091] [main/main] comm.CommPinTan: creating a connection to https://127.0.0.1:8443/pintan/PinTanServlet and checking the certificate
<WRN> [2015.10.06 19:44:57.091] [main/main] comm.PinTanSSLSocketFactory: creating socket factory with disabled cert checking
<DBG> [2015.10.06 19:44:57.092] [main/main] comm.CommPinTan: connecting to server
<DBG> [2015.10.06 19:44:57.092] [main/main] comm.CommPinTan: activating modified socket factory for checkCert=false and debugging=false
<DBG> [2015.10.06 19:44:57.092] [main/main] comm.CommPinTan: activating modified hostname verifier because cert checking is disabled
<DB2> [2015.10.06 19:44:57.092] [main/main] comm.PinTanSSLSocketFactory: createSocket()
<DBG> [2015.10.06 19:44:57.102] [main/main] comm.PinTanSSLTrustManager: cert checking disabled -> server cert always OK
<DBG> [2015.10.06 19:44:57.103] [main/main] comm.PinTanSSLTrustManager: cert checking disabled -> will return 'accepted issuers'
<DBG> [2015.10.06 19:44:57.109] [main/main] comm.PinTanSSLHostnameVerifier: cert checking disabled -> hostname always OK
<DBG> [2015.10.06 19:44:57.109] [main/main] comm.CommPinTan: writing data to output stream
<DBG> [2015.10.06 19:44:57.109] [main/main] comm.CommPinTan: closing output stream
<INF> [2015.10.06 19:44:57.109] [main/main] comm.CommPinTan: waiting for response
<DBG> [2015.10.06 19:44:57.182] [main/main] comm.CommPinTan: found messagesize: 240
<DB2> [2015.10.06 19:44:57.182] [main/main] comm.CommPinTan: received 1 bytes
<DB2> [2015.10.06 19:44:57.182] [main/main] comm.CommPinTan: we still need 239 bytes
<DB2> [2015.10.06 19:44:57.182] [main/main] comm.CommPinTan: received 239 bytes
<DB2> [2015.10.06 19:44:57.183] [main/main] comm.CommPinTan: we still need 0 bytes
<DBG> [2015.10.06 19:44:57.183] [main/main] comm.CommPinTan: closing communication line
<DB2> [2015.10.06 19:44:57.183] [main/main] comm.Comm: received message: HNHBK:1:3+000000000179+220+321825383074345556+1+321825383074345556:1'HIRMG:2:2+9800::org.kapott.hbci.exceptions.InitializingException?: error while initializing eleme'HNHBS:3:1+1'
<DBG> [2015.10.06 19:44:57.183] [main/main] comm.Comm: trying to parse message as crypted message
<DBG> [2015.10.06 19:44:57.184] [main/main] comm.Comm: message seems not to be encrypted; tring to parse it as SynchRes message
<DB2> [2015.10.06 19:44:57.194] [main/main] manager.HBCIKernelImpl: received message after decryption: HNHBK:1:3+000000000179+220+321825383074345556+1+321825383074345556:1'HIRMG:2:2+9800::org.kapott.hbci.exceptions.InitializingException?: error while initializing eleme'HNHBS:3:1+1'
<DBG> [2015.10.06 19:44:57.194] [main/main] manager.HBCIKernelImpl: extracting data from received message
<ERR> [2015.10.06 19:44:57.195] [main/main] status.HBCIStatus: HBCI error code: 9800:org.kapott.hbci.exceptions.InitializingException: error while initializing eleme
<DBG> [2015.10.06 19:44:57.195] [main/main] manager.HBCIKernelImpl: looking for a signature
<WRN> [2015.10.06 19:44:57.195] [main/main] security.Sig: message has no signature
<DBG> [2015.10.06 19:44:57.195] [main/main] manager.HBCIKernelImpl: looking if message is encrypted
<ERR> [2015.10.06 19:44:57.195] [main/main] manager.HBCIUtils: org.kapott.hbci.exceptions.HBCI_Exception: message is expected to be encrypted
at org.kapott.hbci.manager.HBCIKernelImpl.rawDoIt(HBCIKernelImpl.java:454)
at org.kapott.hbci.manager.HBCIKernelImpl.rawDoIt(HBCIKernelImpl.java:178)
at org.kapott.hbci.manager.HBCIUser.fetchSysId(HBCIUser.java:442)
at org.kapott.hbci.manager.HBCIUser.updateUserData(HBCIUser.java:665)
at org.kapott.hbci.manager.HBCIUser.register(HBCIUser.java:690)
at org.kapott.hbci.manager.HBCIHandler.registerUser(HBCIHandler.java:279)
at org.kapott.hbci.manager.HBCIHandler.<init>(HBCIHandler.java:133)
at org.kapott.hbci.tools.HBCIBatch.main(HBCIBatch.java:255)
<DBG> [2015.10.06 19:44:57.195] [main/main] passport.AbstractPinTanPassport: dialog init ended with errors - searching for return code 'wrong PIN'
<DBG> [2015.10.06 19:44:57.196] [main/main] passport.AbstractPinTanPassport: autosecfunc: search for 3920s in response to detect allowed twostep secmechs
<DBG> [2015.10.06 19:44:57.196] [main/main] passport.AbstractPinTanPassport: autosecfunc: (re)checking selected pintan secmech
<DBG> [2015.10.06 19:44:57.196] [main/main] passport.AbstractPinTanPassport: autosecfunc: there is only one pintan method (999) supported - choosing this automatically
Exception in thread "main" org.kapott.hbci.exceptions.HBCI_Exception: can not create HBCI handle
at org.kapott.hbci.manager.HBCIHandler.<init>(HBCIHandler.java:142)
at org.kapott.hbci.tools.HBCIBatch.main(HBCIBatch.java:255)
Caused by: org.kapott.hbci.exceptions.HBCI_Exception: can not register user
at org.kapott.hbci.manager.HBCIHandler.registerUser(HBCIHandler.java:281)
at org.kapott.hbci.manager.HBCIHandler.<init>(HBCIHandler.java:133)
... 1 more
Caused by: org.kapott.hbci.exceptions.HBCI_Exception: error while fetching new sysid from institute
at org.kapott.hbci.manager.HBCIUser.fetchSysId(HBCIUser.java:474)
at org.kapott.hbci.manager.HBCIUser.updateUserData(HBCIUser.java:665)
at org.kapott.hbci.manager.HBCIUser.register(HBCIUser.java:690)
at org.kapott.hbci.manager.HBCIHandler.registerUser(HBCIHandler.java:279)
... 2 more
Caused by: org.kapott.hbci.exceptions.ProcessException: error while fetching new sysid from institute
at org.kapott.hbci.manager.HBCIUser.fetchSysId(HBCIUser.java:461)
... 5 more
Apparently, the needtan property is incorrect and it should be 'J' or 'N' but I'm not sure where I can specify this user-defined property. Or is there something else that is causing the error?
Any help would be greatly appreciated. Thanks in advance
