Habe hier wohl auch das Problem,
ich kann das Problem reproduzieren.
Der Fehler kam nachdem ich wohl seit dem 19.11 nicht mehr abgerufen hatte. Also etwas über drei Wochen.
Dann kommt diese Meldung:
Code
[Tue Dec 11 00:07:18 CET 2018][DEBUG][bg-task:Worker][de.willuhn.jameica.hbci.HBCICallbackSWT.log] extracting data from received message
[Tue Dec 11 00:07:18 CET 2018][DEBUG][bg-task:Worker][de.willuhn.jameica.hbci.HBCICallbackSWT.log] looking for a signature
[Tue Dec 11 00:07:18 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.HBCICallbackSWT.status] überprüfe Signatur der Antwortnachricht
[Tue Dec 11 00:07:18 CET 2018][DEBUG][bg-task:Worker][de.willuhn.jameica.hbci.HBCICallbackSWT.log] looking if message is encrypted
[Tue Dec 11 00:07:18 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.HBCICallbackSWT.status] Dialog beendet
[Tue Dec 11 00:07:18 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.executeJobs] executing check for job SaldoReq
[Tue Dec 11 00:07:18 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.handleResult] execution state: tan needed: false, executed: true
[Tue Dec 11 00:07:18 CET 2018][TRACE][bg-task:Worker][de.willuhn.jameica.services.BeanService.get] searching for bean HBCISynchronizeBackend
[Tue Dec 11 00:07:18 CET 2018][TRACE][bg-task:Worker][de.willuhn.jameica.services.BeanService.get] found in context scope
[Tue Dec 11 00:07:18 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.getErrorText] global status:
[Tue Dec 11 00:07:18 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.getErrorText] job status:
[Tue Dec 11 00:07:18 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.getErrorText] retval[0]: 0020 - *Abfrage der Kontosalden erfolgreich.
[Tue Dec 11 00:07:18 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.handleResult] mark job executed [executed: true, status: OK]
[Tue Dec 11 00:07:18 CET 2018][DEBUG][bg-task:Worker][de.willuhn.datasource.db.AbstractDBObject.getInsertSQL] executing sql statement: prep8367: insert into PROTOKOLL (DATUM,KONTO_ID,TYP,KOMMENTAR) values (?,?,?,?) {1: TIMESTAMP '2018-12-11 00:07:18.973', 2: 4, 3: 1, 4: 'Saldo abgerufen'}
[Tue Dec 11 00:07:18 CET 2018][DEBUG][pool-1-thread-1][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message de.willuhn.jameica.messaging.QueryMessage@3cf5abed
[Tue Dec 11 00:07:18 CET 2018][DEBUG][bg-task:Worker][de.willuhn.datasource.db.AbstractDBObject.getInsertSQL] executing sql statement: prep8368: insert into PROTOKOLL (DATUM,KONTO_ID,TYP,KOMMENTAR) values (?,?,?,?) {1: TIMESTAMP '2018-12-11 00:07:18.974', 2: 4, 3: 1, 4: 'Konto-Eigenschaften aktualisiert'}
[Tue Dec 11 00:07:18 CET 2018][DEBUG][pool-1-thread-1][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message de.willuhn.jameica.messaging.QueryMessage@6085d3dc
[Tue Dec 11 00:07:18 CET 2018][DEBUG][bg-task:Worker][de.willuhn.jameica.hbci.HBCICallbackSWT.log] crc-checking 79090000/XXXXX
[Tue Dec 11 00:07:18 CET 2018][DEBUG][bg-task:Worker][de.willuhn.jameica.hbci.HBCICallbackSWT.log] CRC check for 79090000/XXXXX with alg 88: true
[Tue Dec 11 00:07:18 CET 2018][DEBUG][bg-task:Worker][de.willuhn.datasource.db.AbstractDBObject.getUpdateSQL] executing sql statement: prep8369: update KONTO set SALDO=?,SALDO_DATUM=? where ID=4 {1: 2743.2, 2: TIMESTAMP '2018-12-11 00:07:18.973'}
[Tue Dec 11 00:07:18 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.server.hbci.HBCISaldoJob.markExecuted] saldo fetched successfully
[Tue Dec 11 00:07:18 CET 2018][DEBUG][pool-1-thread-1][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message de.willuhn.jameica.messaging.QueryMessage@54e1d435
[Tue Dec 11 00:07:18 CET 2018][DEBUG][pool-1-thread-1][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message de.willuhn.jameica.hbci.messaging.SaldoMessage@5c4cc4e8
[Tue Dec 11 00:07:18 CET 2018][DEBUG][bg-task:Worker][de.willuhn.jameica.hbci.server.KontoUtil.useCamt] checking if account supports CAMT
[Tue Dec 11 00:07:18 CET 2018][DEBUG][bg-task:Worker][de.willuhn.jameica.hbci.server.KontoUtil.useCamt] account does not support CAMT
[Tue Dec 11 00:07:18 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.executeJobs] executing check for job KUmsAll
[Tue Dec 11 00:07:18 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.handleResult] execution state: tan needed: false, executed: true
[Tue Dec 11 00:07:18 CET 2018][TRACE][bg-task:Worker][de.willuhn.jameica.services.BeanService.get] searching for bean HBCISynchronizeBackend
[Tue Dec 11 00:07:18 CET 2018][TRACE][bg-task:Worker][de.willuhn.jameica.services.BeanService.get] found in context scope
[Tue Dec 11 00:07:18 CET 2018][DEBUG][pool-1-thread-1][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message de.willuhn.jameica.messaging.QueryMessage@4d77b64f
[Tue Dec 11 00:07:18 CET 2018][DEBUG][pool-1-thread-1][de.willuhn.jameica.messaging.InvokeScriptMessageConsumer.handleMessage] no script functions registered for event hibiscus.konto.saldo.changed
[Tue Dec 11 00:07:19 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.getErrorText] global status:
[Tue Dec 11 00:07:19 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.getErrorText] job status:
[Tue Dec 11 00:07:19 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.getErrorText] retval[0]: 3040 - *Es liegen weitere Umsätze vor
[Tue Dec 11 00:07:19 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.getErrorText] retval[1]: 0020 - *Umsatzbereitstellung erfolgreich
[Tue Dec 11 00:07:19 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.handleResult] mark job executed [executed: true, status: OK]
[Tue Dec 11 00:07:19 CET 2018][DEBUG][bg-task:Worker][de.willuhn.datasource.db.AbstractDBObject.getInsertSQL] executing sql statement: prep8371: insert into PROTOKOLL (DATUM,KONTO_ID,TYP,KOMMENTAR) values (?,?,?,?) {1: TIMESTAMP '2018-12-11 00:07:19.027', 2: 4, 3: 1, 4: STRINGDECODE('Ums\u00e4tze abgerufen')}
[Tue Dec 11 00:07:19 CET 2018][DEBUG][pool-1-thread-1][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message de.willuhn.jameica.messaging.QueryMessage@322970e
[Tue Dec 11 00:07:19 CET 2018][DEBUG][bg-task:Worker][de.willuhn.jameica.hbci.HBCICallbackSWT.log] now parsing MT94x data
[Tue Dec 11 00:07:19 CET 2018][DEBUG][bg-task:Worker][de.willuhn.jameica.hbci.HBCICallbackSWT.log] now parsing MT94x data
[Tue Dec 11 00:07:19 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.server.hbci.HBCIUmsatzJob.getMergeWindow] merge window: Tue Aug 07 00:00:00 CEST 2018 - now (based on fetched booked entries)
[Tue Dec 11 00:07:19 CET 2018][DEBUG][bg-task:Worker][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.executeJobs] error while processing job result, have error: true, interrupted: false
java.lang.NoSuchFieldError: camtBooked
at de.willuhn.jameica.hbci.server.hbci.HBCIUmsatzJob.markExecuted(HBCIUmsatzJob.java:193)
at de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.markExecutedInternal(AbstractHBCIJob.java:343)
at de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.handleResult(AbstractHBCIJob.java:281)
at de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.executeJobs(HBCISynchronizeBackend.java:393)
at de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.sync(HBCISynchronizeBackend.java:295)
at de.willuhn.jameica.hbci.synchronize.AbstractSynchronizeBackend$Worker.run(AbstractSynchronizeBackend.java:406)
at de.willuhn.jameica.gui.GUI$7.run(GUI.java:1060)
[Tue Dec 11 00:07:19 CET 2018][ERROR][bg-task:Worker][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.executeJobs] error while processing job result
java.lang.NoSuchFieldError: camtBooked
at de.willuhn.jameica.hbci.server.hbci.HBCIUmsatzJob.markExecuted(HBCIUmsatzJob.java:193)
at de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.markExecutedInternal(AbstractHBCIJob.java:343)
at de.willuhn.jameica.hbci.server.hbci.AbstractHBCIJob.handleResult(AbstractHBCIJob.java:281)
at de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.executeJobs(HBCISynchronizeBackend.java:393)
at de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.sync(HBCISynchronizeBackend.java:295)
at de.willuhn.jameica.hbci.synchronize.AbstractSynchronizeBackend$Worker.run(AbstractSynchronizeBackend.java:406)
at de.willuhn.jameica.gui.GUI$7.run(GUI.java:1060)
[Tue Dec 11 00:07:19 CET 2018][DEBUG][pool-1-thread-1][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message de.willuhn.jameica.hbci.synchronize.hbci.HBCITraceMessage@59b8ab23
[Tue Dec 11 00:07:19 CET 2018][WARN][bg-task:Worker][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.sync] found errors or synchronization cancelled, mark PIN cache dirty [have error: true, interrupted: false]
[Tue Dec 11 00:07:19 CET 2018][DEBUG][bg-task:Worker][de.willuhn.jameica.hbci.gui.DialogFactory.getCacheKey] using cache key: hibiscus.pin./Users/derRichter/Synchronisierung/jameica/hibiscus/passports/1332496598598.pt
[Tue Dec 11 00:07:19 CET 2018][WARN][bg-task:Worker][de.willuhn.jameica.hbci.gui.DialogFactory.dirtyPINCache] mark pin cache dirty for single passport
[Tue Dec 11 00:07:19 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.close] closing resources
[Tue Dec 11 00:07:19 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.gui.action.PassportProcessCode3072.handleAction] no changed customer data in persistent data of passport found
[Tue Dec 11 00:07:19 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.passports.pintan.server.PassportHandleImpl.close] closing pin/tan passport
[Tue Dec 11 00:07:19 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.passports.pintan.server.PassportHandleImpl.close] pin/tan passport closed
[Tue Dec 11 00:07:19 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.synchronize.AbstractSynchronizeBackend$Worker.run] Fehler beim Auswerten eines HBCI-Auftrages
de.willuhn.util.ApplicationException: Fehler beim Auswerten eines HBCI-Auftrages
at de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeBackend$HBCIJobGroup.sync(HBCISynchronizeBackend.java:325)
at de.willuhn.jameica.hbci.synchronize.AbstractSynchronizeBackend$Worker.run(AbstractSynchronizeBackend.java:406)
at de.willuhn.jameica.gui.GUI$7.run(GUI.java:1060)
[Tue Dec 11 00:07:19 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.synchronize.AbstractSynchronizeBackend$Worker.updateStatus] updating synchronization status to: ERROR
[Tue Dec 11 00:07:19 CET 2018][DEBUG][bg-task:Worker][de.willuhn.jameica.messaging.NamedConcurrentQueue.sendMessage] no message consumers found, ignoring message
[Tue Dec 11 00:07:19 CET 2018][INFO][bg-task:Worker][de.willuhn.jameica.hbci.synchronize.AbstractSynchronizeBackend$Worker.run] stopping synchronization
Bei einem erneuten Abruf mit dann ja aktualisiertem Kontodatum von heute (also wenn er dann einen kleineren Abrufzeitraum hat) läufts ohne Probleme durch!
Nur dass ich dann keine Umsätze in dem Zeitraum habe und mir die von davor fehlen, jedenfall werden gar keine Umsätze abgerufen, aber der Abruf läuft durch.
Wenn ich jetzt deswegen das "Kontodatum und Saldo" zurücksetze um die fehlenden Umsätze zu bekommen, dann erscheint prompt wieder die obrige Meldung!
Und auch der Hinweis dass in dem Abruf mehrere Umsätze vorhanden sind.
BDP löschen brachte auch nix mehr...
Das identische Verhalten habe ich übrigens auch bei der comdirect Bank, was wohl bedeutet, dass es wohl nicht an der Bank selbst liegt
Oder ist dies doch ein anderer Fehler wie hier und ich soll nen neuen Thread aufmachen?
Ausgeführt unter Hibiscus 2.8.6, Stable
Gruß