Kern Sibbald wrote:
> Could you set:
>
> export REGRESS_DEBUG=1
>
> and run the migration-job-test then send me the output?
Here it is.
--
Frank Sweetser fs at wpi.edu | For every problem, there is a solution that
WPI Senior Network Engineer | is simple, elegant, and wrong. - HL Mencken
GPG fingerprint = 6174 1257 129E 0D21 D8D4 E8A3 8E39 29E3 E2E8 8CEC
Script started on Sat 22 Dec 2007 12:59:05 PM EST
]0;[EMAIL PROTECTED]:~/bacula/bacula-trunk/[EMAIL PROTECTED] regress]$ export
REGRESS_DEBUG=1
]0;[EMAIL PROTECTED]:~/bacula/bacula-trunk/[EMAIL PROTECTED] regress]$
./tests/migration-job-test
=== Starting migration-job-test at 12:59:30 ===
Starting the Bacula Storage daemon
Starting the Bacula File daemon
Starting the Bacula Director daemon
Connecting to Director localhost:8101
1000 OK: localhost-dir Version: 2.2.7 (14 December 2007)
Enter a period to cancel a command.
@output
messages
You have no messages.
@tee /home/fs/bacula/bacula-trunk/regress/tmp/log1.out
@#setdebug level=100 storage=File
label storage=File volume=FileVolume001 Pool=Default
Automatically selected Catalog: MyCatalog
Using Catalog "MyCatalog"
Connecting to Storage daemon File at localhost:8103 ...
Sending label command for Volume "FileVolume001" Slot 0 ...
3000 OK label. VolBytes=203 DVD=0 Volume="FileVolume001" Device="FileStorage"
(/home/fs/bacula/bacula-trunk/regress/tmp)
Catalog record for Volume "FileVolume001", Slot 0 successfully created.
Requesting to mount FileStorage ...
3906 File device "FileStorage" (/home/fs/bacula/bacula-trunk/regress/tmp) is
always mounted.
label storage=DiskChanger volume=ChangerVolume001 slot=1 Pool=Full drive=0
Connecting to Storage daemon DiskChanger at localhost:8103 ...
Sending label command for Volume "ChangerVolume001" Slot 1 ...
3301 Issuing autochanger "loaded? drive 0" command.
3302 Autochanger "loaded? drive 0", result: nothing loaded.
3304 Issuing autochanger "load slot 1, drive 0" command.
3305 Autochanger "load slot 1, drive 0", status is OK.
3301 Issuing autochanger "loaded? drive 0" command.
3302 Autochanger "loaded? drive 0", result is Slot 1.
3301 Issuing autochanger "loaded? drive 0" command.
3302 Autochanger "loaded? drive 0", result is Slot 1.
3000 OK label. VolBytes=215 DVD=0 Volume="ChangerVolume001" Device="Drive-0"
(/home/fs/bacula/bacula-trunk/regress/tmp/disk-changer/drive0)
Catalog record for Volume "ChangerVolume001", Slot 1 successfully created.
Requesting to mount DiskChanger ...
3002 Device "Drive-0"
(/home/fs/bacula/bacula-trunk/regress/tmp/disk-changer/drive0) is mounted.
label storage=DiskChanger volume=ChangerVolume002 slot=2 Pool=Full drive=0
Connecting to Storage daemon DiskChanger at localhost:8103 ...
Sending label command for Volume "ChangerVolume002" Slot 2 ...
3301 Issuing autochanger "loaded? drive 0" command.
3302 Autochanger "loaded? drive 0", result is Slot 1.
3307 Issuing autochanger "unload slot 1, drive 0" command.
3304 Issuing autochanger "load slot 2, drive 0" command.
3305 Autochanger "load slot 2, drive 0", status is OK.
3301 Issuing autochanger "loaded? drive 0" command.
3302 Autochanger "loaded? drive 0", result is Slot 2.
3301 Issuing autochanger "loaded? drive 0" command.
3302 Autochanger "loaded? drive 0", result is Slot 2.
3000 OK label. VolBytes=215 DVD=0 Volume="ChangerVolume002" Device="Drive-0"
(/home/fs/bacula/bacula-trunk/regress/tmp/disk-changer/drive0)
Catalog record for Volume "ChangerVolume002", Slot 2 successfully created.
Requesting to mount DiskChanger ...
3002 Device "Drive-0"
(/home/fs/bacula/bacula-trunk/regress/tmp/disk-changer/drive0) is mounted.
@# run two jobs (both will be migrated)
run job=MigrationJobSave yes
Job queued. JobId=1
You have messages.
run job=MigrationJobSave yes
Job queued. JobId=2
wait
list jobs
+-------+------------------+---------------------+------+-------+----------+----------+-----------+
| JobId | Name | StartTime | Type | Level | JobFiles |
JobBytes | JobStatus |
+-------+------------------+---------------------+------+-------+----------+----------+-----------+
| 1 | MigrationJobSave | 2007-12-22 12:59:33 | B | F | 5484 |
66657204 | T |
| 2 | MigrationJobSave | 2007-12-22 12:59:37 | B | F | 5484 |
66657204 | T |
+-------+------------------+---------------------+------+-------+----------+----------+-----------+
list volumes
Pool: Default
+---------+---------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+-----------+---------------------+
| MediaId | VolumeName | VolStatus | Enabled | VolBytes | VolFiles |
VolRetention | Recycle | Slot | InChanger | MediaType | LastWritten |
+---------+---------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+-----------+---------------------+
| 1 | FileVolume001 | Append | 1 | 135560063 | 0 |
31536000 | 1 | 0 | 0 | File | 2007-12-22 12:59:40 |
+---------+---------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+-----------+---------------------+
Pool: Full
+---------+------------------+-----------+---------+----------+----------+--------------+---------+------+-----------+------------------+-------------+
| MediaId | VolumeName | VolStatus | Enabled | VolBytes | VolFiles |
VolRetention | Recycle | Slot | InChanger | MediaType | LastWritten |
+---------+------------------+-----------+---------+----------+----------+--------------+---------+------+-----------+------------------+-------------+
| 2 | ChangerVolume001 | Append | 1 | 215 | 0 |
31536000 | 1 | 1 | 1 | DiskChangerMedia | 0 |
| 3 | ChangerVolume002 | Append | 1 | 215 | 0 |
31536000 | 1 | 2 | 1 | DiskChangerMedia | 0 |
+---------+------------------+-----------+---------+----------+----------+--------------+---------+------+-----------+------------------+-------------+
@#setdebug level=100 dir
@# should migrate two jobs
@#setdebug level=51 storage=DiskChanger
run job=migrate-job yes
Job queued. JobId=3
wait
messages
22-Dec 12:59 localhost-dir JobId 1: No prior Full backup Job record found.
22-Dec 12:59 localhost-dir JobId 1: No prior or suitable Full backup found in
catalog. Doing FULL backup.
22-Dec 12:59 localhost-dir JobId 2: No prior Full backup Job record found.
22-Dec 12:59 localhost-dir JobId 2: No prior or suitable Full backup found in
catalog. Doing FULL backup.
22-Dec 12:59 localhost-dir JobId 1: Start Backup JobId 1,
Job=MigrationJobSave.2007-12-22_12.59.03
22-Dec 12:59 localhost-dir JobId 1: Using Device "FileStorage"
22-Dec 12:59 localhost-sd JobId 1: Wrote label to prelabeled Volume
"FileVolume001" on device "FileStorage"
(/home/fs/bacula/bacula-trunk/regress/tmp)
22-Dec 12:59 localhost-sd JobId 1: Spooling data ...
22-Dec 12:59 localhost-sd JobId 1: Job write elapsed time = 00:00:01, Transfer
rate = 67.56 M bytes/second
22-Dec 12:59 localhost-sd JobId 1: Committing spooled data to Volume
"FileVolume001". Despooling 67,792,542 bytes ...
22-Dec 12:59 localhost-sd JobId 1: Despooling elapsed time = 00:00:01, Transfer
rate = 67.79 M bytes/second
22-Dec 12:59 localhost-sd JobId 1: Sending spooled attrs to the Director.
Despooling 1,764,203 bytes ...
22-Dec 12:59 localhost-dir JobId 2: Start Backup JobId 2,
Job=MigrationJobSave.2007-12-22_12.59.04
22-Dec 12:59 localhost-dir JobId 2: Using Device "FileStorage"
22-Dec 12:59 localhost-sd JobId 2: Volume "FileVolume001" previously written,
moving to end of data.
22-Dec 12:59 localhost-sd JobId 2: Ready to append to end of Volume
"FileVolume001" size=67780133
22-Dec 12:59 localhost-sd JobId 2: Spooling data ...
22-Dec 12:59 localhost-sd JobId 2: Job write elapsed time = 00:00:02, Transfer
rate = 33.78 M bytes/second
22-Dec 12:59 localhost-sd JobId 2: Committing spooled data to Volume
"FileVolume001". Despooling 67,792,542 bytes ...
22-Dec 12:59 localhost-sd JobId 2: Despooling elapsed time = 00:00:01, Transfer
rate = 67.79 M bytes/second
22-Dec 12:59 localhost-sd JobId 2: Sending spooled attrs to the Director.
Despooling 1,764,203 bytes ...
22-Dec 12:59 localhost-dir JobId 1: Bacula localhost-dir 2.2.7 (14Dec07):
22-Dec-2007 12:59:41
Build OS: i686-pc-linux-gnu redhat
JobId: 1
Job: MigrationJobSave.2007-12-22_12.59.03
Backup Level: Full (upgraded from Incremental)
Client: "localhost-fd" 2.2.7 (14Dec07)
i686-pc-linux-gnu,redhat,
FileSet: "Full Set" 2007-12-22 12:59:33
Pool: "Default" (From Job resource)
Storage: "File" (From Pool resource)
Scheduled time: 22-Dec-2007 12:59:33
Start time: 22-Dec-2007 12:59:33
End time: 22-Dec-2007 12:59:41
Elapsed time: 8 secs
Priority: 10
FD Files Written: 5,484
SD Files Written: 5,484
FD Bytes Written: 66,657,204 (66.65 MB)
SD Bytes Written: 67,563,500 (67.56 MB)
Rate: 8332.2 KB/s
Software Compression: None
VSS: no
Encryption: no
Volume name(s): FileVolume001
Volume Session Id: 1
Volume Session Time: 1198346370
Last Volume Bytes: 135,560,063 (135.5 MB)
Non-fatal FD errors: 0
SD Errors: 0
FD termination status: OK
SD termination status: OK
Termination: Backup OK
22-Dec 12:59 localhost-dir JobId 1: Begin pruning Jobs.
22-Dec 12:59 localhost-dir JobId 1: No Jobs found to prune.
22-Dec 12:59 localhost-dir JobId 1: Begin pruning Files.
22-Dec 12:59 localhost-dir JobId 1: No Files found to prune.
22-Dec 12:59 localhost-dir JobId 1: End auto prune.
22-Dec 12:59 localhost-dir JobId 2: Bacula localhost-dir 2.2.7 (14Dec07):
22-Dec-2007 12:59:44
Build OS: i686-pc-linux-gnu redhat
JobId: 2
Job: MigrationJobSave.2007-12-22_12.59.04
Backup Level: Full (upgraded from Incremental)
Client: "localhost-fd" 2.2.7 (14Dec07)
i686-pc-linux-gnu,redhat,
FileSet: "Full Set" 2007-12-22 12:59:33
Pool: "Default" (From Job resource)
Storage: "File" (From Pool resource)
Scheduled time: 22-Dec-2007 12:59:33
Start time: 22-Dec-2007 12:59:37
End time: 22-Dec-2007 12:59:44
Elapsed time: 7 secs
Priority: 10
FD Files Written: 5,484
SD Files Written: 5,484
FD Bytes Written: 66,657,204 (66.65 MB)
SD Bytes Written: 67,563,500 (67.56 MB)
Rate: 9522.5 KB/s
Software Compression: None
VSS: no
Encryption: no
Volume name(s): FileVolume001
Volume Session Id: 2
Volume Session Time: 1198346370
Last Volume Bytes: 135,560,063 (135.5 MB)
Non-fatal FD errors: 0
SD Errors: 0
FD termination status: OK
SD termination status: OK
Termination: Backup OK
22-Dec 12:59 localhost-dir JobId 2: Begin pruning Jobs.
22-Dec 12:59 localhost-dir JobId 2: No Jobs found to prune.
22-Dec 12:59 localhost-dir JobId 2: Begin pruning Files.
22-Dec 12:59 localhost-dir JobId 2: No Files found to prune.
22-Dec 12:59 localhost-dir JobId 2: End auto prune.
22-Dec 12:59 localhost-dir JobId 3: The following 2 JobIds were chosen to be
migrated: 1,2
22-Dec 12:59 localhost-dir JobId 4: The following 1 JobIds were chosen to be
migrated: 1
22-Dec 12:59 localhost-dir JobId 4: Migration using JobId=1
Job=MigrationJobSave.2007-12-22_12.59.03
22-Dec 12:59 localhost-dir JobId 4: Bootstrap records written to
/home/fs/bacula/bacula-trunk/regress/working/localhost-dir.restore.1.bsr
22-Dec 12:59 localhost-dir JobId 4:
22-Dec 12:59 localhost-dir JobId 4: The job will require the following
Volume(s) Storage(s) SD Device(s)
===========================================================================
22-Dec 12:59 localhost-dir JobId 4:
22-Dec 12:59 localhost-dir JobId 4: FileVolume001 File
FileStorage
22-Dec 12:59 localhost-dir JobId 4:
22-Dec 12:59 localhost-dir JobId 3: Job queued. JobId=4
22-Dec 12:59 localhost-dir JobId 3: Migration JobId 4 started.
22-Dec 12:59 localhost-dir JobId 3: Migration using JobId=2
Job=MigrationJobSave.2007-12-22_12.59.04
22-Dec 12:59 localhost-dir JobId 3: Bootstrap records written to
/home/fs/bacula/bacula-trunk/regress/working/localhost-dir.restore.2.bsr
22-Dec 12:59 localhost-dir JobId 3:
22-Dec 12:59 localhost-dir JobId 3: The job will require the following
Volume(s) Storage(s) SD Device(s)
===========================================================================
22-Dec 12:59 localhost-dir JobId 3:
22-Dec 12:59 localhost-dir JobId 3: FileVolume001 File
FileStorage
22-Dec 12:59 localhost-dir JobId 3:
22-Dec 12:59 localhost-dir JobId 4: Start Migration JobId 4,
Job=migrate-job.2007-12-22_12.59.06
22-Dec 12:59 localhost-dir JobId 4: Using Device "Drive-0"
22-Dec 12:59 localhost-sd JobId 4: Ready to read from volume "FileVolume001" on
device "FileStorage" (/home/fs/bacula/bacula-trunk/regress/tmp).
22-Dec 12:59 localhost-sd JobId 4: 3301 Issuing autochanger "loaded? drive 0"
command.
22-Dec 12:59 localhost-sd JobId 4: 3302 Autochanger "loaded? drive 0", result
is Slot 2.
22-Dec 12:59 localhost-sd JobId 4: 3307 Issuing autochanger "unload slot 2,
drive 0" command.
22-Dec 12:59 localhost-sd JobId 4: 3304 Issuing autochanger "load slot 1, drive
0" command.
22-Dec 12:59 localhost-sd JobId 4: 3305 Autochanger "load slot 1, drive 0",
status is OK.
22-Dec 12:59 localhost-sd JobId 4: 3301 Issuing autochanger "loaded? drive 0"
command.
22-Dec 12:59 localhost-sd JobId 4: 3302 Autochanger "loaded? drive 0", result
is Slot 1.
22-Dec 12:59 localhost-sd JobId 4: Wrote label to prelabeled Volume
"ChangerVolume001" on device "Drive-0"
(/home/fs/bacula/bacula-trunk/regress/tmp/disk-changer/drive0)
22-Dec 12:59 localhost-sd JobId 4: Forward spacing Volume "FileVolume001" to
file:block 0:203.
22-Dec 12:59 localhost-sd JobId 4: End of file 0 on device "FileStorage"
(/home/fs/bacula/bacula-trunk/regress/tmp), Volume "FileVolume001"
22-Dec 12:59 localhost-sd JobId 4: End of Volume at file 0 on device
"FileStorage" (/home/fs/bacula/bacula-trunk/regress/tmp), Volume "FileVolume001"
22-Dec 12:59 localhost-sd JobId 4: End of all volumes.
22-Dec 12:59 localhost-dir JobId 4: Bacula localhost-dir 2.2.7 (14Dec07):
22-Dec-2007 12:59:48
Build OS: i686-pc-linux-gnu redhat
Prev Backup JobId: 1
New Backup JobId: 5
Migration JobId: 4
Migration Job: migrate-job.2007-12-22_12.59.06
Backup Level: Full
Client: localhost-fd
FileSet: "Full Set" 2007-12-22 12:59:33
Read Pool: "Default" (From Job resource)
Read Storage: "File" (From Pool resource)
Write Pool: "Full" (From Job Pool's NextPool resource)
Write Storage: "DiskChanger" (From Storage from Pool's NextPool
resource)
Start time: 22-Dec-2007 12:59:44
End time: 22-Dec-2007 12:59:48
Elapsed time: 4 secs
Priority: 10
SD Files Written: 5,484
SD Bytes Written: 67,563,870 (67.56 MB)
Rate: 16891.0 KB/s
Volume name(s): ChangerVolume001
Volume Session Id: 3
Volume Session Time: 1198346370
Last Volume Bytes: 67,780,145 (67.78 MB)
SD Errors: 0
SD termination status: OK
Termination: Migration OK
22-Dec 12:59 localhost-dir JobId 4: Begin pruning Jobs.
22-Dec 12:59 localhost-dir JobId 4: No Jobs found to prune.
22-Dec 12:59 localhost-dir JobId 4: Begin pruning Files.
22-Dec 12:59 localhost-dir JobId 4: No Files found to prune.
22-Dec 12:59 localhost-dir JobId 4: End auto prune.
22-Dec 12:59 localhost-dir JobId 3: Start Migration JobId 3,
Job=migrate-job.2007-12-22_12.59.05
22-Dec 12:59 localhost-dir JobId 3: Using Device "Drive-0"
22-Dec 12:59 localhost-sd JobId 3: Ready to read from volume "FileVolume001" on
device "FileStorage" (/home/fs/bacula/bacula-trunk/regress/tmp).
22-Dec 12:59 localhost-sd JobId 3: 3301 Issuing autochanger "loaded? drive 0"
command.
22-Dec 12:59 localhost-sd JobId 3: 3302 Autochanger "loaded? drive 0", result
is Slot 1.
22-Dec 12:59 localhost-sd JobId 3: 3301 Issuing autochanger "loaded? drive 0"
command.
22-Dec 12:59 localhost-sd JobId 3: 3302 Autochanger "loaded? drive 0", result
is Slot 1.
22-Dec 12:59 localhost-sd JobId 3: Volume "ChangerVolume001" previously
written, moving to end of data.
22-Dec 12:59 localhost-sd JobId 3: Ready to append to end of Volume
"ChangerVolume001" size=67780145
22-Dec 12:59 localhost-sd JobId 3: Forward spacing Volume "FileVolume001" to
file:block 0:67780133.
22-Dec 12:59 localhost-sd JobId 3: End of file 0 on device "FileStorage"
(/home/fs/bacula/bacula-trunk/regress/tmp), Volume "FileVolume001"
22-Dec 12:59 localhost-sd JobId 3: End of Volume at file 0 on device
"FileStorage" (/home/fs/bacula/bacula-trunk/regress/tmp), Volume "FileVolume001"
22-Dec 12:59 localhost-sd JobId 3: End of all volumes.
22-Dec 12:59 localhost-dir JobId 3: Bacula localhost-dir 2.2.7 (14Dec07):
22-Dec-2007 12:59:55
Build OS: i686-pc-linux-gnu redhat
Prev Backup JobId: 2
New Backup JobId: 6
Migration JobId: 3
Migration Job: migrate-job.2007-12-22_12.59.05
Backup Level: Full
Client: localhost-fd
FileSet: "Full Set" 2007-12-22 12:59:33
Read Pool: "Default" (From Job resource)
Read Storage: "File" (From Pool resource)
Write Pool: "Full" (From Job Pool's NextPool resource)
Write Storage: "DiskChanger" (From Storage from Pool's NextPool
resource)
Start time: 22-Dec-2007 12:59:50
End time: 22-Dec-2007 12:59:55
Elapsed time: 5 secs
Priority: 10
SD Files Written: 5,484
SD Bytes Written: 67,563,870 (67.56 MB)
Rate: 13512.8 KB/s
Volume name(s): ChangerVolume001
Volume Session Id: 4
Volume Session Time: 1198346370
Last Volume Bytes: 135,560,075 (135.5 MB)
SD Errors: 0
SD termination status: OK
Termination: Migration OK
22-Dec 12:59 localhost-dir JobId 3: Begin pruning Jobs.
22-Dec 12:59 localhost-dir JobId 3: No Jobs found to prune.
22-Dec 12:59 localhost-dir JobId 3: Begin pruning Files.
22-Dec 12:59 localhost-dir JobId 3: No Files found to prune.
22-Dec 12:59 localhost-dir JobId 3: End auto prune.
@# purge volume=FileVolume001
list jobs
+-------+------------------+---------------------+------+-------+----------+----------+-----------+
| JobId | Name | StartTime | Type | Level | JobFiles |
JobBytes | JobStatus |
+-------+------------------+---------------------+------+-------+----------+----------+-----------+
| 1 | MigrationJobSave | 2007-12-22 12:59:33 | M | F | 5484 |
66657204 | T |
| 5 | MigrationJobSave | 2007-12-22 12:59:33 | B | F | 5484 |
67563870 | T |
| 2 | MigrationJobSave | 2007-12-22 12:59:37 | M | F | 5484 |
66657204 | T |
| 6 | MigrationJobSave | 2007-12-22 12:59:37 | B | F | 5484 |
67563870 | T |
| 4 | migrate-job | 2007-12-22 12:59:44 | g | F | 0 | 0
| T |
| 3 | migrate-job | 2007-12-22 12:59:50 | g | F | 0 | 0
| T |
+-------+------------------+---------------------+------+-------+----------+----------+-----------+
list volumes
Pool: Default
+---------+---------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+-----------+---------------------+
| MediaId | VolumeName | VolStatus | Enabled | VolBytes | VolFiles |
VolRetention | Recycle | Slot | InChanger | MediaType | LastWritten |
+---------+---------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+-----------+---------------------+
| 1 | FileVolume001 | Append | 1 | 135560063 | 0 |
31536000 | 1 | 0 | 0 | File | 2007-12-22 12:59:40 |
+---------+---------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+-----------+---------------------+
Pool: Full
+---------+------------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+------------------+---------------------+
| MediaId | VolumeName | VolStatus | Enabled | VolBytes | VolFiles |
VolRetention | Recycle | Slot | InChanger | MediaType | LastWritten
|
+---------+------------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+------------------+---------------------+
| 2 | ChangerVolume001 | Append | 1 | 135560075 | 0 |
31536000 | 1 | 1 | 1 | DiskChangerMedia | 2007-12-22
12:59:55 |
| 3 | ChangerVolume002 | Append | 1 | 215 | 0 |
31536000 | 1 | 2 | 1 | DiskChangerMedia | 0
|
+---------+------------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+------------------+---------------------+
wait
@#
@# Now do another backup, but level Incremental
@#
run job=MigrationJobSave level=Incremental yes
Job queued. JobId=7
wait
You have messages.
messages
22-Dec 12:59 localhost-dir JobId 7: Start Backup JobId 7,
Job=MigrationJobSave.2007-12-22_12.59.09
22-Dec 12:59 localhost-dir JobId 7: Using Device "FileStorage"
22-Dec 12:59 localhost-sd JobId 7: Volume "FileVolume001" previously written,
moving to end of data.
22-Dec 12:59 localhost-sd JobId 7: Ready to append to end of Volume
"FileVolume001" size=135560063
22-Dec 12:59 localhost-sd JobId 7: Spooling data ...
22-Dec 12:59 localhost-sd JobId 7: Job write elapsed time = 00:00:01, Transfer
rate = 0 bytes/second
22-Dec 12:59 localhost-sd JobId 7: Committing spooled data to Volume
"FileVolume001". Despooling 430 bytes ...
22-Dec 12:59 localhost-sd JobId 7: Despooling elapsed time = 00:00:01, Transfer
rate = 430 bytes/second
22-Dec 12:59 localhost-sd JobId 7: Sending spooled attrs to the Director.
Despooling 0 bytes ...
22-Dec 12:59 localhost-dir JobId 7: Bacula localhost-dir 2.2.7 (14Dec07):
22-Dec-2007 12:59:58
Build OS: i686-pc-linux-gnu redhat
JobId: 7
Job: MigrationJobSave.2007-12-22_12.59.09
Backup Level: Incremental, since=2007-12-22 12:59:37
Client: "localhost-fd" 2.2.7 (14Dec07)
i686-pc-linux-gnu,redhat,
FileSet: "Full Set" 2007-12-22 12:59:33
Pool: "Default" (From Job resource)
Storage: "File" (From Pool resource)
Scheduled time: 22-Dec-2007 12:59:56
Start time: 22-Dec-2007 12:59:58
End time: 22-Dec-2007 12:59:58
Elapsed time: 0 secs
Priority: 10
FD Files Written: 0
SD Files Written: 0
FD Bytes Written: 0 (0 B)
SD Bytes Written: 0 (0 B)
Rate: 0.0 KB/s
Software Compression: None
VSS: no
Encryption: no
Volume name(s): FileVolume001
Volume Session Id: 5
Volume Session Time: 1198346370
Last Volume Bytes: 135,560,481 (135.5 MB)
Non-fatal FD errors: 0
SD Errors: 0
FD termination status: OK
SD termination status: OK
Termination: Backup OK
22-Dec 12:59 localhost-dir JobId 7: Begin pruning Jobs.
22-Dec 12:59 localhost-dir JobId 7: No Jobs found to prune.
22-Dec 12:59 localhost-dir JobId 7: Begin pruning Files.
22-Dec 12:59 localhost-dir JobId 7: No Files found to prune.
22-Dec 12:59 localhost-dir JobId 7: End auto prune.
@#
@# This final job that runs should be Incremental and
@# not upgraded to full.
list jobs
+-------+------------------+---------------------+------+-------+----------+----------+-----------+
| JobId | Name | StartTime | Type | Level | JobFiles |
JobBytes | JobStatus |
+-------+------------------+---------------------+------+-------+----------+----------+-----------+
| 1 | MigrationJobSave | 2007-12-22 12:59:33 | M | F | 5484 |
66657204 | T |
| 5 | MigrationJobSave | 2007-12-22 12:59:33 | B | F | 5484 |
67563870 | T |
| 2 | MigrationJobSave | 2007-12-22 12:59:37 | M | F | 5484 |
66657204 | T |
| 6 | MigrationJobSave | 2007-12-22 12:59:37 | B | F | 5484 |
67563870 | T |
| 4 | migrate-job | 2007-12-22 12:59:44 | g | F | 0 | 0
| T |
| 3 | migrate-job | 2007-12-22 12:59:50 | g | F | 0 | 0
| T |
| 7 | MigrationJobSave | 2007-12-22 12:59:58 | B | I | 0 | 0
| T |
+-------+------------------+---------------------+------+-------+----------+----------+-----------+
@#
@# now do a restore
@#
@tee /home/fs/bacula/bacula-trunk/regress/tmp/log2.out
list volumes
Pool: Default
+---------+---------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+-----------+---------------------+
| MediaId | VolumeName | VolStatus | Enabled | VolBytes | VolFiles |
VolRetention | Recycle | Slot | InChanger | MediaType | LastWritten |
+---------+---------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+-----------+---------------------+
| 1 | FileVolume001 | Append | 1 | 135560481 | 0 |
31536000 | 1 | 0 | 0 | File | 2007-12-22 12:59:58 |
+---------+---------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+-----------+---------------------+
Pool: Full
+---------+------------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+------------------+---------------------+
| MediaId | VolumeName | VolStatus | Enabled | VolBytes | VolFiles |
VolRetention | Recycle | Slot | InChanger | MediaType | LastWritten
|
+---------+------------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+------------------+---------------------+
| 2 | ChangerVolume001 | Append | 1 | 135560075 | 0 |
31536000 | 1 | 1 | 1 | DiskChangerMedia | 2007-12-22
12:59:55 |
| 3 | ChangerVolume002 | Append | 1 | 215 | 0 |
31536000 | 1 | 2 | 1 | DiskChangerMedia | 0
|
+---------+------------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+------------------+---------------------+
restore where=/home/fs/bacula/bacula-trunk/regress/tmp/bacula-restores select
storage=DiskChanger
Automatically selected Client: localhost-fd
Automatically selected FileSet: Full Set
+-------+-------+----------+----------+---------------------+------------------+
| JobId | Level | JobFiles | JobBytes | StartTime | VolumeName |
+-------+-------+----------+----------+---------------------+------------------+
| 6 | F | 5484 | 67563870 | 2007-12-22 12:59:37 | ChangerVolume001 |
| 7 | I | 0 | 0 | 2007-12-22 12:59:58 | FileVolume001 |
+-------+-------+----------+----------+---------------------+------------------+
You have selected the following JobIds: 6,7
Building directory tree for JobId 6 ...
++++++++++++++++++++++++++++++++++++++++++++
Building directory tree for JobId 7 ...
2 Jobs, 4,879 files inserted into the tree.
You are now entering file selection mode where you add (mark) and
remove (unmark) files to be restored. No files are initially added, unless
you used the "all" keyword on the command line.
Enter "done" to leave this mode.
cwd is: /
$ unmark *
5,484 files unmarked.
$ mark *
5,484 files marked.
$ done
Bootstrap records written to
/home/fs/bacula/bacula-trunk/regress/working/localhost-dir.restore.3.bsr
The job will require the following
Volume(s) Storage(s) SD Device(s)
===========================================================================
ChangerVolume001 DiskChanger DiskChanger
5,484 files selected to be restored.
grep: tmp/dir.out: No such file or directory
!!!! Zombie Jobs in Director !!!!
diff: tmp/bacula-restores/home/fs/bacula/bacula-trunk/regress/build: No such
file or directory
!!!!! migration-job-test failed!!! 13:00:25 !!!!!
!!!!! Bad termination status !!!!!
Status: backup=0 restore=1 diff=2
]0;[EMAIL PROTECTED]:~/bacula/bacula-trunk/[EMAIL PROTECTED] regress]$ exit
Script done on Sat 22 Dec 2007 01:01:43 PM EST
-------------------------------------------------------------------------
This SF.net email is sponsored by: Microsoft
Defy all challenges. Microsoft(R) Visual Studio 2005.
http://clk.atdmt.com/MRT/go/vse0120000070mrt/direct/01/
_______________________________________________
Bacula-devel mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/bacula-devel
