Hi,
27.06.2008 14:08, RA Cohen wrote:
> OK group, the problem has surfaced again:
>
> *stat dir
> fserv-dir Version: 2.2.8 (26 January 2008) i386-portbld-freebsd6.2
> freebsd 6.2-RELEASE-p8
> Daemon started 23-Jun-08 18:08, 22 Jobs run since started.
> Heap: heap=790,528 smbytes=66,208 max_bytes=101,460 bufs=358 max_bufs=361
>
> Scheduled Jobs:
> Level Type Pri Scheduled Name Volume
> ===================================================================================
> Full Backup 10 28-Jun-08 02:00 fservNightlySave
> Friday-0271
> Full Backup 10 28-Jun-08 02:00 mservNightlySave
> Friday-0271
> Full Backup 10 28-Jun-08 02:15 BackupCatalog
> Friday-0271
> ====
>
> Running Jobs:
> JobId Level Name Status
> ======================================================================
> 1922 Full fservNightlySave.2008-06-27_02.00.37 is waiting on
> Storage InternalQuantum
> 1923 Full mservNightlySave.2008-06-27_02.00.38 is waiting execution
> 1924 Full BackupCatalog.2008-06-27_02.15.40 is waiting execution
> ====
>
> Terminated Jobs:
> JobId Level Files Bytes Status Finished Name
> ====================================================================
> 1912 Full 37 332.2 M Cancel 23-Jun-08 18:19
> fservNightlySave
> 1913 Full 184,423 76.94 G OK 24-Jun-08 03:23
> fservNightlySave
> 1914 Full 10,076 3.322 G OK 24-Jun-08 03:28
> mservNightlySave
> 1915 Full 0 0 Cancel 24-Jun-08 08:48 BackupCatalog
> 1916 Full 184,615 76.97 G OK 25-Jun-08 02:23
> fservNightlySave
> 1917 Full 10,054 3.334 G OK 25-Jun-08 02:29
> mservNightlySave
> 1918 Full 1 174.7 M OK 25-Jun-08 02:30 BackupCatalog
> 1919 Full 184,707 76.98 G OK 26-Jun-08 03:27
> fservNightlySave
> 1920 Full 10,016 3.343 G OK 26-Jun-08 03:32
> mservNightlySave
> 1921 Full 1 198.9 M OK 26-Jun-08 03:34 BackupCatalog
>
> ====
> You have messages.
> *mess
> 27-Jun 02:00 fserv-dir JobId 1922: BeforeJob: run command
> "/usr/local/share/bacula/load bacula bacula"
> 27-Jun 02:00 fserv-dir JobId 1922: BeforeJob: Connecting to Director
> fserv:9101
> 27-Jun 02:00 fserv-dir JobId 1922: BeforeJob: 1000 OK: fserv-dir
> Version: 2.2.8 (26 January 2008)
> 27-Jun 02:00 fserv-dir JobId 1922: BeforeJob: Enter a period to cancel a
> command.
> 27-Jun 02:00 fserv-dir JobId 1922: BeforeJob: mount storage=InternalQuantum
> 27-Jun 02:00 fserv-dir JobId 1922: BeforeJob: Automatically selected
> Catalog: MyCatalog
> 27-Jun 02:00 fserv-dir JobId 1922: BeforeJob: Using Catalog "MyCatalog"
> 27-Jun 02:00 fserv-dir JobId 1922: BeforeJob: 3001 Mounted Volume:
> Thursday-0270
> 27-Jun 02:00 fserv-dir JobId 1922: BeforeJob: 3001 Device
> "InternalQuantum" (/dev/sa0) is mounted with Volume "Thursday-0270"
> 27-Jun 02:00 fserv-dir JobId 1922: BeforeJob: You have messages.
> 27-Jun 02:00 fserv-dir JobId 1922: BeforeJob: quit
> 27-Jun 02:00 fserv-dir JobId 1922: Start Backup JobId 1922,
> Job=fservNightlySave.2008-06-27_02.00.37
Well, I don't know what's wrong, but you could try to leave the run
befor job script out and test if it works then. Other than that, I
think we'd need some debug output from the SD to see why it gets into
this state.
Arno
>
> *sta sd=InternalQuantum
> Connecting to Storage daemon InternalQuantum at 10.150.8.240:9103
>
> fserv-sd Version: 2.2.8 (26 January 2008) i386-portbld-freebsd6.2
> freebsd 6.2-RELEASE-p8
> Daemon started 23-Jun-08 18:08, 11 Jobs run since started.
> Heap: heap=286,720 smbytes=86,416 max_bytes=223,257 bufs=105 max_bufs=123
> Sizes: boffset_t=8 size_t=4 int32_t=4 int64_t=8
>
> Running Jobs:
> Writing: Full Backup job fservNightlySave JobId=1922 Volume="Thursday-0270"
> pool="ThursdayPool" device="InternalQuantum" (/dev/sa0)
> spooling=0 despooling=0 despool_wait=0
> Files=0 Bytes=0 Bytes/sec=0
> FDSocket closed
> ====
>
> Jobs waiting to reserve a drive:
> 3610 JobId=1922 Volume max jobs exceeded on drive "InternalQuantum"
> (/dev/sa0).
> ====
>
> Terminated Jobs:
> JobId Level Files Bytes Status Finished Name
> ===================================================================
> 1912 Full 37 332.2 M Error 23-Jun-08 18:19
> fservNightlySave
> 1913 Full 184,423 76.97 G OK 24-Jun-08 03:21
> fservNightlySave
> 1914 Full 10,076 3.324 G OK 24-Jun-08 03:28
> mservNightlySave
> 1915 Full 0 0 Cancel 24-Jun-08 09:22 BackupCatalog
> 1916 Full 184,615 77.00 G OK 25-Jun-08 02:22
> fservNightlySave
> 1917 Full 10,054 3.335 G OK 25-Jun-08 02:28
> mservNightlySave
> 1918 Full 1 174.7 M OK 25-Jun-08 02:29 BackupCatalog
> 1919 Full 184,707 77.01 G OK 26-Jun-08 03:25
> fservNightlySave
> 1920 Full 10,016 3.344 G OK 26-Jun-08 03:32
> mservNightlySave
> 1921 Full 1 198.9 M OK 26-Jun-08 03:33 BackupCatalog
> ====
>
> Device status:
> Device "FileStorage" (/tmp) is not open.
> Device "InternalQuantum" (/dev/sa0) is mounted with:
> Volume: Thursday-0270
> Pool: WednesdayPool
> Media type: SDLT
> Total Bytes Read=129,024 Blocks Read=2 Bytes/block=64,512
> Positioned at File=0 Block=0
> ====
>
> In Use Volume status:
> Thursday-0270 on device "InternalQuantum" (/dev/sa0)
> Reader=0 writers=0 reserved=0 released=1
> ====
>
> ====
>
> list media
>
> Pool: ThursdayPool
> +---------+---------------+-----------+---------+----------------+----------+--------------+---------+------+-----------+-----------+---------------------+
> | MediaId | VolumeName | VolStatus | Enabled | VolBytes |
> VolFiles | VolRetention | Recycle | Slot | InChanger | MediaType |
> LastWritten |
> +---------+---------------+-----------+---------+----------------+----------+--------------+---------+------+-----------+-----------+---------------------+
> | 270 | Thursday-0270 | Recycle | 1 | 80,494,718,976 |
> 82 | 432,000 | 1 | 0 | 0 | SDLT | 2008-06-20
> 09:58:09 |
> +---------+---------------+-----------+---------+----------------+----------+--------------+---------+------+-----------+-----------+---------------------+
>
> *updat
> Update choice:
> 1: Volume parameters
> 2: Pool from resource
> 3: Slots from autochanger
> Choose catalog item to update (1-3): 1
> Parameters to modify:
> 1: Volume Status
> 2: Volume Retention Period
> 3: Volume Use Duration
> 4: Maximum Volume Jobs
> 5: Maximum Volume Files
> 6: Maximum Volume Bytes
> 7: Recycle Flag
> 8: Slot
> 9: InChanger Flag
> 10: Volume Files
> 11: Pool
> 12: Volume from Pool
> 13: All Volumes from Pool
> 14: Enabled
> 15: RecyclePool
> 16: Done
> Select parameter to modify (1-16): 4
> Defined Pools:
> 1: Default
> 2: MondayPool
> 3: TuesdayPool
> 4: WednesdayPool
> 5: ThursdayPool
> 6: FridayPool
> 7: OldTapes
> 8: First160-320s
> Select the Pool (1-8): 5
> +---------+---------------+-----------+---------+----------------+----------+--------------+---------+------+-----------+-----------+---------------------+
> | MediaId | VolumeName | VolStatus | Enabled | VolBytes |
> VolFiles | VolRetention | Recycle | Slot | InChanger | MediaType |
> LastWritten |
> +---------+---------------+-----------+---------+----------------+----------+--------------+---------+------+-----------+-----------+---------------------+
> | 270 | Thursday-0270 | Recycle | 1 | 80,494,718,976 |
> 82 | 432,000 | 1 | 0 | 0 | SDLT | 2008-06-20
> 09:58:09 |
> +---------+---------------+-----------+---------+----------------+----------+--------------+---------+------+-----------+-----------+---------------------+
> Enter MediaId or Volume name: 270
> Updating Volume "Thursday-0270"
> Current max jobs is: 3
>
>
> When I change the max jobs to 4 (even though there are only three jobs)
> and mount the drive, the jobs run as advertised. So I think I've
> narrowed down the issue a little bit...
>
--
Arno Lehmann
IT-Service Lehmann
www.its-lehmann.de
-------------------------------------------------------------------------
Check out the new SourceForge.net Marketplace.
It's the best place to buy or sell services for
just about anything Open Source.
http://sourceforge.net/services/buy/index.php
_______________________________________________
Bacula-users mailing list
Bacula-users AT lists.sourceforge DOT net
https://lists.sourceforge.net/lists/listinfo/bacula-users
|