Moin,
habe genau das gleiche Problem mit dem Zugang zu CortalConsors...seit knapp 1 Woche.
Jamaica:
Version: 2.6.1
SWT-Version: 4332 / win32
Java-Version: 1.6.0_30 / Windows 7 amd64
Build: 439 [Datum 20140109]
Hibiscus:
Software-Version: 2.6.4
Datenbank-Version: 50
Build: 361 [Datum 20140309]
Mehrfach habe ich den Bankzugang (PIN/TAN) gelöscht und neu angelegt. Teilweise ging alles gut bis zum ersten Abruf Versuch der Salden / Umsätze, teilweise kam nicht mal das Anlegen des Bankzugangs zustande.
Laut CortalConsors wurde das Backend in den Letzten Tagen auf HBCI+ umgestellt, was für dieses Verhalten evtl. verantwortlich sein könnte. Den Bankzugang habe ich mit FinTS 3.0 und HBCI+ versucht zu synchronisieren. Bei beiden das gleiche Ergebnis.
Der Hinweis mit den Proxy Einstellungen hat leider keinen Erfolg gebracht.
Über das DDBAC Framework kann problemlos auf den Bankserver zugegriffen werden. Salden und Umsätze lassen sich wie gewohnt abrufen. Also ist das Backend wohl ansprechbar.
Code
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] onestep method - checking GVs to decide whether or not we need a TAN
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] trying to encrypt message
[Mon Mar 17 09:47:47 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.status] verschlüssele HBCI-Nachricht
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting secfunc to 998
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting keytype to 5
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting blz to 76030080
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting country to DE
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting keyuserid to XXXXXXXXXXXX
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting keynum to 0
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting keyversion to 0
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting cid to
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting sysId to 000003UF5KRB6S3CFB5OPPCDICBP3O
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting role to 1
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting alg to 13
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting mode to 2
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting compfunc to 0
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] could not insert the following user-defined data into message: Crypted.CryptHead.SecProfile.version=1
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] could not insert the following user-defined data into message: Crypted.CryptHead.SecProfile.method=PIN
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] communicating dialogid/msgnum 0/1
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] using filter: MIM (base64)
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep127: select VERSION.* from VERSION where name = ? {1: 'bpd.910767419001'}
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep128: select VERSION.* from VERSION where name = ? {1: 'upd.910767419001'}
[Mon Mar 17 09:47:47 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.log] creating a connection to https://brokerage-hbci.consors.de:443/hbci and checking the certificate
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] using system socket factory
[Mon Mar 17 09:47:47 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.status] versende HBCI-Nachricht
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] connecting to server
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] activating modified socket factory for checkCert=true and debugging=true
[Mon Mar 17 09:47:47 CET 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message de.willuhn.jameica.hbci.synchronize.hbci.HBCITraceMessage@4eeaabad
[Mon Mar 17 09:47:47 CET 2014][WARN][de.willuhn.jameica.hbci.HBCICallbackSWT.log] no log.ssl.filename specified - logging to HBCI4Java logger
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.security.JameicaTrustManager.checkServerTrusted] checking server certificate via system trustmanager
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.security.JameicaTrustManager.checkServerTrusted] server certificate trusted via system trustmanager [vendor: Sun Microsystems Inc.]
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] writing data to output stream
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] closing output stream
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.status] warte auf Antwortdaten
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.log] waiting for response
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] found messagesize: 963
[Mon Mar 17 09:47:48 CET 2014][ERROR][de.willuhn.jameica.hbci.HBCICallbackSWT.log] org.kapott.hbci.exceptions.HBCI_Exception: Fehler beim Empfangen der Daten vom HBCI-Server
at org.kapott.hbci.comm.CommPinTan.pong(CommPinTan.java:189)
at org.kapott.hbci.comm.Comm.pingpong(Comm.java:71)
at org.kapott.hbci.manager.HBCIKernelImpl.rawDoIt(HBCIKernelImpl.java:352)
at org.kapott.hbci.manager.HBCIKernelImpl.rawDoIt(HBCIKernelImpl.java:178)
at org.kapott.hbci.manager.HBCIDialog.doDialogInit(HBCIDialog.java:149)
at org.kapott.hbci.manager.HBCIDialog.doIt(HBCIDialog.java:402)
at org.kapott.hbci.manager.HBCIHandler.execute(HBCIHandler.java:456)
at org.kapott.hbci.manager.HBCIHandler.updateSEPAInfo(HBCIHandler.java:174)
at org.kapott.hbci.manager.HBCIHandler.<init>(HBCIHandler.java:149)
at de.willuhn.jameica.hbci.passports.pintan.server.PassportHandleImpl.open(PassportHandleImpl.java:180)
at de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup$TaskHandleOpen.internalExecute(HBCISynchronizeBackend.java:483)
at de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup$TaskHandleOpen.internalExecute(HBCISynchronizeBackend.java:455)
at de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup$AbstractTaskWrapper.run(HBCISynchronizeBackend.java:592)
at org.eclipse.swt.widgets.RunnableLock.run(Unknown Source)
at org.eclipse.swt.widgets.Synchronizer.runAsyncMessages(Unknown Source)
at org.eclipse.swt.widgets.Display.runAsyncMessages(Unknown Source)
at org.eclipse.swt.widgets.Display.readAndDispatch(Unknown Source)
at de.willuhn.jameica.gui.GUI.loop(GUI.java:827)
at de.willuhn.jameica.gui.GUI.init(GUI.java:310)
at de.willuhn.jameica.system.Application.init(Application.java:148)
at de.willuhn.jameica.system.Application.newInstance(Application.java:90)
at de.willuhn.jameica.Main.main(Main.java:78)
Caused by: java.io.IOException: Server returned HTTP response code: 400 for URL: https://brokerage-hbci.consors.de:443/hbci
at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
at sun.reflect.NativeConstructorAccessorImpl.newInstance(Unknown Source)
at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(Unknown Source)
at java.lang.reflect.Constructor.newInstance(Unknown Source)
at sun.net.www.protocol.http.HttpURLConnection$6.run(Unknown Source)
at java.security.AccessController.doPrivileged(Native Method)
at sun.net.www.protocol.http.HttpURLConnection.getChainedException(Unknown Source)
at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
at sun.net.www.protocol.https.HttpsURLConnectionImpl.getInputStream(Unknown Source)
at org.kapott.hbci.comm.CommPinTan.pong(CommPinTan.java:170)
... 21 more
Caused by: java.io.IOException: Server returned HTTP response code: 400 for URL: https://brokerage-hbci.consors.de:443/hbci
at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
at sun.net.www.protocol.http.HttpURLConnection.getHeaderField(Unknown Source)
at java.net.URLConnection.getHeaderFieldInt(Unknown Source)
at java.net.URLConnection.getContentLength(Unknown Source)
at sun.net.www.protocol.https.HttpsURLConnectionImpl.getContentLength(Unknown Source)
at org.kapott.hbci.comm.CommPinTan.pong(CommPinTan.java:162)
... 21 more org.kapott.hbci.manager.HBCIUtils.log(HBCIUtils.java:1109)
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] dialog init ended with errors - searching for return code 'wrong PIN'
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] autosecfunc: search for 3920s in response to detect allowed twostep secmechs
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] autosecfunc: (re)checking selected pintan secmech
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] autosecfunc: there is only one pintan method (999) supported - choosing this automatically
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.status] Dialog initialisiert - Dialog-ID ist null
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep129: select VERSION.* from VERSION where name = ? {1: 'bpd.910767419001'}
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep130: select VERSION.* from VERSION where name = ? {1: 'upd.910767419001'}
[Mon Mar 17 09:47:48 CET 2014][ERROR][de.willuhn.jameica.hbci.HBCICallbackSWT.log] error while fetching information about SEPA accounts from institute: org.kapott.hbci.manager.HBCIHandler.updateSEPAInfo(HBCIHandler.java:181)
[Mon Mar 17 09:47:48 CET 2014][ERROR][de.willuhn.jameica.hbci.HBCICallbackSWT.log] Dialog for 'XXXXXXXXXXXX':
DIALOG-INITIALISIERUNG:
java.io.IOException: Server returned HTTP response code: 400 for URL: https://brokerage-hbci.consors.de:443/hbci
DIALOG-ENDE:
(not status information available) org.kapott.hbci.manager.HBCIHandler.updateSEPAInfo(HBCIHandler.java:182)
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup$TaskSepaInfo.internalExecute] sepa infos:
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup$TaskSepaInfo.internalExecute] cansingleaccquery, value: J
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup$TaskSepaInfo.internalExecute] suppformats, value: urn:iso:std:iso:20022:tech:xsd:pain.001.002.03
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup$TaskSepaInfo.internalExecute] canstructusage, value: J
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup$TaskSepaInfo.internalExecute] suppformats_6, value: sepade.pain.008.001.01.xsd
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup$TaskSepaInfo.internalExecute] suppformats_5, value: urn:swift:xsd:$pain.008.002.01
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup$TaskSepaInfo.internalExecute] suppformats_4, value: urn:iso:std:iso:20022:tech:xsd:pain.008.002.02
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup$TaskSepaInfo.internalExecute] suppformats_3, value: sepade.pain.001.001.02.xsd
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup$TaskSepaInfo.internalExecute] suppformats_2, value: urn:swift:xsd:$pain.001.002.02
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup$TaskSepaInfo.internalExecute] cannationalacc, value: J
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.<init>] creating message queue hibiscus.sepainfo
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.sendMessage] no message consumers found, ignoring message
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.sync] processing jobs
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.sync] adding job SaldoReq to queue
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] creating new job SaldoReq
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.dumpJob] Job restrictions for Saldo6
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting lowlevel parameter Saldo6.KTV.KIK.country = DE
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting lowlevel parameter Saldo6.KTV.KIK.blz = 76030080
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting lowlevel parameter Saldo6.KTV.number = XXXXXXXXX
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting lowlevel parameter Saldo6.curr = EUR
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] using default customerid XXXXXXXXXXXX
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] have to create new dialog for customerid XXXXXXXXXXXX
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] creating new dialog
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.log] adding job Saldo6 to dialog
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting lowlevel parameter Saldo6.allaccounts = N
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] crc-checking 76030080/XXXXXXXXX
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] CRC check for 76030080/XXXXXXXXX with alg 01: true
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] there are currently 0 GV segs in this message
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.sync] adding job KUmsAll to queue
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] creating new job KUmsAll
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.dumpJob] Job restrictions for KUmsZeit6
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.dumpJob] canmaxentries: J
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.dumpJob] timerange: 90
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.dumpJob] canallaccounts: N
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting lowlevel parameter KUmsZeit6.KTV.KIK.country = DE
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting lowlevel parameter KUmsZeit6.KTV.KIK.blz = 76030080
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting lowlevel parameter KUmsZeit6.KTV.number = XXXXXXXXX
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] using default customerid XXXXXXXXXXXX
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.log] adding job KUmsZeit6 to dialog
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting lowlevel parameter KUmsZeit6.allaccounts = N
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] crc-checking 76030080/XXXXXXXXX
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] CRC check for 76030080/XXXXXXXXX with alg 01: true
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] there are currently 1 GV segs in this message
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.log] have to generate new message because current type of passport only allows 1 GV segs per message
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] starting new message
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.sync] executing jobs
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.log] executing dialog for customerid XXXXXXXXXXXX
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] executing dialog
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] checking whether passport is supported (but ignoring result)
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] autosecfunc: (re)checking selected pintan secmech
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] autosecfunc: there is only one pintan method (999) supported - choosing this automatically
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] supported: pintan-onestep
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] passport supported: true
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.log] processing dialog init
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.status] führe Dialog-Initialisierung aus
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] generating raw message DialogInit
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.status] erzeuge HBCI-Nachricht DialogInit
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] trying to insert signature
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.status] signiere HBCI-Nachricht
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting secfunc to 999
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting cid to
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting role to 1
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting range to 1
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting keyblz to 76030080
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting keycountry to DE
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting keyuserid to XXXXXXXXXXXX
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting keynum to 0
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting keyversion to 0
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting sysid to 000003UF5KRB6S3CFB5OPPCDICBP3O
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting sigid to 1
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting sigalg to 10
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting sigmode to 16
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting hashalg to 999
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] saving two step mechs: 999,
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] saving current tan method: 999
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] onestep method - checking GVs to decide whether or not we need a TAN
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] trying to encrypt message
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.status] verschlüssele HBCI-Nachricht
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting secfunc to 998
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting keytype to 5
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting blz to 76030080
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting country to DE
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting keyuserid to XXXXXXXXXXXX
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting keynum to 0
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting keyversion to 0
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting cid to
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting sysId to 000003UF5KRB6S3CFB5OPPCDICBP3O
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting role to 1
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting alg to 13
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting mode to 2
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] setting compfunc to 0
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] could not insert the following user-defined data into message: Crypted.CryptHead.SecProfile.version=1
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] could not insert the following user-defined data into message: Crypted.CryptHead.SecProfile.method=PIN
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] communicating dialogid/msgnum 0/1
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] using filter: MIM (base64)
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep131: select VERSION.* from VERSION where name = ? {1: 'bpd.910767419001'}
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep132: select VERSION.* from VERSION where name = ? {1: 'upd.910767419001'}
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.log] creating a connection to https://brokerage-hbci.consors.de:443/hbci and checking the certificate
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] using system socket factory
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.status] versende HBCI-Nachricht
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message de.willuhn.jameica.hbci.synchronize.hbci.HBCITraceMessage@24459efb
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] connecting to server
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] activating modified socket factory for checkCert=true and debugging=true
[Mon Mar 17 09:47:48 CET 2014][WARN][de.willuhn.jameica.hbci.HBCICallbackSWT.log] no log.ssl.filename specified - logging to HBCI4Java logger
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.security.JameicaTrustManager.checkServerTrusted] checking server certificate via system trustmanager
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.security.JameicaTrustManager.checkServerTrusted] server certificate trusted via system trustmanager [vendor: Sun Microsystems Inc.]
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] writing data to output stream
[Mon Mar 17 09:47:48 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] closing output stream
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.status] warte auf Antwortdaten
[Mon Mar 17 09:47:48 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.log] waiting for response
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] found messagesize: 963
[Mon Mar 17 09:47:49 CET 2014][ERROR][de.willuhn.jameica.hbci.HBCICallbackSWT.log] org.kapott.hbci.exceptions.HBCI_Exception: Fehler beim Empfangen der Daten vom HBCI-Server
at org.kapott.hbci.comm.CommPinTan.pong(CommPinTan.java:189)
at org.kapott.hbci.comm.Comm.pingpong(Comm.java:71)
at org.kapott.hbci.manager.HBCIKernelImpl.rawDoIt(HBCIKernelImpl.java:352)
at org.kapott.hbci.manager.HBCIKernelImpl.rawDoIt(HBCIKernelImpl.java:178)
at org.kapott.hbci.manager.HBCIDialog.doDialogInit(HBCIDialog.java:149)
at org.kapott.hbci.manager.HBCIDialog.doIt(HBCIDialog.java:402)
at org.kapott.hbci.manager.HBCIHandler.execute(HBCIHandler.java:456)
at de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.sync(HBCISynchronizeBackend.java:256)
at de.willuhn.jameica.hbci.synchronize.AbstractSynchronizeBackend$Worker.run(AbstractSynchronizeBackend.java:381)
at de.willuhn.jameica.gui.GUI$6.run(GUI.java:964)
Caused by: java.io.IOException: Server returned HTTP response code: 400 for URL: https://brokerage-hbci.consors.de:443/hbci
at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
at sun.reflect.NativeConstructorAccessorImpl.newInstance(Unknown Source)
at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(Unknown Source)
at java.lang.reflect.Constructor.newInstance(Unknown Source)
at sun.net.www.protocol.http.HttpURLConnection$6.run(Unknown Source)
at java.security.AccessController.doPrivileged(Native Method)
at sun.net.www.protocol.http.HttpURLConnection.getChainedException(Unknown Source)
at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
at sun.net.www.protocol.https.HttpsURLConnectionImpl.getInputStream(Unknown Source)
at org.kapott.hbci.comm.CommPinTan.pong(CommPinTan.java:170)
... 9 more
Caused by: java.io.IOException: Server returned HTTP response code: 400 for URL: https://brokerage-hbci.consors.de:443/hbci
at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
at sun.net.www.protocol.http.HttpURLConnection.getHeaderField(Unknown Source)
at java.net.URLConnection.getHeaderFieldInt(Unknown Source)
at java.net.URLConnection.getContentLength(Unknown Source)
at sun.net.www.protocol.https.HttpsURLConnectionImpl.getContentLength(Unknown Source)
at org.kapott.hbci.comm.CommPinTan.pong(CommPinTan.java:162)
... 9 more org.kapott.hbci.manager.HBCIUtils.log(HBCIUtils.java:1109)
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] dialog init ended with errors - searching for return code 'wrong PIN'
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] autosecfunc: search for 3920s in response to detect allowed twostep secmechs
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] autosecfunc: (re)checking selected pintan secmech
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] autosecfunc: there is only one pintan method (999) supported - choosing this automatically
[Mon Mar 17 09:47:49 CET 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.status] Dialog initialisiert - Dialog-ID ist null
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep133: select VERSION.* from VERSION where name = ? {1: 'bpd.910767419001'}
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep134: select VERSION.* from VERSION where name = ? {1: 'upd.910767419001'}
[Mon Mar 17 09:47:49 CET 2014][INFO][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.sync] executing check for job SaldoReq
[Mon Mar 17 09:47:49 CET 2014][INFO][de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.getStatusText] global status:
[Mon Mar 17 09:47:49 CET 2014][INFO][de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.getStatusText] job status:
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.util.ClassFinder.findImplementors] used time to search for implementors of de.willuhn.jameica.hbci.rmi.Protokoll: 0 millis]
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.datasource.db.AbstractDBObject.getInsertSQL] executing sql statement: prep136: insert into PROTOKOLL (KOMMENTAR,KONTO_ID,TYP,DATUM) values (?,?,?,?) {1: 'Fehler beim Abrufen das Saldos: Unbekannter Fehler', 2: 3, 3: 2, 4: TIMESTAMP '2014-03-17 09:47:49.108'}
[Mon Mar 17 09:47:49 CET 2014][INFO][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.sync] executing check for job KUmsAll
[Mon Mar 17 09:47:49 CET 2014][INFO][de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.getStatusText] global status:
[Mon Mar 17 09:47:49 CET 2014][INFO][de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.getStatusText] job status:
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.datasource.db.AbstractDBObject.getInsertSQL] executing sql statement: prep137: insert into PROTOKOLL (KONTO_ID,KOMMENTAR,TYP,DATUM) values (?,?,?,?) {1: 3, 2: STRINGDECODE('Fehler beim Abrufen der Ums\u00e4tze: Unbekannter Fehler'), 3: 2, 4: TIMESTAMP '2014-03-17 09:47:49.126'}
[Mon Mar 17 09:47:49 CET 2014][WARN][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.sync] found errors or synchronization cancelled, clear PIN cache
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.hbci.gui.DialogFactory.getCacheKey] using cache key: hibiscus.pin.E:\HB\usr\jamaica_nightly\hibiscus\passports\1395045073674.pt
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.hbci.gui.DialogFactory.getCacheKey] using cache key: hibiscus.pin.E:\HB\usr\jamaica_nightly\hibiscus\passports\1395045073674.pt
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.Wallet.get] reading key hibiscus.pin.E:\HB\usr\jamaica_nightly\hibiscus\passports\1395045073674.pt
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.Wallet.delete] removing key hibiscus.pin.E:\HB\usr\jamaica_nightly\hibiscus\passports\1395045073674.pt
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.Wallet.write] writing wallet file E:\HB\usr\jamaica_nightly\cfg/de.willuhn.jameica.hbci.HBCI.wallet2 via RSAEngine
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.Wallet.write] serializing wallet
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.crypto.RSAEngine.encrypt] creating cipher
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.crypto.RSAEngine.encrypt] encrypting data
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.crypto.RSAEngine.encrypt] using block size (in bytes): 255
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.Wallet.write] test if readable
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.Wallet.read] reading wallet file E:\HB\usr\jamaica_nightly\cfg\de.willuhn.jameica.hbci.HBCI.wallet2_4871652571419639146 via RSAEngine
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.crypto.RSAEngine.decrypt] creating cipher
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.crypto.RSAEngine.decrypt] using block size (in bytes): 256
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.crypto.RSAEngine.decrypt] decrypting data
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.Wallet.read] deserializing wallet
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.Wallet.read] reading wallet done
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.Wallet.write] renaming temp file
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.security.Wallet.write] writing wallet done
[Mon Mar 17 09:47:49 CET 2014][INFO][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.close] closing resources
[Mon Mar 17 09:47:49 CET 2014][INFO][de.willuhn.jameica.hbci.passports.pintan.server.PassportHandleImpl.close] closing pin/tan passport
[Mon Mar 17 09:47:49 CET 2014][INFO][de.willuhn.jameica.hbci.passports.pintan.server.PassportHandleImpl.close] pin/tan passport closed
[Mon Mar 17 09:47:49 CET 2014][INFO][de.willuhn.jameica.hbci.synchronize.AbstractSynchronizeBackend$Worker.updateStatus] updating synchronization status to: ERROR
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.sendMessage] no message consumers found, ignoring message
[Mon Mar 17 09:47:49 CET 2014][INFO][de.willuhn.jameica.hbci.synchronize.AbstractSynchronizeBackend$Worker.run] stopping synchronization
[Mon Mar 17 09:47:49 CET 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message [Mon Mar 17 09:47:49 CET 2014][ERROR] Fehler beim Auswerten eines HBCI-Auftrages
[Mon Mar 17 09:47:49 CET 2014][INFO][de.willuhn.jameica.hbci.synchronize.AbstractSynchronizeBackend$Worker.run] finished
Vielen Dank schon mal.
T. Holenbach