Bug in Amanda::DB::Catalog

Olivier <[email protected]> Fri, 05 May 2023 12:59:18 +0700
Newsgroups	gmane.comp.archivers.amanda.devel
Message-ID	<[email protected]>
Hi,

I recentrly had amrecover that hanged because amidxtaped would die withe
the following message in amidxtaped.log:

Tue May  2 12:38:48 2023: thd-0x802e95800: amidxtaped: warning: Use of uninitialized value $str in pattern match (m//) at /usr/local/lib/perl5/site_perl/Amanda/DB/Catalog.pm line 764.

Tue May 2 12:38:48 2023: thd-0x802e95800: amidxtaped: warning: Use of
uninitialized value $s in concatenation (.) or string at
/usr/local/lib/perl5/site_perl/Amanda/DB/Catalog.pm line 764.

Tue May 2 12:38:48 2023: thd-0x802e95800: amidxtaped: critical (fatal):
'' at /usr/local/lib/perl5/site_perl/Amanda/DB/Catalog.pm line 764.

amidxtaped: '' at /usr/local/lib/perl5/site_perl/Amanda/DB/Catalog.pm
line 764.

Digging into Catalog.pm, I managed to identify the log file that was
causing the error and the specific line in the log file is:

DONE taper WARNING driver Taper protocol error

Removing that specific log file, amrecover worked fine.

I am using amanda-client-3.3.9_4,1 and amanda-server-3.3.9_4,1 on
FreeBSD 13.1

In my 20 years of using Amanda, I never had such problem, and the disk
holding that vtape does not show any problem. I have no record of any
hardware incident on the date corresponding to that log.

I include the log file for reference below.

Thank you,

Olivier

----------------------------------------
INFO amdump amdump pid 96310
INFO driver driver pid 96312
INFO planner planner pid 96311
START planner date 20230407000519
DISK planner localhost /
DISK planner localhost /var
DISK planner localhost /home
DISK planner localhost /usr
DISK planner mail1000 /
DISK planner mail1000 /usr
DISK planner mail1000 /var
DISK planner mail1000 /var/spool/postfix
DISK planner vpn1000 /
DISK planner vpn1000 /usr
START driver date 20230407000519
DISK planner vpn1000 /var
DISK planner ldap1000 /
DISK planner ldap1000 /usr
STATS driver hostname amanda.cs.ait.ac.th
DISK planner ldap1000 /var
DISK planner ldap1000 /home
DISK planner ldap1000 /var/db/openldap-data
DISK planner active1000 /
DISK planner active1000 /usr
DISK planner active1000 /var
DISK planner database1000 /
DISK planner database1000 /usr
DISK planner database1000 /var
DISK planner database1000 /home
DISK planner database1000 /database
DISK planner dns1000 /
DISK planner dns1000 /usr
DISK planner dns1000 /var
DISK planner dns1000 /home
DISK planner sysl1000 /
DISK planner sysl1000 /home
DISK planner sysl1000 /usr
DISK planner sysl1000 /var
DISK planner sysl1000 /var/log
DISK planner puffer1000 /
DISK planner puffer1000 /home2/docker/volumes
DISK planner puffer1000 /home2/
DISK planner puffer1000 /home2/mdailey
DISK planner puffer1000 /home2/st122498
DISK planner puffer1000 /home2/st122403
DISK planner puffer1000 /home2/st122497
DISK planner gourami1000 /
DISK planner gourami1000 /home2/docker/volumes
DISK planner guppy1000 /
DISK planner guppy1000 /home2/
DISK planner guppy1000 /home2/docker
DISK planner guppy1000 /home2/docker/volumes
DISK planner olivier2 /
DISK planner olivier2 /home2
DISK planner ufo1000 /
DISK planner ufo1000 /usr
DISK planner ufo1000 /var
DISK planner ufo1000 /web
DISK planner oak1000 /
DISK planner oak1000 /usr
DISK planner oak1000 /var
DISK planner oak1000 /home/restic
DISK planner oak1000 /home/java
DISK planner oak1000 /home/fidji
DISK planner oak1000 /home/hawai
DISK planner oak1000 /home/pc-application
DISK planner oak1000 /home/corse
DISK planner oak1000 corse_st120
DISK planner oak1000 corse_st121a
DISK planner oak1000 corse_st121b
DISK planner oak1000 corse_st122
DISK planner door /
DISK planner door /var
DISK planner door /usr
DISK planner door /home
DISK planner door /web
DISK planner firewall /boot
DISK planner firewall /cdrom
DISK planner firewall /DB
DISK planner mailback1000 /
DISK planner mailback1000 /var
DISK planner mailback1000 /usr
DISK planner mailback1000 /home
DISK planner pihole1000 /
SUCCESS planner localhost / 20230407000519 1 [skipped: skip-incr]
SUCCESS planner localhost /home 20230407000519 1 [skipped: skip-incr]
SUCCESS planner localhost /usr 20230407000519 1 [skipped: skip-incr]
SUCCESS planner mail1000 / 20230407000519 1 [skipped: skip-incr]
SUCCESS planner mail1000 /usr 20230407000519 1 [skipped: skip-incr]
SUCCESS planner vpn1000 / 20230407000519 1 [skipped: skip-incr]
SUCCESS planner vpn1000 /usr 20230407000519 1 [skipped: skip-incr]
SUCCESS planner vpn1000 /var 20230407000519 1 [skipped: skip-incr]
SUCCESS planner ldap1000 / 20230407000519 1 [skipped: skip-incr]
SUCCESS planner ldap1000 /usr 20230407000519 1 [skipped: skip-incr]
SUCCESS planner ldap1000 /var 20230407000519 1 [skipped: skip-incr]
SUCCESS planner ldap1000 /home 20230407000519 1 [skipped: skip-incr]
SUCCESS planner active1000 / 20230407000519 1 [skipped: skip-incr]
SUCCESS planner active1000 /usr 20230407000519 1 [skipped: skip-incr]
SUCCESS planner database1000 / 20230407000519 1 [skipped: skip-incr]
SUCCESS planner database1000 /usr 20230407000519 1 [skipped: skip-incr]
SUCCESS planner database1000 /var 20230407000519 1 [skipped: skip-incr]
SUCCESS planner database1000 /home 20230407000519 1 [skipped: skip-incr]
SUCCESS planner dns1000 / 20230407000519 1 [skipped: skip-incr]
SUCCESS planner dns1000 /usr 20230407000519 1 [skipped: skip-incr]
SUCCESS planner dns1000 /var 20230407000519 1 [skipped: skip-incr]
SUCCESS planner dns1000 /home 20230407000519 1 [skipped: skip-incr]
SUCCESS planner sysl1000 / 20230407000519 1 [skipped: skip-incr]
SUCCESS planner sysl1000 /home 20230407000519 1 [skipped: skip-incr]
SUCCESS planner sysl1000 /usr 20230407000519 1 [skipped: skip-incr]
SUCCESS planner sysl1000 /var 20230407000519 1 [skipped: skip-incr]
SUCCESS planner puffer1000 / 20230407000519 1 [skipped: skip-incr]
SUCCESS planner guppy1000 / 20230407000519 1 [skipped: skip-incr]
SUCCESS planner guppy1000 /home2/docker 20230407000519 1 [skipped: skip-incr]
SUCCESS planner olivier2 / 20230407000519 1 [skipped: skip-incr]
SUCCESS planner ufo1000 / 20230407000519 1 [skipped: skip-incr]
SUCCESS planner ufo1000 /usr 20230407000519 1 [skipped: skip-incr]
SUCCESS planner ufo1000 /var 20230407000519 1 [skipped: skip-incr]
SUCCESS planner oak1000 / 20230407000519 1 [skipped: skip-incr]
SUCCESS planner oak1000 /usr 20230407000519 1 [skipped: skip-incr]
SUCCESS planner oak1000 /var 20230407000519 1 [skipped: skip-incr]
SUCCESS planner oak1000 /home/pc-application 20230407000519 1 [skipped: skip-incr]
SUCCESS planner door / 20230407000519 1 [skipped: skip-incr]
SUCCESS planner door /var 20230407000519 1 [skipped: skip-incr]
SUCCESS planner door /usr 20230407000519 1 [skipped: skip-incr]
SUCCESS planner firewall /boot 20230407000519 1 [skipped: skip-incr]
SUCCESS planner firewall /cdrom 20230407000519 1 [skipped: skip-incr]
SUCCESS planner mailback1000 / 20230407000519 1 [skipped: skip-incr]
SUCCESS planner mailback1000 /var 20230407000519 1 [skipped: skip-incr]
SUCCESS planner mailback1000 /usr 20230407000519 1 [skipped: skip-incr]
STATS driver startup time 0.597
INFO dumper dumper pid 96317
INFO dumper dumper pid 96338
INFO dumper dumper pid 96336
INFO dumper dumper pid 96314
INFO dumper dumper pid 96340
INFO dumper dumper pid 96343
INFO dumper dumper pid 96315
INFO dumper dumper pid 96325
INFO dumper dumper pid 96318
INFO dumper dumper pid 96316
INFO dumper dumper pid 96320
INFO dumper dumper pid 96329
INFO dumper dumper pid 96330
INFO dumper dumper pid 96321
INFO dumper dumper pid 96323
INFO dumper dumper pid 96333
INFO dumper dumper pid 96331
INFO dumper dumper pid 96327
INFO dumper dumper pid 96324
INFO dumper dumper pid 96335
INFO dumper dumper pid 96332
INFO dumper dumper pid 96339
INFO dumper dumper pid 96326
INFO dumper dumper pid 96322
INFO dumper dumper pid 96337
INFO dumper dumper pid 96341
INFO dumper dumper pid 96319
INFO dumper dumper pid 96334
INFO dumper dumper pid 96328
INFO dumper dumper pid 96342
INFO taper taper pid 96313
INFO taper Slot 252 with label CSIM-set-113 is usable
INFO planner Incremental of oak1000:/home/java bumped to level 2.
INFO planner Incremental of puffer1000:/home2/mdailey bumped to level 3.
INFO planner Incremental of puffer1000:/home2/docker/volumes bumped to level 2.
FINISH planner date 20230407000519 time 2693.543
INFO planner pid-done 96311
INFO chunker chunker pid 97951
INFO chunker chunker pid 97952
INFO chunker chunker pid 97953
INFO chunker chunker pid 97954
INFO chunker chunker pid 97955
INFO dumper gzip pid 97957
INFO chunker chunker pid 97956
INFO chunker chunker pid 97958
INFO chunker chunker pid 97959
INFO chunker chunker pid 97960
INFO dumper gzip pid 97962
INFO chunker chunker pid 97961
INFO dumper gzip pid 97963
INFO chunker chunker pid 97964
INFO chunker chunker pid 97965
INFO chunker chunker pid 97966
INFO chunker chunker pid 97967
INFO chunker chunker pid 97969
INFO dumper gzip pid 97973
INFO chunker chunker pid 97972
INFO dumper gzip pid 97974
INFO dumper gzip pid 97975
INFO dumper gzip pid 97976
INFO dumper gzip pid 97977
INFO dumper gzip pid 97978
INFO dumper gzip pid 97986
INFO dumper gzip pid 97987
INFO dumper gzip pid 97988
INFO dumper gzip pid 97989
INFO dumper gzip pid 97990
INFO dumper gzip pid 97991
INFO dumper gzip pid 97992
INFO dumper pid-done 97986
SUCCESS dumper firewall /DB 20230407000519 1 [sec 2.110 kb 2034 kps 963.6 orig-kb 24260]
SUCCESS chunker firewall /DB 20230407000519 1 [sec 1.875 kb 2034 kps 1101.4]
INFO chunker pid-done 97972
STATS driver estimate firewall /DB 20230407000519 1 [sec 1 nkb 24062 ckb 2048 kps 1134]
INFO dumper pid-done 97977
SUCCESS dumper door /web 20230407000519 1 [sec 2.222 kb 6996 kps 3148.4 orig-kb 8200]
SUCCESS chunker door /web 20230407000519 1 [sec 0.954 kb 6996 kps 7363.2]
INFO chunker pid-done 97969
STATS driver estimate door /web 20230407000519 1 [sec 1 nkb 8232 ckb 7808 kps 6495]
INFO chunker chunker pid 98009
INFO dumper gzip pid 98010
INFO dumper pid-done 98010
SUCCESS dumper door /home 20230407000519 1 [sec 1.105 kb 42 kps 38.0 orig-kb 280]
SUCCESS chunker door /home 20230407000519 1 [sec 0.113 kb 42 kps 651.3]
INFO chunker pid-done 98009
STATS driver estimate door /home 20230407000519 1 [sec 1 nkb 312 ckb 96 kps 35]
INFO dumper pid-done 97976
STRANGE dumper active1000 /var 1 [sec 6.086 kb 20189 kps 3317.1 orig-kb 45660]
  sendbackup: start [active1000:/var level 1]
  sendbackup: info BACKUP=/usr/local/bin/gtar
  sendbackup: info RECOVER_CMD=/usr/bin/gzip -dc |/usr/local/bin/gtar -xpGf - ...
  sendbackup: info COMPRESS_SUFFIX=.gz
  sendbackup: info end
  ? /usr/local/bin/gtar: ./db/samba4/private/sam.ldb.d/DC=CS,DC=AIT,DC=AC,DC=TH.ldb: file changed as we read it
  | Total bytes written: 46755840 (45MiB, 9.0MiB/s)
  sendbackup: size 45660
  sendbackup: end
SUCCESS chunker active1000 /var 20230407000519 1 [sec 4.738 kb 20189 kps 4267.3]
INFO chunker pid-done 97967
STATS driver estimate active1000 /var 20230407000519 1 [sec 7 nkb 45662 ckb 21504 kps 2971]
START taper datestamp 20230407000519 label CSIM-set-113 tape 1
PART taper CSIM-set-113 1 firewall /DB 20230407000519 1/-1 1 [sec 0.002807 bytes 2082095 kps 724260.776630 orig-kb 24260]
DONE taper firewall /DB 20230407000519 1 1 [sec 9.000000 bytes 2082095 kps 225.888889 orig-kb 24260]
PART taper CSIM-set-113 2 door /web 20230407000519 1/-1 1 [sec 0.007166 bytes 7163215 kps 976137.315099 orig-kb 8200]
DONE taper door /web 20230407000519 1 1 [sec 0.100000 bytes 7163215 kps 69950.000000 orig-kb 8200]
PART taper CSIM-set-113 3 door /home 20230407000519 1/-1 1 [sec 0.002011 bytes 42995 kps 20387.866733 orig-kb 280]
DONE taper door /home 20230407000519 1 1 [sec 0.100000 bytes 42995 kps 410.000000 orig-kb 280]
PART taper CSIM-set-113 4 active1000 /var 20230407000519 1/-1 1 [sec 0.018582 bytes 20673187 kps 1086427.725756 orig-kb 45660]
DONE taper active1000 /var 20230407000519 1 1 [sec 0.100000 bytes 20673187 kps 201880.000000 orig-kb 45660]
INFO dumper pid-done 97987
SUCCESS dumper localhost /var 20230407000519 1 [sec 21.400 kb 128958 kps 6026.1 orig-kb 450890]
SUCCESS chunker localhost /var 20230407000519 1 [sec 20.067 kb 128958 kps 6427.8]
INFO chunker pid-done 97966
STATS driver estimate localhost /var 20230407000519 1 [sec 21 nkb 450842 ckb 108832 kps 5166]
PART taper CSIM-set-113 5 localhost /var 20230407000519 1/-1 1 [sec 0.652091 bytes 132052312 kps 197759.208454 orig-kb 450890]
DONE taper localhost /var 20230407000519 1 1 [sec 1.000000 bytes 132052312 kps 128957.000000 orig-kb 450890]
INFO dumper pid-done 97973
STRANGE dumper olivier2 /home2 1 [sec 28.837 kb 58885 kps 2041.9 orig-kb 161810]
  sendbackup: info BACKUP=APPLICATION
  sendbackup: info APPLICATION=amgtar
  sendbackup: info RECOVER_CMD=/bin/gzip -dc |/usr/lib/amanda/application/amgtar restore [./file-to-restore]+
  sendbackup: info COMPRESS_SUFFIX=.gz
  sendbackup: info end
  ? /bin/tar: ./on/.config/slimjet/Default/Session Storage/045948.ldb: File removed before we read it
  ? /bin/tar: ./on/.config/slimjet/Default/Session Storage/045950.ldb: File removed before we read it
  ? /bin/tar: ./on/.config/slimjet/Default/Session Storage/045952.ldb: File removed before we read it
  ? /bin/tar: ./on/.config/slimjet/Default/Session Storage/045953.log: File removed before we read it
  ? /bin/tar: ./on/.config/slimjet/Default/Session Storage/045954.ldb: File removed before we read it
  | Total bytes written: 165693440 (159MiB, 5.8MiB/s)
  sendbackup: size 161810
  sendbackup: end
SUCCESS chunker olivier2 /home2 20230407000519 1 [sec 27.516 kb 58885 kps 2141.2]
INFO chunker pid-done 97964
STATS driver estimate olivier2 /home2 20230407000519 1 [sec 40 nkb 161672 ckb 79936 kps 1954]
PART taper CSIM-set-113 6 olivier2 /home2 20230407000519 1/-1 1 [sec 0.173197 bytes 60298036 kps 339982.794159 orig-kb 161810]
DONE taper olivier2 /home2 20230407000519 1 1 [sec 0.100000 bytes 60298036 kps 588840.000000 orig-kb 161810]
INFO dumper pid-done 97989
SUCCESS dumper mailback1000 /home 20230407000519 1 [sec 45.059 kb 7506 kps 166.6 orig-kb 30270]
SUCCESS chunker mailback1000 /home 20230407000519 1 [sec 43.845 kb 7506 kps 171.9]
INFO chunker pid-done 97965
STATS driver estimate mailback1000 /home 20230407000519 1 [sec 26 nkb 30282 ckb 9664 kps 357]
PART taper CSIM-set-113 7 mailback1000 /home 20230407000519 1/-1 1 [sec 0.007342 bytes 7685536 kps 1022201.035140 orig-kb 30270]
DONE taper mailback1000 /home 20230407000519 1 1 [sec 0.100000 bytes 7685536 kps 75050.000000 orig-kb 30270]
INFO dumper pid-done 97974
STRANGE dumper mail1000 /var 1 [sec 51.477 kb 207126 kps 4023.6 orig-kb 494190]
  sendbackup: start [mail1000:/var level 1]
  sendbackup: info BACKUP=/usr/local/bin/gtar
  sendbackup: info RECOVER_CMD=/usr/bin/gzip -dc |/usr/local/bin/gtar -xpGf - ...
  sendbackup: info COMPRESS_SUFFIX=.gz
  sendbackup: info end
  ? /usr/local/bin/gtar: ./spool/postfix: directory is on a different filesystem; not dumped
  ? /usr/local/bin/gtar: ./db/redis/dump.rdb: file changed as we read it
  | Total bytes written: 506050560 (483MiB, 9.6MiB/s)
  sendbackup: size 494190
  sendbackup: end
SUCCESS chunker mail1000 /var 20230407000519 1 [sec 50.162 kb 207126 kps 4129.8]
INFO chunker pid-done 97960
STATS driver estimate mail1000 /var 20230407000519 1 [sec 51 nkb 493472 ckb 217728 kps 4237]
INFO chunker chunker pid 98045
INFO dumper pid-done 97978
SUCCESS dumper database1000 /database 20230407000519 1 [sec 51.790 kb 111068 kps 2144.6 orig-kb 818690]
SUCCESS chunker database1000 /database 20230407000519 1 [sec 50.435 kb 111068 kps 2202.8]
INFO chunker pid-done 97961
STATS driver estimate database1000 /database 20230407000519 1 [sec 43 nkb 818512 ckb 88960 kps 2056]
INFO dumper gzip pid 98046
PART taper CSIM-set-113 8 mail1000 /var 20230407000519 1/-1 1 [sec 1.188709 bytes 212096172 kps 174243.654250 orig-kb 494190]
DONE taper mail1000 /var 20230407000519 1 1 [sec 2.000000 bytes 212096172 kps 103562.500000 orig-kb 494190]
PART taper CSIM-set-113 9 database1000 /database 20230407000519 1/-1 1 [sec 0.697520 bytes 113733072 kps 159231.276523 orig-kb 818690]
DONE taper database1000 /database 20230407000519 1 1 [sec 0.100000 bytes 113733072 kps 1110670.000000 orig-kb 818690]
INFO dumper pid-done 98046
SUCCESS dumper mail1000 /var/spool/postfix 20230407000519 1 [sec 4.684 kb 2528 kps 539.7 orig-kb 11270]
SUCCESS chunker mail1000 /var/spool/postfix 20230407000519 1 [sec 4.688 kb 2528 kps 546.0]
INFO chunker pid-done 98045
STATS driver estimate mail1000 /var/spool/postfix 20230407000519 1 [sec 3 nkb 11292 ckb 2336 kps 576]
PART taper CSIM-set-113 10 mail1000 /var/spool/postfix 20230407000519 1/-1 1 [sec 0.003594 bytes 2588254 kps 703116.304953 orig-kb 11270]
DONE taper mail1000 /var/spool/postfix 20230407000519 1 1 [sec 0.100000 bytes 2588254 kps 25270.000000 orig-kb 11270]
INFO dumper pid-done 97988
SUCCESS dumper ldap1000 /var/db/openldap-data 20230407000519 1 [sec 67.827 kb 439313 kps 6476.9 orig-kb 439720]
SUCCESS chunker ldap1000 /var/db/openldap-data 20230407000519 1 [sec 66.579 kb 439313 kps 6598.8]
INFO chunker pid-done 97959
STATS driver estimate ldap1000 /var/db/openldap-data 20230407000519 1 [sec 58 nkb 439752 ckb 435072 kps 7398]
PART taper CSIM-set-113 11 ldap1000 /var/db/openldap-data 20230407000519 1/-1 1 [sec 2.666368 bytes 449856191 kps 164760.453171 orig-kb 439720]
DONE taper ldap1000 /var/db/openldap-data 20230407000519 1 1 [sec 2.000000 bytes 449856191 kps 219656.000000 orig-kb 439720]
INFO dumper pid-done 97990
SUCCESS dumper oak1000 corse_st122 20230407000519 1 [sec 117.199 kb 6165 kps 52.6 orig-kb 111520]
SUCCESS chunker oak1000 corse_st122 20230407000519 1 [sec 111.892 kb 6165 kps 55.4]
INFO chunker pid-done 97958
STATS driver estimate oak1000 corse_st122 20230407000519 1 [sec 411 nkb 111552 ckb 6208 kps 15]
INFO chunker chunker pid 98081
PART taper CSIM-set-113 12 oak1000 corse_st122 20230407000519 1/-1 1 [sec 0.006568 bytes 6312020 kps 938489.646772 orig-kb 111520]
DONE taper oak1000 corse_st122 20230407000519 1 1 [sec 0.100000 bytes 6312020 kps 61640.000000 orig-kb 111520]
INFO dumper gzip pid 98082
INFO dumper pid-done 97962
SUCCESS dumper guppy1000 /home2/ 20230407000519 1 [sec 155.150 kb 3349552 kps 21589.0 orig-kb 3862320]
SUCCESS chunker guppy1000 /home2/ 20230407000519 1 [sec 154.756 kb 3349552 kps 21644.2]
INFO chunker pid-done 97956
STATS driver estimate guppy1000 /home2/ 20230407000519 1 [sec 1907 nkb 3862352 ckb 95904 kps 50]
INFO chunker chunker pid 98117
INFO dumper gzip pid 98118
INFO dumper pid-done 98118
SUCCESS dumper guppy1000 /home2/docker/volumes 20230407000519 1 [sec 1.020 kb 1 kps 1.0 orig-kb 10]
SUCCESS chunker guppy1000 /home2/docker/volumes 20230407000519 1 [sec 0.018 kb 1 kps 1823.9]
INFO chunker pid-done 98117
STATS driver estimate guppy1000 /home2/docker/volumes 20230407000519 1 [sec 1 nkb 42 ckb 64 kps 1]
PART taper CSIM-set-113 13 guppy1000 /home2/ 20230407000519 1/-1 1 [sec 17.972503 bytes 3429940304 kps 186370.868877 orig-kb 3862320]
DONE taper guppy1000 /home2/ 20230407000519 1 1 [sec 18.000000 bytes 3429940304 kps 186086.166667 orig-kb 3862320]
PART taper CSIM-set-113 14 guppy1000 /home2/docker/volumes 20230407000519 1/-1 1 [sec 0.002612 bytes 147 kps 0.000000 orig-kb 10]
DONE taper guppy1000 /home2/docker/volumes 20230407000519 1 1 [sec 0.100000 bytes 147 kps 0.000000 orig-kb 10]
INFO dumper pid-done 98082
SUCCESS dumper oak1000 corse_st121a 20230407000519 1 [sec 206.244 kb 2638 kps 12.8 orig-kb 61820]
SUCCESS chunker oak1000 corse_st121a 20230407000519 1 [sec 201.943 kb 2638 kps 13.2]
INFO chunker pid-done 98081
STATS driver estimate oak1000 corse_st121a 20230407000519 1 [sec 247 nkb 61852 ckb 2688 kps 11]
INFO chunker chunker pid 98214
PART taper CSIM-set-113 15 oak1000 corse_st121a 20230407000519 1/-1 1 [sec 0.279121 bytes 2700490 kps 9447.515594 orig-kb 61820]
DONE taper oak1000 corse_st121a 20230407000519 1 1 [sec 0.100000 bytes 2700490 kps 26370.000000 orig-kb 61820]
INFO dumper gzip pid 98231
INFO dumper pid-done 98231
STRANGE dumper oak1000 /home/java 2 [sec 233.014 kb 767229 kps 3292.6 orig-kb 836280]
  sendbackup: start [oak1000:/home/java level 2]
  sendbackup: info BACKUP=/usr/local/bin/gtar
  sendbackup: info RECOVER_CMD=/usr/bin/gzip -dc |/usr/local/bin/gtar -xpGf - ...
  sendbackup: info COMPRESS_SUFFIX=.gz
  sendbackup: info end
  ? index compress: gzip: write: No space left on device
  | Total bytes written: 856350720 (817MiB, 3.6MiB/s)
  sendbackup: size 836280
  sendbackup: end
SUCCESS chunker oak1000 /home/java 20230407000519 2 [sec 228.933 kb 767229 kps 3351.5]
INFO chunker pid-done 98214
STATS driver estimate oak1000 /home/java 20230407000519 2 [sec 141 nkb 836262 ckb 740416 kps 5220]
INFO chunker chunker pid 98386
INFO dumper gzip pid 98403
PART taper CSIM-set-113 16 oak1000 /home/java 20230407000519 1/-1 2 [sec 4.773779 bytes 785642226 kps 160717.117403 orig-kb 836280]
DONE taper oak1000 /home/java 20230407000519 1 2 [sec 5.000000 bytes 785642226 kps 153445.600000 orig-kb 836280]
INFO dumper Index corrupted for puffer1000:/home2/
INFO dumper pid-done 98403
STRANGE dumper oak1000 corse_st121b 1 [sec 93.299 kb 2080 kps 22.3 orig-kb 41310]
  sendbackup: start [oak1000:corse_st121b level 1]
  sendbackup: info BACKUP=/usr/local/bin/gtar
  sendbackup: info RECOVER_CMD=/usr/bin/gzip -dc |/usr/local/bin/gtar -xpGf - ...
  sendbackup: info COMPRESS_SUFFIX=.gz
  sendbackup: info end
  ? index compress: gzip: write: No space left on device
  | Total bytes written: 42301440 (41MiB, 470KiB/s)
  sendbackup: size 41310
  sendbackup: end
SUCCESS chunker oak1000 corse_st121b 20230407000519 1 [sec 89.155 kb 2080 kps 23.7]
INFO chunker pid-done 98386
STATS driver estimate oak1000 corse_st121b 20230407000519 1 [sec 92 nkb 41342 ckb 2112 kps 22]
INFO chunker chunker pid 98487
PART taper CSIM-set-113 17 oak1000 corse_st121b 20230407000519 1/-1 1 [sec 0.075695 bytes 2129348 kps 27465.486492 orig-kb 41310]
DONE taper WARNING driver Taper protocol error
WARNING driver INFO dumper pid-done 96320
INFO dumper pid-done 96321
INFO dumper pid-done 96322
INFO dumper pid-done 96323
INFO dumper pid-done 96324
INFO dumper pid-done 96325
INFO dumper pid-done 96326
INFO dumper pid-done 96327
INFO dumper pid-done 96328
INFO dumper pid-done 96329
INFO dumper pid-done 96330
INFO dumper pid-done 96331
INFO dumper pid-done 96332
INFO dumper pid-done 96333
INFO dumper pid-done 96334
INFO dumper pid-done 96335
INFO dumper pid-done 96336
INFO dumper pid-done 96337
INFO dumper pid-done 96338
INFO dumper pid-done 96339
INFO dumper pid-done 96340
INFO dumper pid-done 96341
INFO dumper pid-done 96342
INFO dumper pid-done 96343
INFO dumper gzip pid 98488
FAIL dumper gourami1000 / 20230407000519 0 [Killed while dumping]
FAIL dumper sysl1000 /var/log 20230407000519 1 [Killed while dumping]
FAIL dumper ufo1000 /web 20230407000519 1 [Killed while dumping]
FAIL dumper puffer1000 /home2/ 20230407000519 0 [Killed while dumping]
FAIL dumper pihole1000 / 20230407000519 1 [Killed while dumping]
FAIL dumper oak1000 /home/fidji 20230407000519 2 [Killed while dumping]
--