Question about duplication to tape

[MickBoosh]

Hi,

I am getting some 190 errors which upon closer inspection have been created as the images on the staging area have expired before it has duplicated to tape. I have always been under the impression that duplication to tape takes place quickly (the same day) after it's been backed up to disk and then once the watermark is hit on the staging area it is a candidate to be deleted from disk?

The backup for this particular policy was created 1 week ago, so it's not going to tape for a week, is that right? Our staging policy runs from midnight to 5pm daily so it should have enough time. Also all the problems are from the same policy, which does SQL transaction logs.

Is a week too long for it to be duplicated? Should it be quicker than this? 

[mph999]

If you are using DSSU, in the storage unit, you haveto create a window (very similar to a normal policy) that allows when the duplication can run.

Providing there is an 'open' window, the staging from disk to tape will hape reasonbly quickly.

Martin

[mph999]

OK, just re-read the post, seems you have a window.

Can you right click the stu and try manual relocation ?

Martin

[MickBoosh]

Its only started happening in the last 3 weeks or so though, and it's not all the time, we get maybe 1 or 2 a day so it's managing most from the policy but seems it's the odd one.

[mph999]

Is this policy using the same DSSU as others, or is the DSSU new also ?

You say its only the past 3 weeks, but previously mentioned the backup was created 1 week ago ...  I'm a bit confused.

Is this issue only affecting certain clients / backups ???

What version of NBU are you running ....

[Mark_Solutions]

Check the retention period set on the Default application schedule for you SQL policy just in case it is very short

Wouldnt generally expect anything to be expired from a DSSU before it has been duplicated, even in a disk full condition, so it sounds like a retention issue

[MickBoosh]

> Is this policy using the same DSSU as others, or is the DSSU new also 

Yes serveral policies use it, we've ahd the DSSU for years

> You say its only the past 3 weeks, but previously mentioned the backup was created 1 week ago ...  I'm a bit confused.

I mean the backup that created the particluar image that failed to duplicate ran 1 week ago, the problems in general started about 3 weeks ago

> Is this issue only affecting certain clients / backups 

Yes, one particular SQL Transaction Log policy

> What version of NBU are you running

7.1 on Windows 2003 r2 x86

> Check the retention period set on the Default application schedule for you SQL policy just in case it is very short

Thanks, the default application schedule is for 1 week where the Automatic Backup is for 2 weeks. I've now changed it to 2 weeks

> Wouldnt generally expect anything to be expired from a DSSU before it has been duplicated, even in a disk full condition, so it sounds like a retention issue

Me too.

Thanks for the help so far :)

[Mark_Solutions]

Ok - so we had a 1 week retention but you did say that the staging runs daily from midnight to 5pm - what is the frequency set to on the staging (very ? hours / days)?

[MickBoosh]

> Ok - so we had a 1 week retention but you did say that the staging runs daily from midnight to 5pm - what is the frequency set to on the staging (very ? hours / days)?

1 hour.

[Mark_Solutions]

Can you check the catalog to see if the images have actually been duplicated to tape or not.

Just do a search on the catalog for these SQL backups - this isolates if the duplication has actually kicked in twice and has been done once then fails next time

This could indicate that there is a bug or some other intervention causing it (such as a manual relocation being run)

Dont think we have covered it so what version and patch level of NetBackup are you on?

#edit# see you are on 7.1 - which patch level if any

#edit 2# could you post the details from the Admin log on the Master for a period just either side of the 190 failure

[MickBoosh]

> Just do a search on the catalog for these SQL backups - this isolates if the duplication has actually kicked in twice and has been done once then fails next time

Sorry, which type of report shall I run? Images on Media? Not sure how to "search on the catalog" 

Also, no patch levels, just 7.1 vanilla

Yes, give me a few minutes

Thanks

[Mark_Solutions]

In the NetBackup Admin Console go to the catalog section.

Do a search for this client - leaving the options as verify and primary copy

Look for any of the SQL Transaction log backups to see if any exist.

If they do, and they show as being on tape then it has duplicated them but for some reason tried again - if not then they have expired before being dulicated which is a fault

#edit# just make sure that the date range is enough to cover the backups and duplication when the error shows up

[Marianne]

Please remember that the Retention level selected in the schedule applies to Disk and Tape copy.

The only difference between disk and tape copy is that disk copy can be expired and deleted if successfully duplicated to tape and disk reaches High Water Mark.

[MickBoosh]

Obviously I've annonimised this as best I could, servers are AAAAA or BBBBBBB and master server is <masterserver!>

'' -ORBSvcConfDirective "static PBXIOP_Evaluator_Factory '-orb Default_DAEMON_Orb'" -ORBSvcConfDirective "static Resource_Factory '-ORBConnectionCacheMax 1024 '" -ORBEndpoint pbxiop://1556:NB_4048_922262515 -ORBSvcConf nul -ORBSvcConfDirective "static Server_Strategy_Factory '-ORBMaxRecvGIOPPayloadSize 268435456'"(../Orb.cpp:824)

16:09:42.624 [4048.8724] <2> Orb::init: caching EndpointSelectorFactory(../Orb.cpp:839)

16:09:42.718 [868.6080] <2> add_span_node: ADD SPANNED MEDIA F:\Dis

16:09:42.718 [868.6080] <2> find_or_add_affinity_node: Initial serverAffinityId: 1  mapping: 1

16:09:42.718 [868.6080] <2> add_span_node: ADD SPANNED MEDIA F:\Disk_Staging_Area

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Dis

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Disk_Staging_Area

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Dis

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Disk_Staging_Area

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Dis

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Disk_Staging_Area

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Dis

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Disk_Staging_Area

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Dis

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Disk_Staging_Area

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Dis

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Disk_Staging_Area

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Dis

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Disk_Staging_Area

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Dis

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Disk_Staging_Area

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Dis

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Disk_Staging_Area

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Dis

16:09:42.718 [868.6080] <2> add_to_worklist: TMP_SPAN_DELETE F:\Disk_Staging_Area

16:09:42.718 [868.6080] <2> db_end: Need to collect reply

16:09:42.718 [868.6080] <2> check_optimization: Checking to see if an optimized duplication or NDMP Direct Copy can be performed

16:09:42.718 [868.6080] <2> check_optimization: Optimized duplication will not be used - destination is not disk

16:09:42.718 [868.6080] <2> Orb::init: Created anon service name: NB_868_1021618932(../Orb.cpp:696)

16:09:42.718 [868.6080] <2> Orb::init: endpointvalue is : pbxiop://1556:NB_868_1021618932(../Orb.cpp:713)

16:09:42.718 [868.6080] <2> Orb::init: initializing ORB Default_DAEMON_Orb with: Unknown -ORBSvcConfDirective "-ORBDottedDecimalAddresses 0" -ORBSvcConfDirective "static PBXIOP_Factory '-enable_keepalive'" -ORBSvcConfDirective "static EndpointSelectorFactory ''" -ORBSvcConfDirective "static Resource_Factory '-ORBProtocolFactory PBXIOP_Factory'" -ORBSvcConfDirective "static Resource_Factory '-ORBProtocolFactory IIOP_Factory'" -ORBDefaultInitRef '' -ORBSvcConfDirective "static PBXIOP_Evaluator_Factory '-orb Default_DAEMON_Orb'" -ORBSvcConfDirective "static Resource_Factory '-ORBConnectionCacheMax 1024 '" -ORBEndpoint pbxiop://1556:NB_868_1021618932 -ORBSvcConf nul -ORBSvcConfDirective "static Server_Strategy_Factory '-ORBMaxRecvGIOPPayloadSize 268435456'"(../Orb.cpp:824)

16:09:42.718 [868.6080] <2> Orb::init: caching EndpointSelectorFactory(../Orb.cpp:839)

16:09:42.718 [5836.7608] <2> db_end: Need to collect reply

16:09:42.718 [5836.7608] <2> check_optimization: Checking to see if an optimized duplication or NDMP Direct Copy can be performed

16:09:42.718 [5836.7608] <2> check_optimization: Optimized duplication will not be used - destination is not disk

16:09:42.718 [5836.7608] <2> Orb::init: Created anon service name: NB_5836_995030791(../Orb.cpp:696)

16:09:42.718 [5836.7608] <2> Orb::init: endpointvalue is : pbxiop://1556:NB_5836_995030791(../Orb.cpp:713)

16:09:42.718 [5836.7608] <2> Orb::init: initializing ORB Default_DAEMON_Orb with: Unknown -ORBSvcConfDirective "-ORBDottedDecimalAddresses 0" -ORBSvcConfDirective "static PBXIOP_Factory '-enable_keepalive'" -ORBSvcConfDirective "static EndpointSelectorFactory ''" -ORBSvcConfDirective "static Resource_Factory '-ORBProtocolFactory PBXIOP_Factory'" -ORBSvcConfDirective "static Resource_Factory '-ORBProtocolFactory IIOP_Factory'" -ORBDefaultInitRef '' -ORBSvcConfDirective "static PBXIOP_Evaluator_Factory '-orb Default_DAEMON_Orb'" -ORBSvcConfDirective "static Resource_Factory '-ORBConnectionCacheMax 1024 '" -ORBEndpoint pbxiop://1556:NB_5836_995030791 -ORBSvcConf nul -ORBSvcConfDirective "static Server_Strategy_Factory '-ORBMaxRecvGIOPPayloadSize 268435456'"(../Orb.cpp:824)

16:09:42.733 [5836.7608] <2> Orb::init: caching EndpointSelectorFactory(../Orb.cpp:839)

16:09:42.764 [8940.9004] <4> add_to_worklist: Skipping backup id AAAAAAAAA_1326619678, copy 1 is expired.

16:09:42.796 [8940.9004] <4> add_to_worklist: Skipping backup id BBBBBBBBBBBB_1326619706, copy 1 is expired.

16:09:42.827 [8940.9004] <4> add_to_worklist: Skipping backup id AAAAAAAAAA_1326619752, copy 1 is expired.

16:09:42.827 [8940.9004] <4> add_to_worklist: Skipping backup id BBBBBBBBBBBB_1326619774, copy 1 is expired.

16:09:42.858 [8940.9004] <4> add_to_worklist: Skipping backup id AAAAAAAAAAA_1326619822, copy 1 is expired.

16:09:42.874 [8940.9004] <4> add_to_worklist: Skipping backup id BBBBBBBBBBBB_1326619847, copy 1 is expired.

16:09:42.905 [8940.9004] <4> add_to_worklist: Skipping backup id AAAAAAAAAAA_1326619891, copy 1 is expired.

16:09:42.921 [8940.9004] <4> add_to_worklist: Skipping backup id BBBBBBBBBBBB_1326619914, copy 1 is expired.

16:09:42.921 [5092.6444] <2> db_end: Need to collect reply

16:09:42.921 [5092.6444] <2> check_optimization: Checking to see if an optimized duplication or NDMP Direct Copy can be performed

16:09:42.921 [5092.6444] <2> check_optimization: Optimized duplication will not be used - destination is not disk

16:09:42.921 [8940.9004] <4> add_to_worklist: Skipping backup id stas89_1326619927, copy 1 is expired.

16:09:42.921 [5092.6444] <2> Orb::init: Created anon service name: NB_5092_544685312(../Orb.cpp:696)

16:09:42.921 [5092.6444] <2> Orb::init: endpointvalue is : pbxiop://1556:NB_5092_544685312(../Orb.cpp:713)

16:09:42.921 [5092.6444] <2> Orb::init: initializing ORB Default_DAEMON_Orb with: Unknown -ORBSvcConfDirective "-ORBDottedDecimalAddresses 0" -ORBSvcConfDirective "static PBXIOP_Factory '-enable_keepalive'" -ORBSvcConfDirective "static EndpointSelectorFactory ''" -ORBSvcConfDirective "static Resource_Factory '-ORBProtocolFactory PBXIOP_Factory'" -ORBSvcConfDirective "static Resource_Factory '-ORBProtocolFactory IIOP_Factory'" -ORBDefaultInitRef '' -ORBSvcConfDirective "static PBXIOP_Evaluator_Factory '-orb Default_DAEMON_Orb'" -ORBSvcConfDirective "static Resource_Factory '-ORBConnectionCacheMax 1024 '" -ORBEndpoint pbxiop://1556:NB_5092_544685312 -ORBSvcConf nul -ORBSvcConfDirective "static Server_Strategy_Factory '-ORBMaxRecvGIOPPayloadSize 268435456'"(../Orb.cpp:824)

16:09:42.936 [5092.6444] <2> Orb::init: caching EndpointSelectorFactory(../Orb.cpp:839)

16:09:42.936 [8940.9004] <4> add_to_worklist: Skipping backup id AAAAAAAAAAA_1326619940, copy 1 is expired.

16:09:42.936 [8940.9004] <4> add_to_worklist: Skipping backup id AAAAAAAAAAA_1326619980, copy 1 is expired.

16:09:42.952 [8940.9004] <4> add_to_worklist: Skipping backup id BBBBBBBBBBBB_1326619989, copy 1 is expired.

16:09:42.952 [8940.9004] <4> add_to_worklist: Skipping backup id AAAAAAAAAAA_1326620030, copy 1 is expired.

16:09:42.952 [8940.9004] <2> db_end: Need to collect reply

16:09:42.952 [8940.9004] <4> bpduplicate: found no images or media matching the selection criteria

16:09:42.952 [8940.9004] <2> bpduplicate: EXIT status = 190

16:09:42.968 [8940.9004] <2> job_monitoring_exex: ACK disconnect

16:09:42.968 [8940.9004] <2> job_disconnect: Disconnected

16:09:43.780 [472.4476] <2> db_end: Need to collect reply

16:09:43.780 [472.4476] <2> check_optimization: Checking to see if an optimized duplication or NDMP Direct Copy can be performed

16:09:43.780 [472.4476] <2> check_optimization: Optimized duplication will not be used - destination is not disk

16:09:43.780 [472.4476] <2> Orb::init: Created anon service name: NB_472_1350750152(../Orb.cpp:696)

16:09:43.780 [472.4476] <2> Orb::init: endpointvalue is : pbxiop://1556:NB_472_1350750152(../Orb.cpp:713)

16:09:43.780 [472.4476] <2> Orb::init: initializing ORB Default_DAEMON_Orb with: Unknown -ORBSvcConfDirective "-ORBDottedDecimalAddresses 0" -ORBSvcConfDirective "static PBXIOP_Factory '-enable_keepalive'" -ORBSvcConfDirective "static EndpointSelectorFactory ''" -ORBSvcConfDirective "static Resource_Factory '-ORBProtocolFactory PBXIOP_Factory'" -ORBSvcConfDirective "static Resource_Factory '-ORBProtocolFactory IIOP_Factory'" -ORBDefaultInitRef '' -ORBSvcConfDirective "static PBXIOP_Evaluator_Factory '-orb Default_DAEMON_Orb'" -ORBSvcConfDirective "static Resource_Factory '-ORBConnectionCacheMax 1024 '" -ORBEndpoint pbxiop://1556:NB_472_1350750152 -ORBSvcConf nul -ORBSvcConfDirective "static Server_Strategy_Factory '-ORBMaxRecvGIOPPayloadSize 268435456'"(../Orb.cpp:824)

16:09:43.780 [472.4476] <2> Orb::init: caching EndpointSelectorFactory(../Orb.cpp:839)

16:09:44.155 [5180.5424] <2> RequestInitialResources: returning

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: requestStatus is 0

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: allocationId : {B877AD14-3B85-4879-AE52-FA8997C28773}

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdr_AllocationKey : 1712818

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdr_TpReqFileName : 

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.mdar_MediaServer : <MASTERSERVER!>

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdar_MediaServerVersion : 710000

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.mdar_MediaServerClusterName : 

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdar_MediaKey : 4000050

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdar_MediaId : XXXXXXX

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdar_DriveKey : 2000101

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdar_DriveName : HP.ULTRIUM3-SCSI.003

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdar_PrimaryPath : {3,0,0,2}

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdar_PoolName : DataStore

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdar_NdmpControlHost : 

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdar_NdmpUserName : 

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdar_NdmpClientUserName : 

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdar_RetentionLevel : 3

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdar_PolicyType : 2

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdar_JobType : 9

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: results.mdar_MasterServer : <MASTERSERVER!>

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_STUName : <MASTERSERVER!>-STU-3Drives

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_MasterServer : <MASTERSERVER!>

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_STUType : 2

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_MediaServer : <MASTERSERVER!>

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_RobotType : 8

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_RobotNumber : 0

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_Density : 20

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_DriveGroupName : 

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_ConcurrentJobs : 4

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_ActiveJobs : 0

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_AbsolutePath : 

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_InitialMultiplexing : 0

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_OnDemandOnly : 0

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_MaxMultiplexing : 1

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_MaxFragmentSize : 10240

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_NdmpAttachHost : 

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_StuFlags : 0x0

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_StuSubtype : 1

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_Throttle : 0

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_HighWaterMark : 0

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_LowWaterMark : 0

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults:  results.sturec_OkOnRoot : 1

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: Bptm message : [MEDIADB 1 1712818 PJ4743 4000050 ------ 20 1327109344 1327220322 1329869998 0 261965205 44 44 3 2 0 0 1024 0 4093312 0]

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: Bptm message : [VOLUME 1 PJ4743 4000050 PJ4743L3 DataStore HP 2080484143 24 8 0 29 0 {00000000-0000-0000-0000-000000000000} 0]

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: Bptm message : [DRIVE 3 HP.ULTRIUM3-SCSI.003 2000101 HU10702M7N {3,0,0,2} -1 -1 -1 -1 -1 -1 -1 -1 *NULL* *NULL* *NULL* *NULL* 1 0 0 1 0 0]

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: Bptm message : [STORAGE 1 <MASTERSERVER!>-STU-3Drives 20 10240 2 1 0 0 <MASTERSERVER!> <MASTERSERVER!> *NULL*]

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: Bptm message : [DISKGROUP 0 6 *NULL* 6 *NULL* 6 *NULL*]

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: Bptm message : [DISKVOLUME 0 6 *NULL* 6 *NULL* 0]

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: Bptm message : [DISKMOUNTPOINT 0 6 *NULL*]

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: useFatPipeTransport is 0

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: diskPath is 

16:09:44.155 [5180.5424] <2> jmcomm_PrintStuResults: failureCode is 0

16:09:44.155 [5180.5424] <2> bpduplicate: Destination storage unit <MASTERSERVER!>-STU-3Drives on host <MASTERSERVER!>

16:09:44.155 [5180.5424] <2> db_fork_lock_dbm: Sending Q_IMAGE_FORK_LOCK_DBM

[MickBoosh]

That's what I thought happened thank you!

[MickBoosh]

If I do it from when it backed up on the 15/01/12 it returns a list and they all are still on staging, obviously it doesn't show the backup that caused the problem as it's now expired.

It also pops a box up when it's finished the search and says this

INF - Skipping backup id AAAAAAAA_1326713623, copy 1 is expired.

INF - Skipping backup id AAAAAAAA_1326713582, copy 1 is expired.

INF - Skipping backup id AAAAAAAA_1326713540, copy 1 is expired.

Here's a quick copy and paste from the search

AAAAAAAA_1326720738 16/01/2012 13:32:18 SQL_Backup_TransactionLogs Default-Application-Backup <master> F:\Disk_Staging_Area 1 Yes

AAAAAAAA_1326720785 16/01/2012 13:33:05 SQL_Backup_TransactionLogs Default-Application-Backup <master> F:\Disk_Staging_Area 1 Yes

AAAAAAAA_1326720825 16/01/2012 13:33:45 SQL_Backup_TransactionLogs Default-Application-Backup <master> F:\Disk_Staging_Area 1 Yes

AAAAAAAA_1326727939 16/01/2012 15:32:19 SQL_Backup_TransactionLogs Default-Application-Backup <master> F:\Disk_Staging_Area 1 Yes

[Mark_Solutions]

OK - another 4 questions:

1. It may just be how it has gone into the file but do these both exist?:

F:\Disk_Staging_Area
F:\Dis

2. All backups shown in the log relate to 15th Jan so have expired - can you see those image files in the staging area?

3. How oftern do you see the DSSU staging job actually run?

4. Do you allow disk spanning - how many disk units are involved?

[MickBoosh]

1. hmmm F:\Disk_Staging_Area I'm familiar with and it does exist, however f:\dis doesn't and we've never had anything called that

2. After searching through the staging area, I can't see them.

3. It's pretty much doing duplications all the time while

4. We don't allow disk spanning

#edit 2. I mean from 15th, they are present past this.

[Mark_Solutions]

To clarify 3. - how often do you see the policy named DSSU_diskstagingname in the activity monitor?

(substitue diskstagingname with the namke of your disk staging storage unit)

To clarify 1. Could you run bpstulist -U -M masterservername

out post the output please

[Mark_Solutions]

Just noticed your entry about the results from the catalog - so as well as my questions above could you do the same catalog search against Copy 2 rather than primary to see if they are also on tape.

Thanks