ADSM-L

Re: [ADSM-L] TSM DP for SQL - Some backups failed due to Session reject - TCPIP connection failure

2009-10-13 10:40:41
Subject: Re: [ADSM-L] TSM DP for SQL - Some backups failed due to Session reject - TCPIP connection failure
From: "Botelho, Tiago (External)" <Tiago.Botelho AT AUTOEUROPA DOT PT>
To: ADSM-L AT VM.MARIST DOT EDU
Date: Tue, 13 Oct 2009 15:39:18 +0100
[Botelho, Tiago (External)] 

Its a new TSM DP SQL Node.

The node has multiple instances running. Only some DB fail.




The current date is: 13-10-2009 
Enter the new date: (dd-mm-yy) The current time is: 15:35:34,47
Enter the new time: 
IBM Tivoli Storage Manager for Databases:
Data Protection for Microsoft SQL Server
Version 5, Release 5, Level 1.0
(C) Copyright IBM Corporation 1997, 2008. All rights reserved.

ACO5057I The C:\Progra~1\Tivoli\TSM\TDPSql\maximo\sqldiff.log log file
was pruned successfully.

Connecting to SQL Server, please wait...


Starting SQL database backup...

Connecting to TSM Server as node 'SQL_VWAEPASS00093_MAXIMO'...

Beginning difffull backup for database MaximoD, 1 of 4.
Full: 0   Read: 11781120  Written: 11781120  Rate: 11,159.07 Kb/Sec     
Full: 0   Read: 11784576  Written: 11784576  Rate: 7,482.69 Kb/Sec     

Backup of MaximoD completed successfully.

Beginning difffull backup for database MaximoP, 2 of 4.
Full: 0   Read: 89088  Written: 0  Rate: 0.00 Kb/Sec     
Full: 30  Read: 102760448  Written: 71303168  Rate: 34,150.07 Kb/Sec

Full: 30  Read: 186646528  Written: 155189248  Rate: 49,607.86 Kb/Sec

Full: 29  Read: 272906752  Written: 242221056  Rate: 58,104.64 Kb/Sec

Full: 30  Read: 358612992  Written: 327155712  Rate: 62,767.78 Kb/Sec

Full: 7   Read: 395719680  Written: 387973120  Rate: 62,050.44 Kb/Sec

Full: 6   Read: 449304576  Written: 441450496  Rate: 60,446.44 Kb/Sec

Full: 6   Read: 449304576  Written: 441450496  Rate: 52,909.18 Kb/Sec

Full: 6   Read: 451401728  Written: 443547648  Rate: 47,271.85 Kb/Sec

Full: 3   Read: 453512704  Written: 448790528  Rate: 43,056.49 Kb/Sec

Full: 3   Read: 453512704  Written: 448790528  Rate: 39,148.91 Kb/Sec

Full: 3   Read: 453512704  Written: 448790528  Rate: 35,894.51 Kb/Sec

Full: 3   Read: 453512704  Written: 448790528  Rate: 33,137.15 Kb/Sec


Waiting for TSM server.............
Full: 2   Read: 453533696  Written: 448790528  Rate: 17,234.45 Kb/Sec

Full: 4   Read: 462653440  Written: 458227712  Rate: 16,920.18 Kb/Sec

Full: 13  Read: 462653440  Written: 458227712  Rate: 16,823.49 Kb/Sec


Backup of MaximoP failed.
ANS1017E (RC-50)  Session rejected: TCP/IP connection failure

Beginning difffull backup for database model, 3 of 4.
Full: 0   Read: 11133184  Written: 11133184  Rate: 15,248.60 Kb/Sec     

Backup of model completed successfully.

Beginning difffull backup for database msdb, 4 of 4.
Full: 0   Read: 10774784  Written: 10774784  Rate: 14,737.04 Kb/Sec     

Backup of msdb completed successfully.


Total SQL backups selected:               5
Total SQL backups attempted:              4
Total SQL backups completed:              3
Total SQL backups excluded:               1

Throughput rate:                          16,239.85 Kb/Sec
Total bytes transferred:                  491,920,256
Elapsed processing time:                  29.58 Secs

ACO0151E Errors occurred while processing the request.



Errors:

10/13/2009 15:35:35 ============== Log file pruned using log retention
period of 60 day(s)
10/13/2009 15:35:35 ============== No log entries pruned
10/13/2009 15:35:35
========================================================================
=
10/13/2009 15:35:36
========================================================================
=
10/13/2009 15:35:36 Request                       : DIFF BACKUP
10/13/2009 15:35:36 Database Input List           : *
10/13/2009 15:35:36 Group Input List              : -
10/13/2009 15:35:36 File Input List               : -
10/13/2009 15:35:36 Number of Buffers             : 3
10/13/2009 15:35:36 Buffer Size                   : 1024
10/13/2009 15:35:36 Number of SQL Buffers         : 0
10/13/2009 15:35:36 SQL Buffer Size               : 1024
10/13/2009 15:35:36 Number of Stripes specified   : 10
10/13/2009 15:35:36 Estimate                      : 20
10/13/2009 15:35:36 Truncate Log?                 : -
10/13/2009 15:35:36 Wait for Tape Mounts?         : Yes
10/13/2009 15:35:36 TSM Options File              :
C:\Progra~1\Tivoli\TSM\TDPSql\maximo\dsm.opt
10/13/2009 15:35:36 TSM Nodename Override         : -
10/13/2009 15:35:36 Sqlserver                     : VWAEPASH00095\MAXIMO
10/13/2009 15:35:36   
10/13/2009 15:36:04 ACO5436E A failure occurred on stripe number (8), rc
= 418
10/13/2009 15:36:04 ANS1017E (RC-50)  Session rejected: TCP/IP
connection failure
10/13/2009 15:36:05 Backup of MaximoP failed.
10/13/2009 15:36:05 ANS1017E (RC-50)  Session rejected: TCP/IP
connection failure
10/13/2009 15:36:07 Total SQL backups selected:               5
10/13/2009 15:36:07 Total SQL backups attempted:              4
10/13/2009 15:36:07 Total SQL backups completed:              3
10/13/2009 15:36:07 Total SQL backups excluded:               1
10/13/2009 15:36:07 Throughput rate:                          16,239.85
Kb/Sec
10/13/2009 15:36:07 Total bytes transferred:
491,920,256
10/13/2009 15:36:07 Elapsed processing time:                  29.58 Secs
10/13/2009 15:36:07 ACO0151E Errors occurred while processing the
request.












Looks like the TDP client is unable to reach the TSM server.  There's
no illuminating info in the client logging, so you'll have to check
the TSM server Activity Log for any indications.  If nothing
illuminating there, you'll have to perform some client-server tests to
isolate the problem area.  If this started happening at a certain
time, and had been working before, site change control may identify
some firewall or similar configuration change affecting connectivity.

   Richard Sims