sql backups are partially successful
Hi to all. I have an sql backup that partially succeeds (ends with status 1) . in the details of the job I can see a list of all the failed databases: 07/27/2016 12:19:21 - Info dbclient (pid=3868) INF - The following object(s) were not backed up successfully. 07/27/2016 12:19:21 - Info dbclient (pid=3868) INF - master 07/27/2016 12:19:21 - Info dbclient (pid=3868) INF - msdb 07/27/2016 12:19:21 - Info dbclient (pid=3868) INF - Profile_DB 07/27/2016 12:19:21 - Info dbclient (pid=3868) INF - Search_Service_Application_Hadassah_AnalyticsReportingStoreDB_d50fa820052f4ff58334c0d040c05852 07/27/2016 12:19:21 - Info dbclient (pid=3868) INF - Search_Service_Application_Hadassah_CrawlStoreDB_37844f58039d4b858632d9ef2ff5d471 07/27/2016 12:19:21 - Info dbclient (pid=3868) INF - Search_Service_Application_Hadassah_DB_9b4682c331a14d469030bcc49c13872f 07/27/2016 12:19:22 - Info dbclient (pid=3868) INF - Search_Service_Application_Hadassah_LinksStoreDB_12cf8a58253a4fac82e74c9347d96efe 07/27/2016 12:19:22 - Info dbclient (pid=3868) INF - Social_DB 07/27/2016 12:19:22 - Info dbclient (pid=3868) INF - Sync_DB 07/27/2016 12:19:22 - Info dbclient (pid=3868) INF - WSS_Logging which makes sense since they are all in simple recovery mode, however the database I am interested in is not listed as a failed database backup. I actually noticed I have a failed backup because the disk was getting full which led me to check the sql logs: 07/25/2016 12:06:58,Backup,Unknown,BACKUP failed to complete the command BACKUP LOG Mysite101. Check the backup application log for detailed messages. I checked the mssql_backup_failures logs and found the error: INFO The api was waiting and the timeout interval had elapsed. so I increased the VDI timeout and since I have stopped getting any errors regarding the database in the mssql_backup_failures logs, but the backup keeps failing. I moved on to check the dbclient logs: 11:39:17.992 [1260.4416] <4> CDBbackrec::ProcessAvailabilityGroupBackup: INF - Database <Mysite101> is not participating in an availability group. 11:39:17.992 [1260.4416] <4> DBConnect: INF - Logging into SQL Server with DSN <NBMSSQL_1260_1956_11>, SQL userid <sa> handle <0x020b4290>. 11:39:17.996 [1260.4416] <4> DBDisconnect: INF - Logging out of SQL Server with handle <0x020b4290> 11:39:17.996 [1260.4416] <4> DBConnect: INF - Logging into SQL Server with DSN <NBMSSQL_1260_1956_11>, SQL userid <sa> handle <0x020b4290>. 11:39:18.000 [1260.4416] <4> DBDisconnect: INF - Logging out of SQL Server with handle <0x020b4290> 11:39:18.000 [1260.4416] <4> DBConnect: INF - Logging into SQL Server with DSN <NBMSSQL_1260_1956_11>, SQL userid <sa> handle <0x020b4290>. 11:39:18.004 [1260.4416] <4> DBDisconnect: INF - Logging out of SQL Server with handle <0x020b4290> 11:39:18.004 [1260.4416] <4> DBConnect: INF - Logging into SQL Server with DSN <NBMSSQL_1260_1956_11>, SQL userid <sa> handle <0x020b4290>. 11:39:18.008 [1260.4416] <4> DBDisconnect: INF - Logging out of SQL Server with handle <0x020b4290> 11:39:18.008 [1260.4416] <4> Dbbackrec::PerformNBOperation: INF - BACKUP STARTED USING Microsoft SQL Server 2014 - 12.0.2000.8 (X64) Feb 20 2014 20:04:26 Copyright (c) Microsoft Corporation Enterprise Edition (64-bit) on Windows NT 6.3 <X64> (Build 9600: ) (Hypervisor) Batch = C:\Program Files\Veritas\NetBackup\DbExt\MsSql\transaction.bch, Op# = 5 11:39:18.024 [1260.4416] <2> vnet_pbxConnect: pbxConnectEx Succeeded 11:39:18.024 [1260.4416] <2> logconnections: BPRD CONNECT FROM 192.168.6.130.60460 TO 132.64.227.44.1556 fd = 1060 11:39:18.104 [1260.4416] <4> InitPipeInfo: INF - Using backup image SP13-DB.MSSQL7.SP13-DB.trx.Mysite101.~.7.001of001.20160727113916..C 11:39:18.118 [1260.4416] <2> vnet_pbxConnect: pbxConnectEx Succeeded 11:39:18.118 [1260.4416] <2> logconnections: BPRD CONNECT FROM 192.168.6.130.60461 TO 132.64.227.44.1556 fd = 1060 11:39:18.210 [1260.4416] <4> Dbbackrec::CreateSQLcmdSyntax: INF - backup log "Mysite101" to VIRTUAL_DEVICE='VNBU0-1260-4416-1469608758' with stats = 10, blocksize = 65536, maxtransfersize = 4194304, buffercount = 2 11:39:18.214 [1260.4416] <2> vnet_pbxConnect: pbxConnectEx Succeeded 11:39:18.214 [1260.4416] <2> logconnections: BPRD CONNECT FROM 192.168.6.130.60462 TO 132.64.227.44.1556 fd = 1208 11:39:18.230 [1260.1848] <2> vnet_pbxConnect: pbxConnectEx Succeeded 11:39:18.230 [1260.1848] <2> logconnections: BPRD CONNECT FROM 192.168.6.130.60463 TO 132.64.227.44.1556 fd = 1160 11:39:18.325 [1260.4416] <4> Dbbackrec::CreateSQLcmdSyntax: INF - Number of stripes: 1, Number of buffers per stripe 2. 11:39:18.375 [1260.1848] <4> DBthreads::dbclient: INF - Instance\Database is <MSSQLSERVER\Mysite101> 11:39:18.389 [1260.4416] <2> vnet_pbxConnect: pbxConnectEx Succeeded 11:39:18.389 [1260.4416] <2> logconnections: BPRD CONNECT FROM 192.168.6.130.60464 TO 132.64.227.44.1556 fd = 1208 11:39:18.502 [1260.4416] <4> DBConnect: INF - Logging into SQL Server with DSN <NBMSSQL_1260_1956_11>, SQL userid <sa> handle <0x00bde640>. 11:39:18.508 [1260.4416] <4> CDBbackrec::InitDeviceSet(): INF - Created VDI object for SQL Server instance <SP13-DB>. Connection timeout is <300> seconds. 11:39:18.513 [1260.4416] <2> vnet_pbxConnect: pbxConnectEx Succeeded 11:39:18.513 [1260.4416] <2> logconnections: BPRD CONNECT FROM 192.168.6.130.60465 TO 132.64.227.44.1556 fd = 1276 11:39:18.682 [1260.1848] <2> vnet_pbxConnect: pbxConnectEx Succeeded 11:39:18.682 [1260.1848] <2> logconnections: BPRD CONNECT FROM 192.168.6.130.60466 TO 132.64.227.44.1556 fd = 1056 11:39:26.738 [1260.1848] <4> serverResponse: Not a candidate for alternate buffer method: shared memory is not in use. 11:39:33.794 [1260.3644] <4> DBConnect: INF - Logging into SQL Server with DSN <NBMSSQL_1260_1956_11>, SQL userid <sa> handle <0x020b53c0>. 11:39:33.799 [1260.3644] <2> CDBbackcat::GetBackupWaitTimeFromCfg: DBG - Using a backup wait timeout from the BSA environment variable NBBSA_CLIENT_READ_TIMEOUT 11:39:33.799 [1260.3644] <2> CDBbackcat::GetSysBackupTime: DBG - Waiting for SQL Server to update it's backup history for up to 3600 second(s) 11:39:34.815 [1260.3644] <2> CDBbackcat::GetSysBackupTime: DBG - Succeeded in getting the backup timestamps from SQL Server after 1 retry(ies) 11:39:34.815 [1260.3644] <4> DBDisconnect: INF - Logging out of SQL Server with handle <0x020b53c0> 11:39:34.816 [1260.4416] <8> CODBCaccess::LogODBCerr: WARN - ODBC return code <1>, SQL State <01000>, SQL Message <3211><[Microsoft][SQL Server Native Client 11.0][SQL Server]100 percent processed.>. 11:39:34.816 [1260.4416] <8> CODBCaccess::LogODBCerr: WARN - SQL Message <4035><[Microsoft][SQL Server Native Client 11.0][SQL Server]Processed 10 pages for database 'Mysite101', file 'Mysite101_log' on file 1.> 11:39:34.816 [1260.4416] <8> CODBCaccess::LogODBCerr: WARN - SQL Message <3014><[Microsoft][SQL Server Native Client 11.0][SQL Server]BACKUP LOG successfully processed 10 pages in 0.006 seconds (11.881 MB/sec).> 11:39:34.816 [1260.1848] <4> DBthreads::dbclient: INF - Thread has been closed for stripe #0 11:39:34.832 [1260.1848] <2> vnet_pbxConnect: pbxConnectEx Succeeded 11:39:34.832 [1260.1848] <2> logconnections: BPRD CONNECT FROM 192.168.6.130.60483 TO 132.64.227.44.1556 fd = 1212 11:39:34.909 [1260.1848] <4> DBConnect: INF - Logging into SQL Server with DSN <NBMSSQL_1260_1956_11>, SQL userid <sa> handle <0x020b4290>. 11:39:34.914 [1260.1848] <4> DBDisconnect: INF - Logging out of SQL Server with handle <0x020b4290> 11:39:34.914 [1260.1848] <4> DBConnect: INF - Logging into SQL Server with DSN <NBMSSQL_1260_1956_11>, SQL userid <sa> handle <0x020b4290>. 11:39:34.919 [1260.1848] <4> DBDisconnect: INF - Logging out of SQL Server with handle <0x020b4290> 11:39:34.919 [1260.1848] <4> DBConnect: INF - Logging into SQL Server with DSN <NBMSSQL_1260_1956_11>, SQL userid <sa> handle <0x020b4290>. 11:39:34.923 [1260.1848] <4> DBConnect: INF - Logging into SQL Server with DSN <NBMSSQL_1260_1956_11>, SQL userid <sa> handle <0x020b5a10>. 11:39:34.929 [1260.1848] <4> DBDisconnect: INF - Logging out of SQL Server with handle <0x020b5a10> 11:39:34.931 [1260.1848] <4> DBDisconnect: INF - Logging out of SQL Server with handle <0x020b4290> 11:39:40.047 [1260.4416] <4> DBDisconnect: INF - Logging out of SQL Server with handle <0x00bde640> 11:39:40.047 [1260.4416] <4> Dbbackrec::Perform: INF - OPERATION #5 of batch C:\Program Files\Veritas\NetBackup\DbExt\MsSql\transaction.bch SUCCEEDED with STATUS 0 (0 is normal). Elapsed time = 24(1) seconds I can't figure out what the problem is and was hoping for help. my client, master and media servers are all version 7.7.21.3KViews0likes2Comments