Kern Sibbald wrote:
> On Saturday 22 December 2007 19:07, Frank Sweetser wrote:
>> Kern Sibbald wrote:
>>> Could you set:
>>>
>>> export REGRESS_DEBUG=1
>>>
>>> and run the migration-job-test then send me the output?
>> Here it is.
>
> That is *very* odd. It looks like bconsole just "vanished" -- maybe it
> crashed or something, but it is in the middle of doing something then just
> goes away ...
>
> Could you do an "svn update" on the trunk regress svn, then run that test
> again. I've added one new command that should print some output if bconsole
> gets to it.
Done, and attached. At a glance, at least, it looks to be pretty much
identical output.
--
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 03:33:07 PM EST
]0;[EMAIL PROTECTED]:~/bacula/bacula-trunk/[EMAIL PROTECTED] regress]$
./tests/migration-job-test
[C[C[C[C[C[C[C[C[C[C[C[C[C[C[C[C[C[C[C[C[C[5Pexport
REGRESS_DEBUG=1
]0;[EMAIL PROTECTED]:~/bacula/bacula-trunk/[EMAIL PROTECTED] regress]$ export
REGRESS_DEBUG=1./tests/migration-job-test
=== Starting migration-job-test at 15:33:18 ===
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
22-Dec 13:42 localhost-dir: Fatal Error because: Bacula interrupted by signal
11: Segmentation violation
@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 15:33:21 | B | F | 5484 |
66657204 | T |
| 2 | MigrationJobSave | 2007-12-22 15:33:25 | 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 15:33:28 |
+---------+---------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+-----------+---------------------+
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 15:33 localhost-dir JobId 1: No prior Full backup Job record found.
22-Dec 15:33 localhost-dir JobId 1: No prior or suitable Full backup found in
catalog. Doing FULL backup.
22-Dec 15:33 localhost-dir JobId 2: No prior Full backup Job record found.
22-Dec 15:33 localhost-dir JobId 2: No prior or suitable Full backup found in
catalog. Doing FULL backup.
22-Dec 15:33 localhost-dir JobId 1: Start Backup JobId 1,
Job=MigrationJobSave.2007-12-22_15.33.03
22-Dec 15:33 localhost-dir JobId 1: Using Device "FileStorage"
22-Dec 15:33 localhost-sd JobId 1: Wrote label to prelabeled Volume
"FileVolume001" on device "FileStorage"
(/home/fs/bacula/bacula-trunk/regress/tmp)
22-Dec 15:33 localhost-sd JobId 1: Spooling data ...
22-Dec 15:33 localhost-sd JobId 1: Job write elapsed time = 00:00:01, Transfer
rate = 67.56 M bytes/second
22-Dec 15:33 localhost-sd JobId 1: Committing spooled data to Volume
"FileVolume001". Despooling 67,792,542 bytes ...
22-Dec 15:33 localhost-sd JobId 1: Despooling elapsed time = 00:00:01, Transfer
rate = 67.79 M bytes/second
22-Dec 15:33 localhost-sd JobId 1: Sending spooled attrs to the Director.
Despooling 1,764,203 bytes ...
22-Dec 15:33 localhost-dir JobId 2: Start Backup JobId 2,
Job=MigrationJobSave.2007-12-22_15.33.04
22-Dec 15:33 localhost-dir JobId 2: Using Device "FileStorage"
22-Dec 15:33 localhost-sd JobId 2: Volume "FileVolume001" previously written,
moving to end of data.
22-Dec 15:33 localhost-sd JobId 2: Ready to append to end of Volume
"FileVolume001" size=67780133
22-Dec 15:33 localhost-sd JobId 2: Spooling data ...
22-Dec 15:33 localhost-sd JobId 2: Job write elapsed time = 00:00:02, Transfer
rate = 33.78 M bytes/second
22-Dec 15:33 localhost-sd JobId 2: Committing spooled data to Volume
"FileVolume001". Despooling 67,792,542 bytes ...
22-Dec 15:33 localhost-sd JobId 2: Despooling elapsed time = 00:00:01, Transfer
rate = 67.79 M bytes/second
22-Dec 15:33 localhost-sd JobId 2: Sending spooled attrs to the Director.
Despooling 1,764,203 bytes ...
22-Dec 15:33 localhost-dir JobId 1: Bacula localhost-dir 2.2.7 (14Dec07):
22-Dec-2007 15:33:28
Build OS: i686-pc-linux-gnu redhat
JobId: 1
Job: MigrationJobSave.2007-12-22_15.33.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 15:33:21
Pool: "Default" (From Job resource)
Storage: "File" (From Pool resource)
Scheduled time: 22-Dec-2007 15:33:21
Start time: 22-Dec-2007 15:33:21
End time: 22-Dec-2007 15:33:28
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: 1
Volume Session Time: 1198355598
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 15:33 localhost-dir JobId 1: Begin pruning Jobs.
22-Dec 15:33 localhost-dir JobId 1: No Jobs found to prune.
22-Dec 15:33 localhost-dir JobId 1: Begin pruning Files.
22-Dec 15:33 localhost-dir JobId 1: No Files found to prune.
22-Dec 15:33 localhost-dir JobId 1: End auto prune.
22-Dec 15:33 localhost-dir JobId 2: Bacula localhost-dir 2.2.7 (14Dec07):
22-Dec-2007 15:33:32
Build OS: i686-pc-linux-gnu redhat
JobId: 2
Job: MigrationJobSave.2007-12-22_15.33.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 15:33:21
Pool: "Default" (From Job resource)
Storage: "File" (From Pool resource)
Scheduled time: 22-Dec-2007 15:33:21
Start time: 22-Dec-2007 15:33:25
End time: 22-Dec-2007 15:33:32
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: 1198355598
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 15:33 localhost-dir JobId 2: Begin pruning Jobs.
22-Dec 15:33 localhost-dir JobId 2: No Jobs found to prune.
22-Dec 15:33 localhost-dir JobId 2: Begin pruning Files.
22-Dec 15:33 localhost-dir JobId 2: No Files found to prune.
22-Dec 15:33 localhost-dir JobId 2: End auto prune.
22-Dec 15:33 localhost-dir JobId 3: The following 2 JobIds were chosen to be
migrated: 1,2
22-Dec 15:33 localhost-dir JobId 4: The following 1 JobIds were chosen to be
migrated: 1
22-Dec 15:33 localhost-dir JobId 4: Migration using JobId=1
Job=MigrationJobSave.2007-12-22_15.33.03
22-Dec 15:33 localhost-dir JobId 4: Bootstrap records written to
/home/fs/bacula/bacula-trunk/regress/working/localhost-dir.restore.1.bsr
22-Dec 15:33 localhost-dir JobId 4:
22-Dec 15:33 localhost-dir JobId 4: The job will require the following
Volume(s) Storage(s) SD Device(s)
===========================================================================
22-Dec 15:33 localhost-dir JobId 4:
22-Dec 15:33 localhost-dir JobId 4: FileVolume001 File
FileStorage
22-Dec 15:33 localhost-dir JobId 4:
22-Dec 15:33 localhost-dir JobId 3: Job queued. JobId=4
22-Dec 15:33 localhost-dir JobId 3: Migration JobId 4 started.
22-Dec 15:33 localhost-dir JobId 3: Migration using JobId=2
Job=MigrationJobSave.2007-12-22_15.33.04
22-Dec 15:33 localhost-dir JobId 3: Bootstrap records written to
/home/fs/bacula/bacula-trunk/regress/working/localhost-dir.restore.2.bsr
22-Dec 15:33 localhost-dir JobId 3:
22-Dec 15:33 localhost-dir JobId 3: The job will require the following
Volume(s) Storage(s) SD Device(s)
===========================================================================
22-Dec 15:33 localhost-dir JobId 3:
22-Dec 15:33 localhost-dir JobId 3: FileVolume001 File
FileStorage
22-Dec 15:33 localhost-dir JobId 3:
22-Dec 15:33 localhost-dir JobId 4: Start Migration JobId 4,
Job=migrate-job.2007-12-22_15.33.06
22-Dec 15:33 localhost-dir JobId 4: Using Device "Drive-0"
22-Dec 15:33 localhost-sd JobId 4: Ready to read from volume "FileVolume001" on
device "FileStorage" (/home/fs/bacula/bacula-trunk/regress/tmp).
22-Dec 15:33 localhost-sd JobId 4: 3301 Issuing autochanger "loaded? drive 0"
command.
22-Dec 15:33 localhost-sd JobId 4: 3302 Autochanger "loaded? drive 0", result
is Slot 2.
22-Dec 15:33 localhost-sd JobId 4: 3307 Issuing autochanger "unload slot 2,
drive 0" command.
22-Dec 15:33 localhost-sd JobId 4: 3304 Issuing autochanger "load slot 1, drive
0" command.
22-Dec 15:33 localhost-sd JobId 4: 3305 Autochanger "load slot 1, drive 0",
status is OK.
22-Dec 15:33 localhost-sd JobId 4: 3301 Issuing autochanger "loaded? drive 0"
command.
22-Dec 15:33 localhost-sd JobId 4: 3302 Autochanger "loaded? drive 0", result
is Slot 1.
22-Dec 15:33 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 15:33 localhost-sd JobId 4: Forward spacing Volume "FileVolume001" to
file:block 0:203.
22-Dec 15:33 localhost-sd JobId 4: End of file 0 on device "FileStorage"
(/home/fs/bacula/bacula-trunk/regress/tmp), Volume "FileVolume001"
22-Dec 15:33 localhost-sd JobId 4: End of Volume at file 0 on device
"FileStorage" (/home/fs/bacula/bacula-trunk/regress/tmp), Volume "FileVolume001"
22-Dec 15:33 localhost-sd JobId 4: End of all volumes.
22-Dec 15:33 localhost-dir JobId 4: Bacula localhost-dir 2.2.7 (14Dec07):
22-Dec-2007 15:33:36
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_15.33.06
Backup Level: Full
Client: localhost-fd
FileSet: "Full Set" 2007-12-22 15:33:21
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 15:33:32
End time: 22-Dec-2007 15:33:36
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: 1198355598
Last Volume Bytes: 67,780,145 (67.78 MB)
SD Errors: 0
SD termination status: OK
Termination: Migration OK
22-Dec 15:33 localhost-dir JobId 4: Begin pruning Jobs.
22-Dec 15:33 localhost-dir JobId 4: No Jobs found to prune.
22-Dec 15:33 localhost-dir JobId 4: Begin pruning Files.
22-Dec 15:33 localhost-dir JobId 4: No Files found to prune.
22-Dec 15:33 localhost-dir JobId 4: End auto prune.
22-Dec 15:33 localhost-dir JobId 3: Start Migration JobId 3,
Job=migrate-job.2007-12-22_15.33.05
22-Dec 15:33 localhost-dir JobId 3: Using Device "Drive-0"
22-Dec 15:33 localhost-sd JobId 3: Ready to read from volume "FileVolume001" on
device "FileStorage" (/home/fs/bacula/bacula-trunk/regress/tmp).
22-Dec 15:33 localhost-sd JobId 3: 3301 Issuing autochanger "loaded? drive 0"
command.
22-Dec 15:33 localhost-sd JobId 3: 3302 Autochanger "loaded? drive 0", result
is Slot 1.
22-Dec 15:33 localhost-sd JobId 3: 3301 Issuing autochanger "loaded? drive 0"
command.
22-Dec 15:33 localhost-sd JobId 3: 3302 Autochanger "loaded? drive 0", result
is Slot 1.
22-Dec 15:33 localhost-sd JobId 3: Volume "ChangerVolume001" previously
written, moving to end of data.
22-Dec 15:33 localhost-sd JobId 3: Ready to append to end of Volume
"ChangerVolume001" size=67780145
22-Dec 15:33 localhost-sd JobId 3: Forward spacing Volume "FileVolume001" to
file:block 0:67780133.
22-Dec 15:33 localhost-sd JobId 3: End of file 0 on device "FileStorage"
(/home/fs/bacula/bacula-trunk/regress/tmp), Volume "FileVolume001"
22-Dec 15:33 localhost-sd JobId 3: End of Volume at file 0 on device
"FileStorage" (/home/fs/bacula/bacula-trunk/regress/tmp), Volume "FileVolume001"
22-Dec 15:33 localhost-sd JobId 3: End of all volumes.
22-Dec 15:33 localhost-dir JobId 3: Bacula localhost-dir 2.2.7 (14Dec07):
22-Dec-2007 15:33:43
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_15.33.05
Backup Level: Full
Client: localhost-fd
FileSet: "Full Set" 2007-12-22 15:33:21
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 15:33:38
End time: 22-Dec-2007 15:33:43
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: 1198355598
Last Volume Bytes: 135,560,075 (135.5 MB)
SD Errors: 0
SD termination status: OK
Termination: Migration OK
22-Dec 15:33 localhost-dir JobId 3: Begin pruning Jobs.
22-Dec 15:33 localhost-dir JobId 3: No Jobs found to prune.
22-Dec 15:33 localhost-dir JobId 3: Begin pruning Files.
22-Dec 15:33 localhost-dir JobId 3: No Files found to prune.
22-Dec 15:33 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 15:33:21 | M | F | 5484 |
66657204 | T |
| 5 | MigrationJobSave | 2007-12-22 15:33:21 | B | F | 5484 |
67563870 | T |
| 2 | MigrationJobSave | 2007-12-22 15:33:25 | M | F | 5484 |
66657204 | T |
| 6 | MigrationJobSave | 2007-12-22 15:33:25 | B | F | 5484 |
67563870 | T |
| 4 | migrate-job | 2007-12-22 15:33:32 | g | F | 0 | 0
| T |
| 3 | migrate-job | 2007-12-22 15:33:38 | 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 15:33:28 |
+---------+---------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+-----------+---------------------+
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
15:33:43 |
| 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 15:33 localhost-dir JobId 7: Start Backup JobId 7,
Job=MigrationJobSave.2007-12-22_15.33.09
22-Dec 15:33 localhost-dir JobId 7: Using Device "FileStorage"
22-Dec 15:33 localhost-sd JobId 7: Volume "FileVolume001" previously written,
moving to end of data.
22-Dec 15:33 localhost-sd JobId 7: Ready to append to end of Volume
"FileVolume001" size=135560063
22-Dec 15:33 localhost-sd JobId 7: Spooling data ...
22-Dec 15:33 localhost-sd JobId 7: Job write elapsed time = 00:00:01, Transfer
rate = 0 bytes/second
22-Dec 15:33 localhost-sd JobId 7: Committing spooled data to Volume
"FileVolume001". Despooling 430 bytes ...
22-Dec 15:33 localhost-sd JobId 7: Despooling elapsed time = 00:00:01, Transfer
rate = 430 bytes/second
22-Dec 15:33 localhost-sd JobId 7: Sending spooled attrs to the Director.
Despooling 0 bytes ...
22-Dec 15:33 localhost-dir JobId 7: Bacula localhost-dir 2.2.7 (14Dec07):
22-Dec-2007 15:33:47
Build OS: i686-pc-linux-gnu redhat
JobId: 7
Job: MigrationJobSave.2007-12-22_15.33.09
Backup Level: Incremental, since=2007-12-22 15:33:25
Client: "localhost-fd" 2.2.7 (14Dec07)
i686-pc-linux-gnu,redhat,
FileSet: "Full Set" 2007-12-22 15:33:21
Pool: "Default" (From Job resource)
Storage: "File" (From Pool resource)
Scheduled time: 22-Dec-2007 15:33:44
Start time: 22-Dec-2007 15:33:46
End time: 22-Dec-2007 15:33:47
Elapsed time: 1 sec
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: 1198355598
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 15:33 localhost-dir JobId 7: Begin pruning Jobs.
22-Dec 15:33 localhost-dir JobId 7: No Jobs found to prune.
22-Dec 15:33 localhost-dir JobId 7: Begin pruning Files.
22-Dec 15:33 localhost-dir JobId 7: No Files found to prune.
22-Dec 15:33 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 15:33:21 | M | F | 5484 |
66657204 | T |
| 5 | MigrationJobSave | 2007-12-22 15:33:21 | B | F | 5484 |
67563870 | T |
| 2 | MigrationJobSave | 2007-12-22 15:33:25 | M | F | 5484 |
66657204 | T |
| 6 | MigrationJobSave | 2007-12-22 15:33:25 | B | F | 5484 |
67563870 | T |
| 4 | migrate-job | 2007-12-22 15:33:32 | g | F | 0 | 0
| T |
| 3 | migrate-job | 2007-12-22 15:33:38 | g | F | 0 | 0
| T |
| 7 | MigrationJobSave | 2007-12-22 15:33:46 | 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 15:33:47 |
+---------+---------------+-----------+---------+-----------+----------+--------------+---------+------+-----------+-----------+---------------------+
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
15:33:43 |
| 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 15:33:25 | ChangerVolume001 |
| 7 | I | 0 | 0 | 2007-12-22 15:33:46 | 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!!! 15:34:13 !!!!!
!!!!! 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 03:34:17 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
