Bacula-users

Re: [Bacula-users] Issues With Quantum 160/320 SDLT - HP/Compaq Proliant G3

2008-06-29 18:41:24
Subject: Re: [Bacula-users] Issues With Quantum 160/320 SDLT - HP/Compaq Proliant G3
From: Arno Lehmann <al AT its-lehmann DOT de>
To: bacula-users AT lists.sourceforge DOT net
Date: Mon, 30 Jun 2008 00:40:29 +0200
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