Automatische Backup sporadisch unvollständig

Der Prozess kann nicht auf die Datei zugreifen, da ein anderer Prozess einen Teil der Datei gesperrt hat

 
Benutzer
Avatar
Geschlecht: keine Angabe
Beiträge: 25
Dabei seit: 01 / 2019
Betreff:

Automatische Backup sporadisch unvollständig

 · 
Gepostet: 22.03.2020 - 16:36 Uhr  ·  #1
Hallo,

mir ist aufgefallen, dass die beim Beenden von Hibiscus automatisch erstellten Backups sich in zwei Lager teilen:
- ZIP-Dateien von ein paar MB Größe
- ZIP-Dateien mit nur rund 20 KB Größe

In der letzten Gruppe hat hibiscus.h2.db eine Größe von 0 Bytes, und das Verzeichnis ...\hibiscus\passports fehlt.

Seit 4 Tagen gibt es nur noch unvollständige Backups, zuvor gab es im zeitlichen Verlauf immer mal wieder ein unvollständiges zwischendurch, flankiert von 2-3 vollständigen.

Im jameica.log finde ich:

Code

[Sun Mar 22 15:50:44 CET 2020][ERROR][main][de.willuhn.jameica.backup.BackupEngine.doBackup] unable to create backup
java.io.IOException: Der Prozess kann nicht auf die Datei zugreifen, da ein anderer Prozess einen Teil der Datei gesperrt hat
  at java.base/java.io.FileInputStream.readBytes(Native Method)
  at java.base/java.io.FileInputStream.read(Unknown Source)
  at java.base/java.io.BufferedInputStream.fill(Unknown Source)
  at java.base/java.io.BufferedInputStream.read1(Unknown Source)
  at java.base/java.io.BufferedInputStream.read(Unknown Source)
  at java.base/java.io.FilterInputStream.read(Unknown Source)
  at de.willuhn.io.IOUtil.copy(IOUtil.java:38)
  at de.willuhn.io.ZipCreator._add(ZipCreator.java:132)
  at de.willuhn.io.ZipCreator._add(ZipCreator.java:120)
  at de.willuhn.io.ZipCreator._add(ZipCreator.java:120)
  at de.willuhn.io.ZipCreator.add(ZipCreator.java:79)
  at de.willuhn.jameica.backup.BackupEngine.doBackup(BackupEngine.java:324)
  at de.willuhn.jameica.services.BackupService.shutdown(BackupService.java:86)
  at de.willuhn.boot.BootLoader.shutdown(BootLoader.java:202)
  at de.willuhn.jameica.system.Application.shutDown(Application.java:213)
  at de.willuhn.jameica.gui.GUI.quit(GUI.java:1040)
  at de.willuhn.jameica.gui.GUI.loop(GUI.java:941)
  at de.willuhn.jameica.gui.GUI.init(GUI.java:328)
  at de.willuhn.jameica.system.Application.init(Application.java:145)
  at de.willuhn.jameica.system.Application.newInstance(Application.java:87)
  at de.willuhn.jameica.Main.main(Main.java:75)


Was sperrt da noch die DB? Und wie kann ich Abhilfe schaffen?

Vielen Dank
Sina

Hier im Einsatz:
Code
[Sun Mar 22 15:45:52 CET 2020][INFO][main][de.willuhn.jameica.services.SysinfoService.init] starting Jameica Version 2.8.6
[Sun Mar 22 15:45:52 CET 2020][INFO][main][de.willuhn.jameica.services.SysinfoService.init]   Built-Date : 20191101
[Sun Mar 22 15:45:52 CET 2020][INFO][main][de.willuhn.jameica.services.SysinfoService.init]   Buildnumber: 455
[Sun Mar 22 15:45:52 CET 2020][INFO][main][de.willuhn.jameica.services.SysinfoService.init]   max. memory: 494mb
[Sun Mar 22 15:45:52 CET 2020][INFO][main][de.willuhn.jameica.services.SysinfoService.init]   sys charset: windows-1252
[Sun Mar 22 15:45:52 CET 2020][INFO][main][de.willuhn.jameica.services.SysinfoService.init] command line parameters
[Sun Mar 22 15:45:52 CET 2020][INFO][main][de.willuhn.jameica.services.SysinfoService.init] os.arch          : amd64
[Sun Mar 22 15:45:52 CET 2020][INFO][main][de.willuhn.jameica.services.SysinfoService.init] os.name          : Windows 10
[Sun Mar 22 15:45:52 CET 2020][INFO][main][de.willuhn.jameica.services.SysinfoService.init] os.version       : 10.0
[Sun Mar 22 15:45:52 CET 2020][INFO][main][de.willuhn.jameica.services.SysinfoService.init] java.version     : 11.0.5
[Sun Mar 22 15:45:52 CET 2020][INFO][main][de.willuhn.jameica.services.SysinfoService.init] java.vendor      : AdoptOpenJDK
[Sun Mar 22 15:45:52 CET 2020][INFO][main][de.willuhn.jameica.services.SysinfoService.init] java.runtime.name: OpenJDK Runtime Environment
[Sun Mar 22 15:45:52 CET 2020][INFO][main][de.willuhn.jameica.services.SysinfoService.init] java.vm.name     : OpenJDK 64-Bit Server VM
Benutzer
Avatar
Geschlecht: keine Angabe
Herkunft: Leipzig
Homepage: willuhn.de/
Beiträge: 10071
Dabei seit: 03 / 2005
Betreff:

Re: Automatische Backup sporadisch unvollständig

 · 
Gepostet: 23.03.2020 - 09:21 Uhr  ·  #2
Stell das Loglevel unter Datei->Einstellungen mal testweise auf "DEBUG" und versuche den Fehler zu reproduzieren. Da sollte dann im Log ersichtlich werden, welche Datei konkret da gesperrt ist. Daraus kann man dann eher ableiten, was die Ursache ist.
Benutzer
Avatar
Geschlecht: keine Angabe
Beiträge: 25
Dabei seit: 01 / 2019
Betreff:

Re: Automatische Backup sporadisch unvollständig

 · 
Gepostet: 23.03.2020 - 16:03 Uhr  ·  #3
Ich denke, es wird die Datei hibiscus.h2.db sein (Größe im ZIP-File 0 Bytes)

Code

[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message [Mon Mar 23 15:30:53 CET 2020] shutting down jameica
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.jameica.gui.SplashScreen.<init>] init splash screen: Shutdown
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.jameica.gui.SplashScreen.run] starting splash screen thread
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service TransportService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service TransportService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service Init5 ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][pool-1-thread-1][de.willuhn.jameica.messaging.NamedConcurrentQueue.deliver] deliver message [Mon Mar 23 15:30:53 CET 2020][OK] shutting down jameica
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service Init5
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service UpdateService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service UpdateService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service RepositoryService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service RepositoryService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service ScriptingService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service ScriptingService
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.unRegisterMessageConsumer] queue jameica.scripting: unregistering message consumer de.willuhn.jameica.messaging.InvokeScriptMessageConsumer
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service ReminderService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service ReminderService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service SearchService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service SearchService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service PluginService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service PluginService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.plugin.PluginLoader.shutDown] shutting down plugins
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.jameica.plugin.PluginLoader.shutDown] de.willuhn.jameica.hbci.HBCI
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service PluginServiceService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service PluginServiceService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.system.ServiceFactory.shutDown] shutting down local services
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.system.ServiceFactory.shutDown]   de.willuhn.jameica.hbci.HBCI.addressbook
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.system.ServiceFactory.shutDown]   de.willuhn.jameica.hbci.HBCI.database
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.datasource.db.DBServiceImpl.stop] stopping db service
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.datasource.db.DBServiceImpl.stop] db service: object cache matches: 94 %
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.datasource.db.DBServiceImpl.closeConnection] commit connection
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.datasource.db.DBServiceImpl.closeConnection] closing connection
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.datasource.db.DBServiceImpl.closeConnection] connection closed
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.datasource.db.DBServiceImpl.stop] db service stopped [1 connection(s) closed]
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service SSLSocketFactoryService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service SSLSocketFactoryService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service DeployService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service DeployService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service BeanService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service BeanService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service PluginSourceService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service PluginSourceService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service ClassService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service ClassService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service RegistryService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service RegistryService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service SSLService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service SSLService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service HostnameVerifierService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service HostnameVerifierService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service AuthenticateService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service AuthenticateService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service ProxyService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service ProxyService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service BackupService ...
[Mon Mar 23 15:30:53 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service BackupService
[Mon Mar 23 15:30:53 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  creating backup [.....]\.jameica\jameica-backup-20200323__15_30_53.zip ...
[Mon Mar 23 15:30:54 CET 2020][ERROR][main][de.willuhn.jameica.backup.BackupEngine.doBackup] unable to create backup
java.io.IOException: Der Prozess kann nicht auf die Datei zugreifen, da ein anderer Prozess einen Teil der Datei gesperrt hat
  at java.base/java.io.FileInputStream.readBytes(Native Method)
  at java.base/java.io.FileInputStream.read(Unknown Source)
  at java.base/java.io.BufferedInputStream.fill(Unknown Source)
  at java.base/java.io.BufferedInputStream.read1(Unknown Source)
  at java.base/java.io.BufferedInputStream.read(Unknown Source)
  at java.base/java.io.FilterInputStream.read(Unknown Source)
  at de.willuhn.io.IOUtil.copy(IOUtil.java:38)
  at de.willuhn.io.ZipCreator._add(ZipCreator.java:132)
  at de.willuhn.io.ZipCreator._add(ZipCreator.java:120)
  at de.willuhn.io.ZipCreator._add(ZipCreator.java:120)
  at de.willuhn.io.ZipCreator.add(ZipCreator.java:79)
  at de.willuhn.jameica.backup.BackupEngine.doBackup(BackupEngine.java:324)
  at de.willuhn.jameica.services.BackupService.shutdown(BackupService.java:86)
  at de.willuhn.boot.BootLoader.shutdown(BootLoader.java:202)
  at de.willuhn.jameica.system.Application.shutDown(Application.java:213)
  at de.willuhn.jameica.gui.GUI.quit(GUI.java:1040)
  at de.willuhn.jameica.gui.GUI.loop(GUI.java:941)
  at de.willuhn.jameica.gui.GUI.init(GUI.java:328)
  at de.willuhn.jameica.system.Application.init(Application.java:145)
  at de.willuhn.jameica.system.Application.newInstance(Application.java:87)
  at de.willuhn.jameica.Main.main(Main.java:75)

[Mon Mar 23 15:30:54 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  zip file created successfully ...
[Mon Mar 23 15:30:54 CET 2020][ERROR][main][de.willuhn.jameica.services.BackupService.shutdown] Fehler beim Erstellen des Backups: Der Prozess kann nicht auf die Datei zugreifen, da ein anderer Prozess einen Teil der Datei gesperrt hat
de.willuhn.util.ApplicationException: Fehler beim Erstellen des Backups: Der Prozess kann nicht auf die Datei zugreifen, da ein anderer Prozess einen Teil der Datei gesperrt hat
  at de.willuhn.jameica.backup.BackupEngine.doBackup(BackupEngine.java:367)
  at de.willuhn.jameica.services.BackupService.shutdown(BackupService.java:86)
  at de.willuhn.boot.BootLoader.shutdown(BootLoader.java:202)
  at de.willuhn.jameica.system.Application.shutDown(Application.java:213)
  at de.willuhn.jameica.gui.GUI.quit(GUI.java:1040)
  at de.willuhn.jameica.gui.GUI.loop(GUI.java:941)
  at de.willuhn.jameica.gui.GUI.init(GUI.java:328)
  at de.willuhn.jameica.system.Application.init(Application.java:145)
  at de.willuhn.jameica.system.Application.newInstance(Application.java:87)
  at de.willuhn.jameica.Main.main(Main.java:75)

[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.unRegisterMessageConsumer] queue jameica.error: unregistering message consumer de.willuhn.jameica.services.BackupService$Consumer
[Mon Mar 23 15:30:54 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service MessagingService ...
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service MessagingService
[Mon Mar 23 15:30:54 CET 2020][INFO][main][de.willuhn.jameica.messaging.MessagingFactory.close] shutting down messaging factory
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.transfer.sepalast
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.ibancalculator
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.update.repository.disabled
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue item:32
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.kontoauszug
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue item:30
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue item:31
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.transfer.lastschrift
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.update.repository.remove
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.reporting.einnahmenausgaben
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.boot
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.menu.backups
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.ext
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.reminder.order
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.reminder.appointment
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.transfer.sepaueb
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue de.willuhn.jameica.hbci.gui.views.Settings
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.error
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.menu.settings
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue item:25
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue item:23
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.transfer.sepasammellast
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue item:29
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.scripting.add
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.transfer
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue item:27
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue item:28
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.menu.quit
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.sync.hbci.trace
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.addresses
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.transfer.sepasammelueb
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.donate
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.appointments
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.menu.masterpassword
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.query.bankname
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue de.willuhn.jameica.gui.internal.views.Start
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.menu.file
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.passport.rdh.hbciversion
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.ext.chiptantest
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.bookmark.created
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.dbobject.store
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.scripting
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.start
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.bookmark.deleted
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.ext.backup.create
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.ext.backup.restore
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.gui.view.unbind
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.settings
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.support
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue item:44
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.query.accountcrc
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.scripting.removed
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.sync.status
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.license
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.accounts
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.ext.hbcitrace
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.menu.updates
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.archive
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.archive.transfer.dauer
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.about
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.popup
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.archive.transfer.ueb
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue menu:16
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.sync.error
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue de.willuhn.jameica.gui.internal.views.Settings
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.archive.transfer.sammellast
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.dbobject.delete
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.menu.bookmarks
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue syntax.buchung.markchecked
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.reporting.sparquote
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.transfer.uebforeign
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.transfer.check
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.shutdown.unclean
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.reporting.saldochart
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue de.willuhn.jameica.hbci.gui.parts.UmsatzList
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.update.repository.add
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.gui.view.bind
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.transfer.sepasammellast
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.messages
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.sepatransfer
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.transfer.sepadauer
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.syncengine.status
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.archive.transfer.einzellast
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue menu:15
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.transfer.sepasammelueb
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.passports
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue de.willuhn.jameica.hbci.gui.menus.UmsatzList
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.query.ibancalc
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.handbuch
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue item:19
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.menu.back
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.umsatz
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.update.repository.enabled
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.scripting.added
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.query.ibancrc
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.reporting
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue de.willuhn.jameica.hbci.gui.menus.UmsatzTypList
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.scripting.remove
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.statusbar
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue jameica.gui.view.unbind.fail
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.transfer.sepalast
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.menu.archive.transfer.sammelueb
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue hibiscus.navi.reporting.kategorien
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.jameica.messaging.NamedConcurrentQueue.close] closing queue [default]
[Mon Mar 23 15:30:54 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service SysinfoService ...
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service SysinfoService
[Mon Mar 23 15:30:54 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service SysPropertyService ...
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service SysPropertyService
[Mon Mar 23 15:30:54 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service LogService ...
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service LogService
[Mon Mar 23 15:30:54 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service LockService ...
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service LockService
[Mon Mar 23 15:30:54 CET 2020][INFO][main][de.willuhn.jameica.gui.SplashScreen$3.run]  shutting down service SecurityManagerService ...
[Mon Mar 23 15:30:54 CET 2020][DEBUG][main][de.willuhn.boot.BootLoader.shutdown] shutting down service SecurityManagerService
[Mon Mar 23 15:30:54 CET 2020][INFO][main][de.willuhn.jameica.system.Application.shutDown] shutdown complete
[Mon Mar 23 15:30:54 CET 2020][INFO][main][de.willuhn.jameica.system.Application.shutDown] --------------------------------------------------
 
Benutzer
Avatar
Geschlecht: keine Angabe
Beiträge: 25
Dabei seit: 01 / 2019
Betreff:

Re: Automatische Backup sporadisch unvollständig

 · 
Gepostet: 23.03.2020 - 16:13 Uhr  ·  #4
Zitat geschrieben von Sina05

Seit 4 Tagen gibt es nur noch unvollständige Backups

...das ist so nicht mehr aktuell. (eben gab es zwischendurch auch mal wieder ein vollständiges Backup)
Benutzer
Avatar
Geschlecht: keine Angabe
Herkunft: Leipzig
Homepage: willuhn.de/
Beiträge: 10071
Dabei seit: 03 / 2005
Betreff:

Re: Automatische Backup sporadisch unvollständig

 · 
Gepostet: 23.03.2020 - 16:18 Uhr  ·  #5
Schade. Hatte gehofft, dass die Datei im Log erscheint. Wenn es die Datenbank-Datei ist, weiss ich leider auch nicht, was die Ursache ist. Die Datenbank wird jedenfalls geschlossen, bevor das Backup erstellt wird. Generell wird es erst ausgeführt, wenn alle Plugins gestoppt wurden. Da ich den Fehler nie reproduzieren konnte. Eventuell hält noch ein anderes Plugin eine Verbindung zur Hibiscus-Datenbank offen und schliesst diese nicht.
Benutzer
Avatar
Geschlecht: keine Angabe
Beiträge: 25
Dabei seit: 01 / 2019
Betreff:

Re: Automatische Backup sporadisch unvollständig

 · 
Gepostet: 23.03.2020 - 16:29 Uhr  ·  #6
Außer Hibiscus habe ich kein Plugin installiert.

An alle mitlesenden Hibiscus-Benutzer: Schaut doch bitte mal nach den automatischen Backups bei Euch.
Benutzer
Avatar
Geschlecht:
Beiträge: 6694
Dabei seit: 06 / 2008
Betreff:

Re: Automatische Backup sporadisch unvollständig

 · 
Gepostet: 23.03.2020 - 22:54 Uhr  ·  #7
Idee: Virensoftware?
Benutzer
Avatar
Geschlecht: keine Angabe
Beiträge: 25
Dabei seit: 01 / 2019
Betreff:

Re: Automatische Backup sporadisch unvollständig

 · 
Gepostet: 24.03.2020 - 05:26 Uhr  ·  #8
Zitat geschrieben von infoman

Idee: Virensoftware?

Hier ist außer dem bei Windows mitgelieferten "Viren- & Bedrohungsschutz" nichts Derartiges im Einsatz. Ich wüsste auch nicht, da besondere Einstellungen vorgenommen zu haben. Falls hier die Ursache liegt, würde ich vermuten, dass ich nicht der einzige Betroffene bin. Vielleicht gibt es ja noch Meldungen, wie es sich bei anderen Nutzern verhält...

Generell fände ich es gut, wenn die Fehlersituation in einer zukünftigen Version abgefangen und beim Schließen im GUI berichtet würde. Idealerweise mit Unterbrechung des weiteren Shutdown-Ablaufs und der Möglichkeit eines Retry.

Darf ich davon ausgehen, dass ansonsten IO-Exceptions im Programmablauf so behandelt werden, dass keine Datenverluste (ich denke da vor allem an DB-Zugriffe) zu befürchten sind?
Benutzer
Avatar
Geschlecht: keine Angabe
Herkunft: Leipzig
Homepage: willuhn.de/
Beiträge: 10071
Dabei seit: 03 / 2005
Betreff:

Re: Automatische Backup sporadisch unvollständig

 · 
Gepostet: 24.03.2020 - 09:15 Uhr  ·  #9
Zitat geschrieben von Sina05

Generell fände ich es gut, wenn die Fehlersituation in einer zukünftigen Version abgefangen und beim Schließen im GUI berichtet würde. Idealerweise mit Unterbrechung des weiteren Shutdown-Ablaufs und der Möglichkeit eines Retry.

Das Problem ist, dass die GUI zu dem Zeitpunkt bereits runtergefahren ist. Das Erstellen des Backups ist (vor dem Löschen der Lock-Datei) der letzte Task beim Shutdown. Und das muss auch der letzte sein, eben damit die Dateien nicht mehr vom Programm gesperrt sind. Für die Anzeige von Dialogen ist es da zu spät.

Zitat geschrieben von Sina05

Darf ich davon ausgehen, dass ansonsten IO-Exceptions im Programmablauf so behandelt werden, dass keine Datenverluste (ich denke da vor allem an DB-Zugriffe) zu befürchten sind?


Bei der Datenbank muss das nicht berücksichtigt werden. Das ist eine externe Komponente (www.h2database.com), die sich selbst darum kümmert.
Benutzer
Avatar
Geschlecht: keine Angabe
Beiträge: 86
Dabei seit: 02 / 2009
Betreff:

Re: Automatische Backup sporadisch unvollständig

 · 
Gepostet: 24.03.2020 - 10:10 Uhr  ·  #10
Zitat geschrieben von Sina05

...
An alle mitlesenden Hibiscus-Benutzer: Schaut doch bitte mal nach den automatischen Backups bei Euch.


 
Allerdings ist das Linux. :-)
Benutzer
Avatar
Geschlecht: keine Angabe
Beiträge: 25
Dabei seit: 01 / 2019
Betreff:

Re: Automatische Backup sporadisch unvollständig

 · 
Gepostet: 27.03.2020 - 20:15 Uhr  ·  #11
Zitat geschrieben von infoman

Idee: Virensoftware?

Um das zu klären, habe ich den Sysinternals ProcessMonitor auf die DB-Datei angesetzt.

Bislang sehe ich Zugriffe ausschließlich von javaw.exe

Nachfolgend Auszüge aus dem Zugriffs-Log:

vollständiges Backup:
Code

17:22:46,6665673  javaw.exe  2952  WriteFile  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  Offset: 6.144, Length: 2.048
17:22:46,6667254  javaw.exe  2952  QueryStandardInformationFile  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  AllocationSize: 5.943.296, EndOfFile: 5.920.768, NumberOfLinks: 1, DeletePending: False, Directory: False
17:22:46,6667538  javaw.exe  2952  SetEndOfFileInformationFile  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  EndOfFile: 2.775.040
17:22:46,6672627  javaw.exe  2952  UnlockFileSingle  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  Offset: 0, Length: 4.294.967.295
17:22:46,6674020  javaw.exe  2952  CloseFile  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  
17:22:47,2961799  javaw.exe  2952  QueryOpen  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  CreationTime: 08.07.2012 20:00:17, LastAccessTime: 27.03.2020 17:22:47, LastWriteTime: 27.03.2020 17:22:47, ChangeTime: 27.03.2020 17:22:47, AllocationSize: 2.777.088, EndOfFile: 2.775.040, FileAttributes: A
17:22:47,2963000  javaw.exe  2952  QueryOpen  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  CreationTime: 08.07.2012 20:00:17, LastAccessTime: 27.03.2020 17:22:47, LastWriteTime: 27.03.2020 17:22:47, ChangeTime: 27.03.2020 17:22:47, AllocationSize: 2.777.088, EndOfFile: 2.775.040, FileAttributes: A
17:22:47,2964186  javaw.exe  2952  QueryOpen  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  CreationTime: 08.07.2012 20:00:17, LastAccessTime: 27.03.2020 17:22:47, LastWriteTime: 27.03.2020 17:22:47, ChangeTime: 27.03.2020 17:22:47, AllocationSize: 2.777.088, EndOfFile: 2.775.040, FileAttributes: A
17:22:47,2976317  javaw.exe  2952  CreateFile  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  Desired Access: Generic Read, Disposition: Open, Options: Synchronous IO Non-Alert, Non-Directory File, Attributes: N, ShareMode: Read, Write, AllocationSize: n/a, OpenResult: Opened
17:22:47,2977160  javaw.exe  2952  QueryBasicInformationFile  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  CreationTime: 08.07.2012 20:00:17, LastAccessTime: 27.03.2020 17:22:47, LastWriteTime: 27.03.2020 17:22:47, ChangeTime: 27.03.2020 17:22:47, FileAttributes: A
17:22:47,2977391  javaw.exe  2952  FileSystemControl  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  INVALID DEVICE REQUEST  Control: 0x90390 (Device:0x9 Function:228 Method: 0)
17:22:47,2977594  javaw.exe  2952  QueryAttributeInformationVolume  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  FileSystemAttributes: Case Preserved, Case Sensitive, Unicode, ACLs, Compression, Named Streams, EFS, Object IDs, Reparse Points, Sparse Files, Quotas, Transactions, 0x3c00600, MaximumComponentNameLength: 255, FileSystemName: NTFS



unvollständiges Backup:
Code

18:40:56,9703777  javaw.exe  2052  WriteFile  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  Offset: 2.779.136, Length: 2.048
[...]
18:40:57,4118515  javaw.exe  2052  QueryOpen  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  CreationTime: 08.07.2012 20:00:17, LastAccessTime: 27.03.2020 18:40:57, LastWriteTime: 27.03.2020 18:40:56, ChangeTime: 27.03.2020 18:40:56, AllocationSize: 3.825.664, EndOfFile: 3.823.616, FileAttributes: A
[...]
18:41:51,0764766  javaw.exe  2052  QueryOpen  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  CreationTime: 08.07.2012 20:00:17, LastAccessTime: 27.03.2020 18:41:02, LastWriteTime: 27.03.2020 18:40:56, ChangeTime: 27.03.2020 18:40:56, AllocationSize: 3.825.664, EndOfFile: 3.823.616, FileAttributes: A
18:41:51,0765977  javaw.exe  2052  QueryOpen  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  CreationTime: 08.07.2012 20:00:17, LastAccessTime: 27.03.2020 18:41:02, LastWriteTime: 27.03.2020 18:40:56, ChangeTime: 27.03.2020 18:40:56, AllocationSize: 3.825.664, EndOfFile: 3.823.616, FileAttributes: A
18:41:51,0767153  javaw.exe  2052  QueryOpen  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  CreationTime: 08.07.2012 20:00:17, LastAccessTime: 27.03.2020 18:41:02, LastWriteTime: 27.03.2020 18:40:56, ChangeTime: 27.03.2020 18:40:56, AllocationSize: 3.825.664, EndOfFile: 3.823.616, FileAttributes: A
18:41:51,0769021  javaw.exe  2052  CreateFile  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  Desired Access: Generic Read, Disposition: Open, Options: Synchronous IO Non-Alert, Non-Directory File, Attributes: N, ShareMode: Read, Write, AllocationSize: n/a, OpenResult: Opened
18:41:51,0769918  javaw.exe  2052  QueryBasicInformationFile  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  CreationTime: 08.07.2012 20:00:17, LastAccessTime: 27.03.2020 18:41:02, LastWriteTime: 27.03.2020 18:40:56, ChangeTime: 27.03.2020 18:40:56, FileAttributes: A
18:41:51,0770143  javaw.exe  2052  FileSystemControl  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  INVALID DEVICE REQUEST  Control: 0x90390 (Device:0x9 Function:228 Method: 0)
18:41:51,0770342  javaw.exe  2052  QueryAttributeInformationVolume  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  SUCCESS  FileSystemAttributes: Case Preserved, Case Sensitive, Unicode, ACLs, Compression, Named Streams, EFS, Object IDs, Reparse Points, Sparse Files, Quotas, Transactions, 0x3c00600, MaximumComponentNameLength: 255, FileSystemName: NTFS
18:41:51,0778288  javaw.exe  2052  ReadFile  ...\.jameica\hibiscus\h2db\hibiscus.h2.db  FILE LOCK CONFLICT  Offset: 0, Length: 8.192, Priority: Normal8.192, Priority: Normal


Auffällig: Nach dem letzten WriteFile gab es kein CloseFile vor der problematischen Operation (oben bei dem vollständigen Backup jedoch schon). Ich schätze, dass es deswegen zum FILE LOCK CONFLICT kommt.

Könnte irgendein(e) Caching/Asynchronizität ursächlich sein für nicht immer rechtzeitiges Schließen der DB?
Gewählte Zitate für Mehrfachzitierung:   0