Absturz pcscd nach einigen Aktionen

 
Schnapspraline
Benutzer
Avatar
Geschlecht: keine Angabe
Beiträge: 3
Dabei seit: 03 / 2014
Betreff:

Absturz pcscd nach einigen Aktionen

 ·  Gepostet: 30.03.2014 - 11:51 Uhr  ·  #1
Hallo,

meine Schwiegereltern (ich administriere das System) nutzen Hibiscus 2.6.4 mit Jameica 2.6.1 auf Ubuntu 12.04. Es wird eine DDV-Karte der Sparkasse genutzt. Der Kartenleser ist ein ReinerSCT cyberjack Standard. Den Leser spreche ich über den pcsc-ctapi-wrapper an. Ich habe den Treiber von der ReinerSCT-Seite installiert.

In Hibiscus kann ich einige Aktionen durchführen, z.B. die Synchronisation starten und eine Überweisung vornehmen. Weitere Online-Aktionen, z.B. noch eine Überweisung durchführen, funktionieren nicht. Das ganze Programm friert ein. Als letzte Meldung steht im System-Log-Fenster: Bitte legen Sie die Chipkarte in das Lesegerät ...

Hier mal das Log auf Level TRACE (erstes Stück auf INFO):
Code
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SecurityManagerService.init] applying jameica security manager
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.security.JameicaSecurityManager.<init>] protecting program dir /usr/share/jameica/
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.LockService.init] creating lockfile /home/nutzer/.jameica/jameica.lock
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.LockService.init] /home/nutzer/.jameica/jameica.lock successfully locked
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.LogService.init] using log level INFO [100]
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.LogService.init] log file /home/nutzer/.jameica/jameica.log
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.LogService.init] log size 1048576 bytes
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysPropertyService.init] setting sys property: sun.security.smartcardio.library: /lib/x86_64-linux-gnu/libpcsclite.so.1.0.0
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init] starting Jameica Version 2.6.1
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init]   Built-Date : 20140109
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init]   Buildnumber: 439
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init]   max. memory: 227mb
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init]   sys charset: UTF-8
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init] command line parameters
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init] os.arch          : amd64
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init] os.name          : Linux
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init] os.version       : 3.8.0-37-generic
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init] java.version     : 1.7.0_51
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init] java.vendor      : Oracle Corporation
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init] java.runtime.name: OpenJDK Runtime Environment
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init] java.vm.name     : OpenJDK 64-Bit Server VM
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init] user.name        : nutzer
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init] user.home        : /home/nutzer
[Sun Mar 30 10:53:35 CEST 2014][INFO][de.willuhn.jameica.services.SysinfoService.init] file.encoding    : UTF-8

hier sehr viele Initialisierungsmeldung rausgeschnitten wegen der Länge ...

[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.jameica.gui.SplashScreen$3.run]  init plugin hibiscus [Version: 2.6.4] ...
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.jameica.plugin.PluginLoader.initPlugin] init plugin hibiscus [Version: 2.6.4]
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.jameica.plugin.PluginLoader.initPlugin] trying to initialize de.willuhn.jameica.hbci.HBCI
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.jameica.gui.SplashScreen$3.run]  initializing plugin hibiscus ...
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.jameica.hbci.HBCI.init] starting init process for hibiscus
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.jameica.hbci.server.HBCIDBServiceImpl.<init>] loading database driver: de.willuhn.jameica.hbci.server.DBSupportH2Impl
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.jameica.hbci.server.DBSupportH2Impl.<init>] switching dbservice to uppercase
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.jameica.hbci.server.DBSupportH2Impl.<init>] h2 version: 1.3.172
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.datasource.db.DBServiceImpl.start] starting db service
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.jameica.hbci.server.HBCIDBServiceImpl.checkConsistency] init update provider
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.datasource.db.DBServiceImpl.createConnection] creating new connection
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.datasource.db.DBServiceImpl.getConnection] created new connection for <local>
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.sql.version.Updater.execute] current version: 50
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.sql.version.Updater.execute] searching for available updates
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.sql.version.Updater.execute] no new updates found
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.jameica.hbci.server.HBCIDBServiceImpl.checkConsistency] updates finished
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.datasource.db.DBServiceImpl.stop] stopping db service
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.datasource.db.DBServiceImpl.closeConnection] commit connection
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.datasource.db.DBServiceImpl.closeConnection] closing connection
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.datasource.db.DBServiceImpl.closeConnection] connection closed
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.datasource.db.DBServiceImpl.stop] db service stopped [1 connection(s) closed]
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.jameica.gui.SplashScreen$3.run]  hibiscus: init hbci4java subsystem ...
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.util.I18N.<init>] loading resource bundle lang/hibiscus_messages for locale de_DE
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.jameica.hbci.HBCI.initHBCI] callback: de.willuhn.jameica.hbci.HBCICallbackSWT
[Sun Mar 30 10:53:40 CEST 2014][INFO][de.willuhn.jameica.hbci.HBCICallbackSWT.log] This is HBCI4Java-2.5.12

hier sehr viele Initialisierungsmeldung rausgeschnitten wegen der Länge ...

jetzt geht es weiter mit TRACE

[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.gui.Navigation.start] executing navigation entry jameica.start [Jameica]
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean Start
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.services.BeanService.get]   creating new class de.willuhn.jameica.gui.internal.views.Start
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   no lifecycle -> request scope
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.gui.GUI.startView] starting view: de.willuhn.jameica.gui.internal.views.Start
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.sendSyncMessage] no message consumers found, ignoring message
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.gui.GUI$4.run] disposing previous view
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.unRegisterMessageConsumer] queue [default]: unregistering message consumer de.willuhn.jameica.hbci.gui.input.KontoInput$SaldoMessageConsumer
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.gui.GUI$4.run] dispose finished
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.gui.GUI$4.run] adding view de.willuhn.jameica.hbci.gui.views.AuslandsUeberweisungList to history
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.unRegisterMessageConsumer] queue [default]: unregistering message consumer de.willuhn.jameica.hbci.gui.parts.AbstractTransferList$TransferMessageConsumer
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.unRegisterMessageConsumer] queue jameica.bookmark.created: unregistering message consumer de.willuhn.jameica.gui.internal.parts.PanelButtonBookmark$MyCreateMessageConsumer
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.unRegisterMessageConsumer] queue jameica.bookmark.deleted: unregistering message consumer de.willuhn.jameica.gui.internal.parts.PanelButtonBookmark$MyDeleteMessageConsumer
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.sendSyncMessage] no message consumers found, ignoring message
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean FirstStart
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.services.BeanService.get]   creating new class de.willuhn.jameica.gui.boxes.FirstStart
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   no lifecycle -> request scope
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean PluginErrors
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.services.BeanService.get]   creating new class de.willuhn.jameica.gui.boxes.PluginErrors
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   no lifecycle -> request scope
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean SystemMessages
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.services.BeanService.get]   creating new class de.willuhn.jameica.gui.boxes.SystemMessages
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   no lifecycle -> request scope
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean Adressbuch
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.services.BeanService.get]   creating new class de.willuhn.jameica.hbci.gui.boxes.Adressbuch
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   no lifecycle -> request scope
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean FirstStart
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.services.BeanService.get]   creating new class de.willuhn.jameica.hbci.gui.boxes.FirstStart
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   no lifecycle -> request scope
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean Konten
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.services.BeanService.get]   creating new class de.willuhn.jameica.hbci.gui.boxes.Konten
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   no lifecycle -> request scope
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean NachrichtBox
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.services.BeanService.get]   creating new class de.willuhn.jameica.hbci.gui.boxes.NachrichtBox
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   no lifecycle -> request scope
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean NeueUmsaetze
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.services.BeanService.get]   creating new class de.willuhn.jameica.hbci.gui.boxes.NeueUmsaetze
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   no lifecycle -> request scope
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean Overview
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.services.BeanService.get]   creating new class de.willuhn.jameica.hbci.gui.boxes.Overview
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   no lifecycle -> request scope
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean SaldoChart
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.services.BeanService.get]   creating new class de.willuhn.jameica.hbci.gui.boxes.SaldoChart
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   no lifecycle -> request scope
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean Sync
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.services.BeanService.get]   creating new class de.willuhn.jameica.hbci.gui.boxes.Sync
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   no lifecycle -> request scope
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean UmsatzTyp
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.services.BeanService.get]   creating new class de.willuhn.jameica.hbci.gui.boxes.UmsatzTyp
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   no lifecycle -> request scope
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean BootMessageConsumer
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   found in context scope
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep486: select KONTO.* from KONTO
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep487: select SYSTEMNACHRICHT.* from SYSTEMNACHRICHT where gelesen is null or gelesen = 0
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep488: select KONTO.* from KONTO
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep489: select KONTO.* from KONTO
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep490: select KONTO.* from KONTO
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep492: select KONTO.* from KONTO ORDER BY LOWER(kategorie), blz, kontonummer, bezeichnung
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.registerMessageConsumer] queue [default]: registering message consumer de.willuhn.jameica.hbci.gui.input.KontoInput$SaldoMessageConsumer
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.registerMessageConsumer] queue [default]: registering message consumer de.willuhn.jameica.hbci.gui.boxes.Overview$SaldoMessageConsumer
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean SynchronizeEngine
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   found in context scope
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep495: select KONTO.* from KONTO order by blz,bic,passport_class,bezeichnung
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep496: select SEPALASTSCHRIFT.* from SEPALASTSCHRIFT where konto_id = 1 and (ausgefuehrt is null or ausgefuehrt = 0) ORDER BY termin DESC
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep497: select SEPASLAST.* from SEPASLAST where konto_id = 1 and (ausgefuehrt is null or ausgefuehrt = 0)
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep498: select LASTSCHRIFT.* from LASTSCHRIFT where konto_id = 1 and (ausgefuehrt is null or ausgefuehrt = 0)
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep499: select SLASTSCHRIFT.* from SLASTSCHRIFT where konto_id = 1 and (ausgefuehrt is null or ausgefuehrt = 0)
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean HBCISynchronizeJobKontoauszug
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.services.BeanService.get]   creating new class de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeJobKontoauszug
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   no lifecycle -> request scope
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep500: select KONTO.* from KONTO order by blz,bic,passport_class,bezeichnung
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.registerMessageConsumer] queue hibiscus.sync.status: registering message consumer de.willuhn.jameica.hbci.gui.parts.SynchronizeList$SyncMessageConsumer
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.registerMessageConsumer] queue jameica.gui.view.unbind: registering message consumer de.willuhn.jameica.hbci.gui.parts.SynchronizeList$CacheMessageConsumer
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean SynchronizeEngine
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   found in context scope
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep501: select KONTO.* from KONTO order by blz,bic,passport_class,bezeichnung
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep502: select SEPALASTSCHRIFT.* from SEPALASTSCHRIFT where konto_id = 1 and (ausgefuehrt is null or ausgefuehrt = 0) ORDER BY termin DESC
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep503: select SEPASLAST.* from SEPASLAST where konto_id = 1 and (ausgefuehrt is null or ausgefuehrt = 0)
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep504: select LASTSCHRIFT.* from LASTSCHRIFT where konto_id = 1 and (ausgefuehrt is null or ausgefuehrt = 0)
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep505: select SLASTSCHRIFT.* from SLASTSCHRIFT where konto_id = 1 and (ausgefuehrt is null or ausgefuehrt = 0)
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean HBCISynchronizeJobKontoauszug
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.services.BeanService.get]   creating new class de.willuhn.jameica.hbci.synchronize.hbci.HBCISynchronizeJobKontoauszug
[Sun Mar 30 10:55:50 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   no lifecycle -> request scope
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.datasource.db.DBIteratorImpl.init] executing sql query: prep506: select KONTO.* from KONTO order by blz,bic,passport_class,bezeichnung
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.registerMessageConsumer] queue [default]: registering message consumer de.willuhn.jameica.hbci.gui.parts.UmsatzList$UmsatzChangedMessageConsumer
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.registerMessageConsumer] queue [default]: registering message consumer de.willuhn.jameica.hbci.gui.parts.UmsatzList$UmsatzNewMessageConsumer
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.sendSyncMessage] no message consumers found, ignoring message
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.sendSyncMessage] no message consumers found, ignoring message
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.gui.parts.TablePart.paint] restoring last table order: flags
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.gui.parts.TablePart.orderBy] table ordered by flags
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.gui.parts.table.FeatureShortcut.applyShortcuts] bound ALT+G: de.willuhn.jameica.hbci.gui.action.FlaggableChange
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.gui.parts.table.FeatureShortcut.applyShortcuts] bound ALT+CTRL+G: de.willuhn.jameica.hbci.gui.action.FlaggableChange
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.gui.parts.table.FeatureShortcut.applyShortcuts] bound ALT+K: de.willuhn.jameica.hbci.gui.action.UmsatzAssign
[Sun Mar 30 10:55:50 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.sendSyncMessage] no message consumers found, ignoring message
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.gui.parts.SynchronizeList$SyncStart.handleAction] Collecting synchronize jobs
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.gui.action.Synchronize.handleAction] Start synchronization
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.gui.action.Synchronize.handleAction] backends to synchronize: 1
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.gui.action.Synchronize.handleAction] synchronizing 1 backends
[Sun Mar 30 10:55:51 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.registerMessageConsumer] queue hibiscus.sync.status: registering message consumer de.willuhn.jameica.hbci.gui.action.Synchronize$MyMessageConsumer
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.gui.action.Synchronize.sync] synchronizing backend HBCI with 1 jobs
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.synchronize.AbstractSynchronizeBackend.execute] starting HBCI synchronization
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.synchronize.AbstractSynchronizeBackend$Worker.<init>] accounts to synchronize: 1, jobs: 1
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.synchronize.AbstractSynchronizeBackend$Worker.updateStatus] updating synchronization status to: RUNNING
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.gui.internal.parts.BackgroundTaskMonitor.check] creating progress monitor for GUI
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.gui.internal.parts.BackgroundTaskMonitor$2.run] activating progress monitor
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.synchronize.AbstractSynchronizeBackend$Worker.run] BEGIN synchronization of account 1/1
[Sun Mar 30 10:55:51 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message de.willuhn.jameica.messaging.QueryMessage@3a4d75b2
[Sun Mar 30 10:55:51 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message [Sun Mar 30 10:55:51 CEST 2014][OK] Synchronisierung via HBCI läuft
[Sun Mar 30 10:55:51 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message de.willuhn.jameica.hbci.synchronize.hbci.HBCITraceMessage@336a1705
[Sun Mar 30 10:55:51 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message de.willuhn.jameica.hbci.synchronize.hbci.HBCITraceMessage@7a0d63a1
[Sun Mar 30 10:55:51 CEST 2014][DEBUG][de.willuhn.jameica.hbci.PassportRegistry.load] [de.willuhn.jameica.hbci.passports.ddv.server.PassportImpl][Chipkarte (DDV)] instantiated successfully
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.passports.ddv.server.PassportHandleImpl.open] open ddv passport
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.passports.ddv.DDVConfigFactory.findByKonto] searching config for konto [entfernt], blz: [entfernt]
[Sun Mar 30 10:55:51 CEST 2014][DEBUG][de.willuhn.datasource.db.AbstractDBObject.load] executing query: select * from KONTO where ID = 1
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.passports.ddv.DDVConfigFactory.findByKonto] found config via account. name: Reiner SCT cyberJack Standard
[Sun Mar 30 10:55:51 CEST 2014][DEBUG][de.willuhn.jameica.hbci.passports.ddv.server.PassportHandleImpl.open] using config Reiner SCT cyberJack Standard
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.passports.ddv.DDVConfigFactory.createPassport]   jni lib: /usr/share/jameica/plugins/hibiscus/lib/libhbci4java-card-linux-64.so
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.passports.ddv.DDVConfigFactory.createPassport]   ctapi driver: /usr/local/lib/libpcsc-ctapi-wrapper.so.0.3
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.passports.ddv.DDVConfigFactory.createPassport]   port: COM2/USB2 [ID: 1]
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.passports.ddv.DDVConfigFactory.createPassport]   ctnumber: 0
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.passports.ddv.DDVConfigFactory.createPassport]   soft pin: false
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.passports.ddv.DDVConfigFactory.createPassport]   entry index: 2
[Sun Mar 30 10:55:51 CEST 2014][INFO][de.willuhn.jameica.hbci.passports.ddv.DDVConfigFactory.createPassport]   passport type: DDV
[Sun Mar 30 10:55:51 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean HBCISynchronizeBackend
[Sun Mar 30 10:55:51 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   found in context scope
[Sun Mar 30 10:55:51 CEST 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] creating new instance of a DDV passport
[Sun Mar 30 10:55:51 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean HBCISynchronizeBackend
[Sun Mar 30 10:55:51 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   found in context scope
[Sun Mar 30 10:55:51 CEST 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] trying to load native DDV library /usr/share/jameica/plugins/hibiscus/lib/libhbci4java-card-linux-64.so
[Sun Mar 30 10:55:51 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean HBCISynchronizeBackend
[Sun Mar 30 10:55:51 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   found in context scope
[Sun Mar 30 10:55:51 CEST 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.log] using chipcard terminal with port 1 and terminal number 0
[Sun Mar 30 10:55:51 CEST 2014][DEBUG][de.willuhn.jameica.hbci.AbstractHibiscusHBCICallback.update] [bpd] no version, no userid or no data found, skipping update
[Sun Mar 30 10:55:51 CEST 2014][DEBUG][de.willuhn.jameica.hbci.AbstractHibiscusHBCICallback.update] [upd] no version, no userid or no data found, skipping update
[Sun Mar 30 10:55:51 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean HBCISynchronizeBackend
[Sun Mar 30 10:55:51 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   found in context scope
[Sun Mar 30 10:55:51 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean HBCISynchronizeBackend
[Sun Mar 30 10:55:51 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   found in context scope
[Sun Mar 30 10:55:51 CEST 2014][DEBUG][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message [Sun Mar 30 10:55:51 CEST 2014][OK] Bitte legen Sie die Chipkarte in das Lesegerät. S-GeschäftsKonto, Kto. [entfernt] [Sparkasse entfernt]
[Sun Mar 30 10:55:51 CEST 2014][DEBUG][de.willuhn.jameica.hbci.HBCICallbackSWT.callback] callback [reason 2] handled by class de.willuhn.jameica.hbci.passports.ddv.server.PassportHandleImpl
[Sun Mar 30 10:55:51 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get] searching for bean HBCISynchronizeBackend
[Sun Mar 30 10:55:51 CEST 2014][TRACE][de.willuhn.jameica.services.BeanService.get]   found in context scope
[Sun Mar 30 10:55:51 CEST 2014][TRACE][de.willuhn.jameica.hbci.HBCICallbackSWT.log] loading lib ok
Meine Schwiegereltern haben sich damit beholfen, den Rechner neu zu starten. Dann geht es wieder für eine weitere Überweisung. Dann wieder neu starten ...

Ganz schön lästig.

Ich habe nun herausgefunden, dass das Abziehen und Wiederanstecken des Lesers auch hilft (Karte muss auch noch aus- und wieder eingesteckt werden). Leider auch sehr fummelig, da die USB-Buchse hinten am Computer sitzt.

Wenn ich
Code
sudo ps ax
im Terminal ausführe, dann fiel mir auf, dass es mehrere pcscd-Prozesse gibt:
Code
3617 ?        S      0:00 pcscd --auto-exit
3618 ?        S      0:00 pcscd --auto-exit
Nach mehreren Stunden Suche im Internet habe ich mir ein Skript zusammengebastelt, welches auch hilft:
Code
#!/bin/bash
gksu -p -m "Bitte Passwort eingeben:" | sudo -S sh -c -- "/etc/init.d/pcscd stop ; sleep 2s ; killall -s KILL pcscd ; sleep 1s ; /etc/init.d/pcscd start"
Dieses Skript führt man aus, wenn Hibiscus nicht mehr reagiert. Hibiscus meldet dann, das libpcsc-ctapi-wrapper.so.0.3 nicht geladen werden konnte. Dann steckt man die Karte aus und wieder ein - und jetzt geht es wieder. Aber nur wieder eine Weile, dann muss man das Skript erneut ausführen.

Immer noch nicht schön.

Ist dieses Verhalten bekannt und gibt es vielleicht Abhilfe?

Hier noch meine Java-Version:
Code
java version "1.7.0_51"
OpenJDK Runtime Environment (IcedTea 2.4.4) (7u51-2.4.4-0ubuntu0.12.04.2)
OpenJDK 64-Bit Server VM (build 24.45-b08, mixed mode)


Danke und Grüße

Jan
Odin
Benutzer
Avatar
Geschlecht: keine Angabe
Herkunft: Bayerisch Venedig
Homepage: sparkasse-passau.d…
Beiträge: 769
Dabei seit: 11 / 2004
Betreff:

Re: Absturz pcscd nach einigen Aktionen

 ·  Gepostet: 30.03.2014 - 20:15 Uhr  ·  #2
Moin moin,

ähnliche Auffälligkeiten kenne ich auch von WIN-Systemen unter dann entsprechend anderen Banking-Systemen. Da sind es dann zumeist echte Hardware-Probleme mit dem USB.Anschluß - Stichwort. Spannungsversorgung und/oder Stromspaarfunktionen und kein "vernünftiges" wieder aufwachen nach der "Ruhephase"... - ggfs mal einen anderen Steckplatz benutzen und/oder das BIOS mal nach Stromsparfunktionen durchforsten und diese abschalten - vielleicht kann auch ein HUB mit eigener Stromquelle hilfreich sein...
- zu evtl. Linux-Besonderheiten kann ich hier nichts beitragen

Viel Erfolg

Gruß

Od
Schnapspraline
Benutzer
Avatar
Geschlecht: keine Angabe
Beiträge: 3
Dabei seit: 03 / 2014
Betreff:

Re: Absturz pcscd nach einigen Aktionen

 ·  Gepostet: 01.04.2014 - 20:20 Uhr  ·  #3
Hallo,

den Kartenleser hatte ich testweise an einen USB 2.0-Port, an einen USB 3.0-Port und an einen Hub mit eigener Stromversorgung gehängt. All dies brachte keine Besserung.

Auf die Idee mit den Stromsparfunktionen des Bios bin ich nicht gekommen, dass werde ich überprüfen. Bin aber erst Ende April wieder bei meinen Schwiegereltern.

Danke und Grüße

Jan
Schnapspraline
Benutzer
Avatar
Geschlecht: keine Angabe
Beiträge: 3
Dabei seit: 03 / 2014
Betreff:

Re: Absturz pcscd nach einigen Aktionen

 ·  Gepostet: 13.04.2014 - 21:59 Uhr  ·  #4
Hallo,

es war mir möglich, den Kartenleser direkt als PC/SC-Gerät zu konfigurieren. Der pcsc-ctapi-wrapper wird nun nicht mehr benötigt. Und siehe da, jetzt funktioniert alles wunderbar.

Grüße

Jan
Gewählte Zitate für Mehrfachzitierung:   0