Looks like a bug to me, but a possible workaround is to limit the size of your disk volumes (see Maximum Volume Bytes) to avoid filling the disks during the backup. This will avoid the "short block" when you migrate.
BTW, can you post the log from jobid 47704 as well? __Martin >>>>> On Wed, 25 Mar 2020 20:23:20 +0100, Pierre Bernhardt said: > > Am 24.03.20 um 22:39 schrieb Pierre Bernhardt: > > > Today I tried to migrate again the job which uses two disk files. > But now I tried to put both files in one directory (I used my second > bay to mount the DISK017 file) and used a symbolic link: > > -rw-rw-r-- 1 bacula tape 972406571008 Mar 24 17:10 /media/baculadisk1/DISK017 > -rw-rw-r-- 1 bacula tape 972406571008 Mar 22 07:47 /media/baculadisk2/DISK016 > lrwxrwxrwx 1 root root 26 Mar 25 07:32 /media/baculadisk2/DISK017 > -> /media/baculadisk1/D > > By the way the migration situation doesn't have been changed: > > Here the messages from the backup and from the migration job: > > > Backup (Migration) Job: > 25-Mar 07:48 backup-dir JobId 47755: Recycled volume "LTO40026" > 25-Mar 07:48 backup-dir JobId 47755: Using Device "HPUltrium4-2" to write. > 25-Mar 07:48 backup-sd JobId 47755: 3307 Issuing autochanger "unload Volume > LTO40030, Slot 8, Drive 1" command. > 25-Mar 07:49 backup-sd JobId 47755: 3304 Issuing autochanger "load Volume > LTO40026, Slot 9, Drive 1" command. > 25-Mar 07:51 backup-sd JobId 47755: 3305 Autochanger "load Volume LTO40026, > Slot 9, Drive 1", status is OK. > 25-Mar 07:51 backup-sd JobId 47755: Recycled volume "LTO40026" on Tape device > "HP Ultrium 4-2" (/dev/tape/by-id/scsi-HU19145705-nst), all previous data > lost. > 25-Mar 12:02 backup-sd JobId 47755: [SI0202] End of Volume "LTO40026" at > 813:1 on device "HP Ultrium 4-2" (/dev/tape/by-id/scsi-HU19145705-nst). Write > of 64512 bytes got -1. > 25-Mar 12:02 backup-sd JobId 47755: Re-read of last block succeeded. > 25-Mar 12:02 backup-sd JobId 47755: End of medium on Volume "LTO40026" > Bytes=812,948,032,512 Blocks=12,601,500 at 25-Mar-2020 12:02. > 25-Mar 12:02 backup-sd JobId 47755: 3307 Issuing autochanger "unload Volume > LTO40026, Slot 9, Drive 1" command. > 25-Mar 12:04 backup-dir JobId 47755: Recycled volume "LTO40025" > 25-Mar 12:04 backup-sd JobId 47755: 3301 Issuing autochanger "loaded? drive > 1" command. > 25-Mar 12:04 backup-sd JobId 47755: 3302 Autochanger "loaded? drive 1", > result: nothing loaded. > 25-Mar 12:04 backup-sd JobId 47755: 3304 Issuing autochanger "load Volume > LTO40025, Slot 17, Drive 1" command. > 25-Mar 12:05 backup-sd JobId 47755: 3305 Autochanger "load Volume LTO40025, > Slot 17, Drive 1", status is OK. > 25-Mar 12:05 backup-sd JobId 47755: Recycled volume "LTO40025" on Tape device > "HP Ultrium 4-2" (/dev/tape/by-id/scsi-HU19145705-nst), all previous data > lost. > 25-Mar 12:05 backup-sd JobId 47755: New volume "LTO40025" mounted on device > "HP Ultrium 4-2" (/dev/tape/by-id/scsi-HU19145705-nst) at 25-Mar-2020 12:05. > 25-Mar 14:01 backup-sd JobId 47755: Elapsed time=06:06:37, Transfer > rate=49.20 M Bytes/second > 25-Mar 14:01 backup-sd JobId 47755: Sending spooled attrs to the Director. > Despooling 300,838,146 bytes ... > > > Migration job: > > > 25-Mar 07:48 backup-dir JobId 47754: The following 1 JobId was chosen to be > migrated: 47704 > 25-Mar 07:48 backup-dir JobId 47754: Migration using JobId=47704 > Job=nihilnihil_home.2020-03-21_20.23.31_49 > 25-Mar 07:48 backup-dir JobId 47754: Start Migration JobId 47754, > Job=MigrateFile2Drive.2020-03-25_07.48.01_43 > 25-Mar 07:48 backup-dir JobId 47754: Using Device "DiskStorage2" to read. > 25-Mar 07:51 backup-sd JobId 47754: Ready to read from volume "DISK016" on > File device "DiskStorage2" (/media/baculadisk2). > 25-Mar 07:51 backup-sd JobId 47754: Forward spacing Volume "DISK016" to > addr=217 > 25-Mar 12:59 backup-sd JobId 47754: Error: block.c:682 [SE0208] Volume data > error at 0:0! Short block of 57010 bytes on device "DiskStorage2" > (/media/baculadisk2) discarded. > 25-Mar 12:59 backup-sd JobId 47754: Error: read_records.c:160 block.c:682 > [SE0208] Volume data error at 0:0! Short block of 57010 bytes on device > "DiskStorage2" (/media/baculadisk2) discarded. > 25-Mar 12:59 backup-sd JobId 47754: End of Volume "DISK016" at > addr=972406571008 on device "DiskStorage2" (/media/baculadisk2). > 25-Mar 13:00 backup-sd JobId 47754: Ready to read from volume "DISK017" on > File device "DiskStorage2" (/media/baculadisk2). > 25-Mar 13:00 backup-sd JobId 47754: Forward spacing Volume "DISK017" to > addr=213 > 25-Mar 13:59 backup-sd JobId 47754: End of Volume "DISK017" at > addr=110838477984 on device "DiskStorage2" (/media/baculadisk2). > 25-Mar 13:59 backup-sd JobId 47754: Elapsed time=06:08:08, Transfer > rate=49.00 M Bytes/second > 25-Mar 15:51 backup-dir JobId 47754: Warning: Found errors during the > migration process. The original job 47704 will be kept in the catalog and the > Migration job will be marked in Error > 25-Mar 15:51 backup-dir JobId 47754: Error: bsock.c:388 Wrote 4 bytes to > Storage daemon:backup.localnet.cosmicstars.de:9103, but only 0 accepted. > 25-Mar 15:51 backup-dir JobId 47754: Error: Bacula backup-dir 9.4.2 (04Feb19): > Build OS: x86_64-pc-linux-gnu debian buster/sid > Prev Backup JobId: 47704 > Prev Backup Job: nihilnihil_home.2020-03-21_20.23.31_49 > New Backup JobId: 47755 > Current JobId: 47754 > Current Job: MigrateFile2Drive.2020-03-25_07.48.01_43 > Backup Level: Full > Client: backup-fd > FileSet: "Full Set" 2017-10-09 08:53:50 > Read Pool: "Migrate" (From Job resource) > Read Storage: "Disk2" (From Pool resource) > Write Pool: "Monthly" (From Job Pool's NextPool resource) > Write Storage: "FibreCAT TX48 S2" (From Job Pool's NextPool > resource) > Catalog: "MyCatalog" (From Client resource) > Start time: 25-Mar-2020 07:48:04 > End time: 25-Mar-2020 15:51:34 > Elapsed time: 8 hours 3 mins 30 secs > Priority: 21 > SD Files Written: 1,030,385 > SD Bytes Written: 1,082,331,572,757 (1.082 TB) > Rate: 37308.9 KB/s > Volume name(s): LTO40026|LTO40025 > Volume Session Id: 77 > Volume Session Time: 1584646035 > Last Volume Bytes: 270,297,086,976 (270.2 GB) > SD Errors: 2 > SD termination status: OK > Termination: *** Migration Error *** > > 25-Mar 07:33 backup-dir JobId 0: Job=Migrate2FileTmpVol not found. Assuming > it was removed!!! > 25-Mar 07:35 backup-dir JobId 0: Job=Migrate2FileTmpVol not found. Assuming > it was removed!!! > 25-Mar 07:47 backup-dir JobId 0: Job=Migrate2FileTmpVol not found. Assuming > it was removed!!! > > I will check what bscan will report. > > > > _______________________________________________ > Bacula-users mailing list > Bacula-users@lists.sourceforge.net > https://lists.sourceforge.net/lists/listinfo/bacula-users > _______________________________________________ Bacula-users mailing list Bacula-users@lists.sourceforge.net https://lists.sourceforge.net/lists/listinfo/bacula-users