cancel
Showing results for 
Search instead for 
Did you mean: 

MSSQL 2008 server suddenly stopped backing up

aleks_rov
Level 2

MSSQL 2008 server suddenly stopped backing up. There are two database, they back up in the same (14:00) time, backup first database was successful, second no. After that moment both database have not backed up, in bpcd I didn't fount anything useful. where to find the problem?

3 REPLIES 3

AndrewHarris
Level 3
Employee

I am assuming the backup job failed? What error was in the job log? What happens ( errors, etc.) when future instances of the job run?

Yes, job failed. Backup up at 15:00 was partitialy successful, first DB backed up, second no. Further (at 16:00, 17:00 etc), both DB didn't back up. I tried reinstall client, it didn't help. On all other servers everything is normal (including those in which the same policy), the error only on one client. I tried bpclntcmd, clent saw master and master saw client.

02.11.2016 22:55:22 - Info dbclient (pid=4524) INF - BACKUP STARTED USING
02.11.2016 22:55:22 - Info dbclient (pid=4524) Microsoft SQL Server 2008 R2 (SP3) - 10.50.6220.0 (X64)
02.11.2016 22:55:22 - Info dbclient (pid=4524) Mar 19 2015 12:32:14
02.11.2016 22:55:22 - Info dbclient (pid=4524) Copyright (c) Microsoft Corporation
02.11.2016 22:55:22 - Info dbclient (pid=4524) Standard Edition (64-bit) on Windows NT 6.2 <X64> (Build 9200: )
02.11.2016 22:55:22 - Info dbclient (pid=4524) Batch = C:\Program Files\Veritas\NetBackup\dbext\mssql\temp\SQL_Differential_Backup[0].bch1478105534[0].bch, Op# = 1
02.11.2016 22:55:23 - Info dbclient (pid=4524) INF - Using backup image Server.MSSQL7.Server.inc.WFSYSTEM.~.7.001of001.20161102235520..C
02.11.2016 22:55:25 - Info dbclient (pid=4524) INF - backup database "WFSYSTEM" to VIRTUAL_DEVICE='VNBU0-4524-5784-1478105722' with  stats = 10, blocksize = 65536, maxtransfersize = 4194304, buffercount = 2, differential
02.11.2016 22:55:26 - Info dbclient (pid=4524) INF - Number of stripes: 1, Number of buffers per stripe 2.
02.11.2016 22:55:27 - Info dbclient (pid=4524) INF - Created VDI object for SQL Server instance <Server>. Connection timeout is <300> seconds.
02.11.2016 23:10:47 - Info dbclient (pid=4524) ERR - Error in VxBSACreateObject: 3.
02.11.2016 23:10:49 - Info dbclient (pid=4524)     CONTINUATION: - System detected error, operation aborted.
02.11.2016 23:10:50 - Info dbclient (pid=4524) ERR - Error in GetCommand: 0x80770004.
02.11.2016 23:10:51 - Info dbclient (pid=4524) DBMS MSG - ODBC return code <-1>, SQL State <37000>, SQL Message< 3202><[Microsoft][SQL Server Native Client 10.0][SQL Server]Write on "VNBU0-4524-5784-1478105722" failed: 995(Операция ввода/вывода была прервана из-за завершения потока команд или по запросу приложения.)>.
02.11.2016 23:10:51 - Info dbclient (pid=4524)     CONTINUATION: - An abort request is preventing anything except termination actions.
02.11.2016 23:10:52 - Info dbclient (pid=4524) DBMS MSG - SQL Message <3271><[Microsoft][SQL Server Native Client 10.0][SQL Server]A nonrecoverable I/O error occurred on file "VNBU0-4524-5784-1478105722:" 995(Операция ввода/вывода была прервана из-за завершения потока команд или по запросу приложения.).>
02.11.2016 23:10:53 - Info dbclient (pid=4524) DBMS MSG - SQL Message <3013><[Microsoft][SQL Server Native Client 10.0][SQL Server]BACKUP DATABASE is terminating abnormally.>
02.11.2016 23:10:54 - Info dbclient (pid=4524) ERR - Error found executing <backup database "WFSYSTEM" to VIRTUAL_DEVICE='VNBU0-4524-5784-1478105722' with  stats = 10, blocksize = 65536, maxtransfersize = 4194304, buffercount = 2, differential>.
02.11.2016 23:15:59 - Info dbclient (pid=4524) ERR - Internal error. See the dbclient log for more information.
02.11.2016 23:16:00 - Info dbclient (pid=4524) INF - OPERATION #1 of batch C:\Program Files\Veritas\NetBackup\dbext\mssql\temp\SQL_Differential_Backup[0].bch1478105534[0].bch FAILED with STATUS 1 (0 is normal). Elapsed time = 1239(1239) seconds.
02.11.2016 23:16:05 - Info dbclient (pid=4524) INF - BACKUP STARTED USING
02.11.2016 23:16:05 - Info dbclient (pid=4524) Microsoft SQL Server 2008 R2 (SP3) - 10.50.6220.0 (X64)
02.11.2016 23:16:05 - Info dbclient (pid=4524) Mar 19 2015 12:32:14
02.11.2016 23:16:05 - Info dbclient (pid=4524) Copyright (c) Microsoft Corporation
02.11.2016 23:16:05 - Info dbclient (pid=4524) Standard Edition (64-bit) on Windows NT 6.2 <X64> (Build 9200: )
02.11.2016 23:16:05 - Info dbclient (pid=4524) Batch = C:\Program Files\Veritas\NetBackup\dbext\mssql\temp\SQL_Differential_Backup[0].bch1478105534[0].bch, Op# = 2
02.11.2016 23:16:06 - Info dbclient (pid=4524) INF - Using backup image Server.MSSQL7.Server.inc.СПОНИ.~.7.001of001.20161103001602..C
02.11.2016 23:16:07 - Info dbclient (pid=4524) INF - backup database "СПОНИ" to VIRTUAL_DEVICE='VNBU0-4524-8152-1478106965' with  stats = 10, blocksize = 65536, maxtransfersize = 4194304, buffercount = 2, differential
02.11.2016 23:16:08 - Info dbclient (pid=4524) INF - Number of stripes: 1, Number of buffers per stripe 2.
02.11.2016 23:16:09 - Info dbclient (pid=4524) INF - Created VDI object for SQL Server instance <Server>. Connection timeout is <300> seconds.
02.11.2016 23:31:26 - Info dbclient (pid=4524) ERR - Error in VxBSACreateObject: 3.
02.11.2016 23:31:27 - Info dbclient (pid=4524)     CONTINUATION: - System detected error, operation aborted.
02.11.2016 23:31:29 - Info dbclient (pid=4524) ERR - Error in GetCommand: 0x80770004.
02.11.2016 23:31:29 - Info dbclient (pid=4524) DBMS MSG - ODBC return code <-1>, SQL State <37000>, SQL Message< 3202><[Microsoft][SQL Server Native Client 10.0][SQL Server]Write on "VNBU0-4524-8152-1478106965" failed: 995(Операция ввода/вывода была прервана из-за завершения потока команд или по запросу приложения.)>.
02.11.2016 23:31:30 - Info dbclient (pid=4524)     CONTINUATION: - An abort request is preventing anything except termination actions.
02.11.2016 23:31:30 - Info dbclient (pid=4524) DBMS MSG - SQL Message <3271><[Microsoft][SQL Server Native Client 10.0][SQL Server]A nonrecoverable I/O error occurred on file "VNBU0-4524-8152-1478106965:" 995(Операция ввода/вывода была прервана из-за завершения потока команд или по запросу приложения.).>
02.11.2016 23:31:32 - Info dbclient (pid=4524) DBMS MSG - SQL Message <3013><[Microsoft][SQL Server Native Client 10.0][SQL Server]BACKUP DATABASE is terminating abnormally.>
02.11.2016 23:31:33 - Info dbclient (pid=4524) ERR - Error found executing <backup database "СПОНИ" to VIRTUAL_DEVICE='VNBU0-4524-8152-1478106965' with  stats = 10, blocksize = 65536, maxtransfersize = 4194304, buffercount = 2, differential>.
02.11.2016 23:36:38 - Info dbclient (pid=4524) ERR - Internal error. See the dbclient log for more information.
02.11.2016 23:36:39 - Info dbclient (pid=4524) INF - OPERATION #2 of batch C:\Program Files\Veritas\NetBackup\dbext\mssql\temp\SQL_Differential_Backup[0].bch1478105534[0].bch FAILED with STATUS 1 (0 is normal). Elapsed time = 1236(1236) seconds.
02.11.2016 23:36:42 - Info dbclient (pid=4524) INF - Results of executing <C:\Program Files\Veritas\NetBackup\dbext\mssql\temp\SQL_Differential_Backup[0].bch1478105534[0].bch>:
02.11.2016 23:36:42 - Info dbclient (pid=4524) <0> operations succeeded. <2> operations failed.
02.11.2016 23:36:44 - Info dbclient (pid=4524) INF - The failed backups in this script will be retried automatically in 180 seconds.


02.11.2016 22:15:46 - Info nbjm (pid=4356) starting backup job (jobid=41226) for client Server, policy SQL_Differential_Day_SPONI, schedule Differential
02.11.2016 22:15:46 - Info nbjm (pid=4356) requesting MEDIA_SERVER_WITH_ATTRIBUTES resources from RB for backup job (jobid=41226, request id:{5A95F308-680C-44FD-9725-1FF330CACFB4})
02.11.2016 22:15:46 - requesting resource IBM_HP_sys-003_LB
02.11.2016 22:15:46 - requesting resource Master.NBU_CLIENT.MAXJOBS.Server
02.11.2016 22:15:46 - requesting resource Master.NBU_POLICY.MAXJOBS.SQL_Differential_Day_SPONI
02.11.2016 22:15:46 - granted resource  Master.NBU_CLIENT.MAXJOBS.Server
02.11.2016 22:15:46 - granted resource  Master.NBU_POLICY.MAXJOBS.SQL_Differential_Day_SPONI
02.11.2016 22:15:46 - granted resource  Master_HP
02.11.2016 22:15:48 - estimated 0 kbytes needed
02.11.2016 22:15:48 - Info nbjm (pid=4356) started backup (backupid=Server_1478103346) job for client Server, policy SQL_Differential_Day_SPONI, schedule Differential on storage unit Master_HP
02.11.2016 22:15:48 - started process bpbrm (pid=6228)
02.11.2016 22:15:50 - Info bpbrm (pid=6228) Server is the host to backup data from
02.11.2016 22:15:50 - Info bpbrm (pid=6228) reading file list for client
02.11.2016 22:15:51 - connecting
02.11.2016 22:15:54 - Info bpbrm (pid=6228) starting bphdb on client
02.11.2016 22:15:54 - Info bphdb (pid=2792) Backup started
02.11.2016 22:15:54 - connected; connect time: 0:00:00
02.11.2016 22:15:57 - Info dbclient (pid=8896) INF - NUMRETRIES, RETRYTYPE, RETRYWAITSECONDS are ignored if they provided after the first operation in the batch file. However, the values provided for the first operation apply to all of the operations in the batch.
02.11.2016 22:15:58 - Info dbclient (pid=8896) WARN - NUMRETRIES, RETRYTYPE, RETRYWAITSECONDS are ignored if they provided after the first operation in the batch file. However, the values provided for the first operation apply to all of the operations in the batch.
02.11.2016 22:16:01 - Info dbclient (pid=8896) INF - BACKUP STARTED USING
02.11.2016 22:16:01 - Info dbclient (pid=8896) Microsoft SQL Server 2008 R2 (SP3) - 10.50.6220.0 (X64)
02.11.2016 22:16:01 - Info dbclient (pid=8896) Mar 19 2015 12:32:14
02.11.2016 22:16:01 - Info dbclient (pid=8896) Copyright (c) Microsoft Corporation
02.11.2016 22:16:01 - Info dbclient (pid=8896) Standard Edition (64-bit) on Windows NT 6.2 <X64> (Build 9200: )
02.11.2016 22:16:01 - Info dbclient (pid=8896) Batch = C:\Program Files\VERITAS\NetBackup\dbext\MSSql\SQL_Differential_Backup.bch, Op# = 1
02.11.2016 22:16:02 - Info dbclient (pid=8896) INF - Using backup image Server.MSSQL7.Server.inc.WFSYSTEM.~.7.001of001.20161102231558..C
02.11.2016 22:16:04 - Info dbclient (pid=8896) INF - backup database "WFSYSTEM" to VIRTUAL_DEVICE='VNBU0-8896-8932-1478103361' with  stats = 10, blocksize = 65536, maxtransfersize = 4194304, buffercount = 2, differential
02.11.2016 22:16:05 - Info dbclient (pid=8896) INF - Number of stripes: 1, Number of buffers per stripe 2.
02.11.2016 22:16:06 - Info dbclient (pid=8896) INF - Created VDI object for SQL Server instance <Server>. Connection timeout is <300> seconds.
02.11.2016 22:31:26 - Info dbclient (pid=8896) ERR - Error in VxBSACreateObject: 3.
02.11.2016 22:31:27 - Info dbclient (pid=8896)     CONTINUATION: - System detected error, operation aborted.
02.11.2016 22:31:29 - Info dbclient (pid=8896) ERR - Error in GetCommand: 0x80770004.
02.11.2016 22:31:29 - Info dbclient (pid=8896) DBMS MSG - ODBC return code <-1>, SQL State <37000>, SQL Message< 3202><[Microsoft][SQL Server Native Client 10.0][SQL Server]Write on "VNBU0-8896-8932-1478103361" failed: 995(Операция ввода/вывода была прервана из-за завершения потока команд или по запросу приложения.)>.
02.11.2016 22:31:30 - Info dbclient (pid=8896)     CONTINUATION: - An abort request is preventing anything except termination actions.
02.11.2016 22:31:31 - Info dbclient (pid=8896) DBMS MSG - SQL Message <3271><[Microsoft][SQL Server Native Client 10.0][SQL Server]A nonrecoverable I/O error occurred on file "VNBU0-8896-8932-1478103361:" 995(Операция ввода/вывода была прервана из-за завершения потока команд или по запросу приложения.).>
02.11.2016 22:31:32 - Info dbclient (pid=8896) DBMS MSG - SQL Message <3013><[Microsoft][SQL Server Native Client 10.0][SQL Server]BACKUP DATABASE is terminating abnormally.>
02.11.2016 22:31:33 - Info dbclient (pid=8896) ERR - Error found executing <backup database "WFSYSTEM" to VIRTUAL_DEVICE='VNBU0-8896-8932-1478103361' with  stats = 10, blocksize = 65536, maxtransfersize = 4194304, buffercount = 2, differential>.
02.11.2016 22:36:37 - Info dbclient (pid=8896) ERR - Internal error. See the dbclient log for more information.
02.11.2016 22:36:38 - Info dbclient (pid=8896) INF - OPERATION #1 of batch C:\Program Files\VERITAS\NetBackup\dbext\MSSql\SQL_Differential_Backup.bch FAILED with STATUS 1 (0 is normal). Elapsed time = 1239(1239) seconds.
02.11.2016 22:36:42 - Info dbclient (pid=8896) INF - BACKUP STARTED USING
02.11.2016 22:36:42 - Info dbclient (pid=8896) Microsoft SQL Server 2008 R2 (SP3) - 10.50.6220.0 (X64)
02.11.2016 22:36:42 - Info dbclient (pid=8896) Mar 19 2015 12:32:14
02.11.2016 22:36:42 - Info dbclient (pid=8896) Copyright (c) Microsoft Corporation
02.11.2016 22:36:42 - Info dbclient (pid=8896) Standard Edition (64-bit) on Windows NT 6.2 <X64> (Build 9200: )
02.11.2016 22:36:42 - Info dbclient (pid=8896) Batch = C:\Program Files\VERITAS\NetBackup\dbext\MSSql\SQL_Differential_Backup.bch, Op# = 2
02.11.2016 22:36:43 - Info dbclient (pid=8896) INF - Using backup image Server.MSSQL7.Server.inc.СПОНИ.~.7.001of001.20161102233640..C
02.11.2016 22:36:45 - Info dbclient (pid=8896) INF - backup database "СПОНИ" to VIRTUAL_DEVICE='VNBU0-8896-9976-1478104602' with  stats = 10, blocksize = 65536, maxtransfersize = 4194304, buffercount = 2, differential
02.11.2016 22:36:46 - Info dbclient (pid=8896) INF - Number of stripes: 1, Number of buffers per stripe 2.
02.11.2016 22:36:47 - Info dbclient (pid=8896) INF - Created VDI object for SQL Server instance <Server>. Connection timeout is <300> seconds.
02.11.2016 22:52:03 - Info dbclient (pid=8896) ERR - Error in VxBSACreateObject: 3.
02.11.2016 22:52:04 - Info dbclient (pid=8896)     CONTINUATION: - System detected error, operation aborted.
02.11.2016 22:52:05 - Info dbclient (pid=8896) ERR - Error in GetCommand: 0x80770004.
02.11.2016 22:52:07 - Info dbclient (pid=8896)     CONTINUATION: - An abort request is preventing anything except termination actions.
02.11.2016 22:52:11 - Info dbclient (pid=8896) INF - OPERATION #2 of batch C:\Program Files\VERITAS\NetBackup\dbext\MSSql\SQL_Differential_Backup.bch FAILED with STATUS 1 (0 is normal). Elapsed time = 930(930) seconds.
02.11.2016 22:52:14 - Info dbclient (pid=8896) INF - Results of executing <C:\Program Files\VERITAS\NetBackup\dbext\MSSql\SQL_Differential_Backup.bch>:
02.11.2016 22:52:14 - Info dbclient (pid=8896) <0> operations succeeded. <2> operations failed.
02.11.2016 22:52:16 - Info dbclient (pid=8896) INF - The failed backups in this script will be retried automatically in 180 seconds.
02.11.2016 22:55:36 - Error bpbrm (pid=6228) from client Server: ERR - command failed: none of the requested files were backed up (2)
02.11.2016 22:55:36 - Error bpbrm (pid=6228) from client Server: ERR - bphdb exit status = 2: none of the requested files were backed up
02.11.2016 22:55:40 - Info bphdb (pid=2792) done. status: 2: none of the requested files were backed up
02.11.2016 22:55:40 - end writing
none of the requested files were backed up  (2)

Colin_Weaver
Moderator
Moderator
Employee Accredited Certified

Are you using Netbackup or Backup Exec as your debug log looks a tad odd for Backup Exec and if NetBackup you are posting in the wrong forum