svasilev
6 years agoLevel 3
ERR - exit status: <2> <41>
AUTOMATIC_DATABASE_BACKUP
Apr 2, 2019 1:56:30 PM - Info nbjm (pid=6452) starting backup job (jobid=7972396) for client ************, policy Prophix-DBs, schedule Hourly Apr 2, 2019 1:56:30 PM - Info nbjm (pid=6452) requesting MEDIA_SERVER_ONLY resources from RB for backup job (jobid=7972396, request id:{15A07788-7AD1-4032-A3EB-329244BF4990}) Apr 2, 2019 1:56:30 PM - requesting resource M**T-SQL Apr 2, 2019 1:56:30 PM - estimated 0 kbytes needed Apr 2, 2019 1:56:30 PM - Info nbjm (pid=6452) started backup (backupid=************_1554202590) job for client ************, policy Prophix-DBs, schedule Hourly on storage unit Apr 2, 2019 1:56:32 PM - started process bpbrm (pid=8832) Apr 2, 2019 1:56:33 PM - Info bpbrm (pid=8832) ************ is the host to backup data from Apr 2, 2019 1:56:33 PM - Info bpbrm (pid=8832) reading file list for client Apr 2, 2019 1:56:34 PM - connecting Apr 2, 2019 1:56:35 PM - Info bpbrm (pid=8832) starting bphdb on client Apr 2, 2019 1:56:35 PM - Info bphdb (pid=12072) Backup started Apr 2, 2019 1:56:35 PM - connected; connect time: 0:00:00 Apr 2, 2019 1:56:36 PM - Info dbclient (pid=5164) INF - Intelligent policy initiated by server <srv-snbu01.M**T.ru> Apr 2, 2019 1:56:37 PM - Info dbclient (pid=5164) INF - Intelligent policy <Prophix-DBs> is valid. The input file <C:\Program Files\Veritas\NetBackup\dbext\mssql\input.12072.0.0402119.135635> has been parsed successfully Apr 2, 2019 1:56:38 PM - Info dbclient (pid=5164) INF - Instance server name resolved to: <PROPHIX-APP> Apr 2, 2019 1:56:40 PM - Info dbclient (pid=5164) INF - Intelligent policy <Prophix-DBs> has resulted in <1> batch operation(s). Apr 2, 2019 1:56:41 PM - Info dbclient (pid=5164) INF - Intelligent policy <Prophix-DBs>: <1> operation(s) will protect the database transaction logs. Apr 2, 2019 1:56:42 PM - Info dbclient (pid=5164) INF - Intelligent policy preprocessing has finished, created temporary batch file <__13_56_39_925_00.bch>, and submitted it to the backend agent for processing Apr 2, 2019 1:56:43 PM - Info dbclient (pid=5164) INF - Querying master.sys.database_recovery_status to determine last_log_backup_lsn for database Dev_PROPHIX_FactDb Apr 2, 2019 1:56:44 PM - Info dbclient (pid=5164) INF - A full backup has already been performed on this database. Apr 2, 2019 1:56:45 PM - Info dbclient (pid=5164) INF - No conversion required for transaction log backup. Apr 2, 2019 1:56:47 PM - Info dbclient (pid=5164) INF - BACKUP STARTED USING Apr 2, 2019 1:56:47 PM - Info dbclient (pid=5164) Microsoft SQL Server 2016 (SP1-CU11) (KB4459676) - 13.0.4528.0 (X64) Apr 2, 2019 1:56:47 PM - Info dbclient (pid=5164) Aug 30 2018 21:57:02 Apr 2, 2019 1:56:47 PM - Info dbclient (pid=5164) Copyright (c) Microsoft Corporation Apr 2, 2019 1:56:47 PM - Info dbclient (pid=5164) Enterprise Edition: Core-based Licensing (64-bit) on Windows Server 2016 Standard 10.0 <X64> (Build 14393: ) (Hypervisor) Apr 2, 2019 1:56:47 PM - Info dbclient (pid=5164) Batch = __13_56_39_925_00.bch, Op# = 1 Apr 2, 2019 1:56:49 PM - Info dbclient (pid=5164) INF - Using backup image PROPHIX-APP.MSSQL7.PROPHIX-APP.trx.Dev_PROPHIX_FactDb.~.7.001of001.20190402135646..C Apr 2, 2019 1:56:50 PM - Info dbclient (pid=5164) INF - backup log "Dev_PROPHIX_FactDb" to VIRTUAL_DEVICE='VNBU0-5164-7736-1554202609' with compression, stats = 10, checksum, stop_on_error, blocksize = 65536, maxtransfersize = 4194304, buffercount = 2 Apr 2, 2019 1:56:51 PM - Info dbclient (pid=5164) INF - Number of stripes: 1, Number of buffers per stripe 2. Apr 2, 2019 1:56:52 PM - Info dbclient (pid=5164) INF - Setting backup catalog name to: ************ Apr 2, 2019 1:56:52 PM - Info dbclient (pid=5164) INF - Created VDI object for SQL Server instance <PROPHIX-APP>. Connection timeout is <300> seconds. Apr 2, 2019 3:36:21 PM - Info dbclient (pid=5164) ERR - Error in VxBSACreateObject: 3. Apr 2, 2019 3:36:23 PM - Info dbclient (pid=5164) CONTINUATION: - System detected error, operation aborted. Apr 2, 2019 3:36:25 PM - Info dbclient (pid=5164) ERR - Error in GetCommand: 0x80770004. Apr 2, 2019 3:36:26 PM - Info dbclient (pid=5164) INF - OPERATION #1 of batch __13_56_39_925_00.bch FAILED with STATUS 1 (0 is normal). Elapsed time = 5980(5980) seconds. Apr 2, 2019 3:36:27 PM - Info dbclient (pid=5164) CONTINUATION: - An abort request is preventing anything except termination actions. Apr 2, 2019 3:36:29 PM - Info dbclient (pid=5164) INF - Results of executing <__13_56_39_925_00.bch>: Apr 2, 2019 3:36:29 PM - Info dbclient (pid=5164) <0> operations succeeded. <1> operations failed. Apr 2, 2019 3:36:30 PM - Info dbclient (pid=5164) INF - The following object(s) were not backed up successfully. Apr 2, 2019 3:36:32 PM - Info dbclient (pid=5164) INF - Dev_PROPHIX_FactDb Apr 2, 2019 3:36:32 PM - Error bpbrm (pid=8832) from client ************: ERR - exit status: <2> Apr 2, 2019 3:36:33 PM - Error bpbrm (pid=8832) from client ************: ERR - bphdb exit status = 2: none of the requested files were backed up Apr 2, 2019 3:36:33 PM - Info bphdb (pid=12072) done. status: 2: none of the requested files were backed up Apr 2, 2019 3:36:33 PM - end writing none of the requested files were backed up (2)
AND
Apr 2, 2019 1:56:55 PM - Info nbjm (pid=6452) starting backup job (jobid=7972398) for client ************, policy Prophix-DBs, schedule Hourly Apr 2, 2019 1:56:55 PM - Info nbjm (pid=6452) requesting STANDARD_RESOURCE resources from RB for backup job (jobid=7972398, request id:{4BE15C6D-B68B-4B9C-9EF5-A90C8B765BB2}) Apr 2, 2019 1:56:55 PM - requesting resource MONT-SQL Apr 2, 2019 1:56:55 PM - requesting resource MASTER.NBU_CLIENT.MAXJOBS.************ Apr 2, 2019 1:56:55 PM - awaiting resource MONT-SQL. Maximum job count has been reached for the storage unit. Apr 2, 2019 1:58:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:00:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:02:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:04:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:06:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:08:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:10:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:12:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:14:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:16:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:18:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:20:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:22:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:24:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:26:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:28:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:30:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:32:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:34:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:36:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:38:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:40:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:42:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:44:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:46:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:48:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:50:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:52:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:54:55 PM - Info nbjm (pid=6452) Waiting in NetBackup scheduler work queue on server MASTER Apr 2, 2019 2:55:39 PM - granted resource MASTER.NBU_CLIENT.MAXJOBS.************ Apr 2, 2019 2:55:39 PM - granted resource MediaID=@aaaa6;DiskVolume=PureDiskVolume;DiskPool=DDUPool-01;Path=PureDiskVolume;StorageServer=srv-snbu08.mont.ru;MediaServer=srv-snbu03.mont.ru Apr 2, 2019 2:55:39 PM - granted resource DiskStorage-1 Apr 2, 2019 2:55:39 PM - estimated 2857766 kbytes needed Apr 2, 2019 2:55:39 PM - Info nbjm (pid=6452) started backup (backupid=************_1554206139) job for client ************, policy Prophix-DBs, schedule Hourly on storage unit DiskStorage-1 Apr 2, 2019 2:55:41 PM - started process bpbrm (pid=12200) Apr 2, 2019 2:55:41 PM - Info bpbrm (pid=12200) ************ is the host to backup data from Apr 2, 2019 2:55:42 PM - connecting Apr 2, 2019 2:55:42 PM - Info bpbrm (pid=12200) reading file list for client Apr 2, 2019 2:55:43 PM - Info bpbrm (pid=12200) listening for client connection Apr 2, 2019 2:55:44 PM - Info bpbrm (pid=12200) INF - Client read timeout = 900 Apr 2, 2019 2:55:44 PM - Info bpbrm (pid=12200) accepted connection from client Apr 2, 2019 2:55:44 PM - Info dbclient (pid=5164) Backup started Apr 2, 2019 2:55:44 PM - Info bptm (pid=11352) start Apr 2, 2019 2:55:45 PM - connected; connect time: 0:00:00 Apr 2, 2019 2:55:45 PM - Info bptm (pid=11352) using 262144 data buffer size Apr 2, 2019 2:55:45 PM - Info bptm (pid=11352) setting receive network buffer to 1049600 bytes Apr 2, 2019 2:55:45 PM - Info bptm (pid=11352) using 30 data buffers Apr 2, 2019 2:55:47 PM - Info bptm (pid=11352) start backup Apr 2, 2019 3:19:03 PM - Info bptm (pid=11352) backup child process is pid 10980.10236 Apr 2, 2019 3:19:03 PM - begin writing Apr 2, 2019 3:19:03 PM - Info bptm (pid=10980) start Apr 2, 2019 3:39:06 PM - Info dbclient (pid=5164) done. status: 41: network connection timed out Apr 2, 2019 3:39:06 PM - end writing; write time: 0:20:03 network connection timed out (41)