Connecting to SQL Server [EC012QSQL] for validation... [13:00:05.031] *** SnapManager for SQL Server Report [13:00:05.031] Backup Time Stamp: 08-19-2008_13.00.01 [13:00:05.031] Getting SQL Server Database Information, please wait... [13:00:05.031] Getting virtual disks information... [13:00:06.281] Querying SQL Server instances installed... [13:00:06.281] Creating threads for enumerating databases of different SQL Server instances. [13:00:06.281] Waiting for the threads to finish enumerating databases. [13:00:06.297] Connecting to SQL Server instance - EC012QSQL... [13:00:06.312] Getting SQL Server version information... [13:00:06.344] Querying database information... [13:00:06.437] All threads finished enumerating databases. [13:00:06.437] Validating database configuration... [13:00:06.437] Setting database disk configuration... [13:00:06.437] Setting database locating on SQLRoot path... [13:00:06.437] Querying database disk volume configuration... [13:00:06.437] Getting SnapInfo directories configuration... [13:00:06.437] Full database backup [13:00:06.437] Maximum databases of concurrent backup: 20 [13:00:06.437] Naming convention: Generic [13:00:06.437] Run transaction log backup after full database backup: No [13:00:06.437] Keep the oldest 28 full backups. [13:00:06.437] Retain up-to-the-minute restore ability for older backups in other management groups: No [13:00:06.437] Leave database attached after DBCC: No [13:00:06.437] Run DBCC CHECKDB with Live Database Before Backup: No [13:00:06.437] Run DBCC CHECKDB with Live Database After Backup: No [13:00:06.437] Backup Management Group: Standard [13:00:06.437] Update SnapMirror after operation: No [13:00:06.437] Run Command after operation: No [13:00:06.437] [13:00:06.437] Backup Database 1: EC012QSQL : Northwind [13:00:06.437] Backup Database 2: EC012QSQL : pubs [13:00:06.437] Backup Database 3: EC012QSQL : QBAnalytics [13:00:06.437] Backup Database 4: EC012QSQL : QBCollection_Plus [13:00:06.437] Backup Database 5: EC012QSQL : QBCollection_Plus_GR_Dialer [13:00:06.437] Backup Database Group #1: [13:00:06.437] EC012QSQL : Northwind [13:00:06.437] EC012QSQL : pubs [13:00:06.437] EC012QSQL : QBAnalytics [13:00:06.437] EC012QSQL : QBCollection_Plus [13:00:06.437] EC012QSQL : QBCollection_Plus_GR_Dialer [13:00:06.437] [13:00:06.437] Backup job based on volume: #1 [13:00:06.437] Sub Job: #1 of Job#1 [13:00:06.437] 1 - EC012QSQL : Northwind [13:00:06.437] 2 - EC012QSQL : pubs [13:00:06.437] 3 - EC012QSQL : QBAnalytics [13:00:06.437] 4 - EC012QSQL : QBCollection_Plus [13:00:06.437] 5 - EC012QSQL : QBCollection_Plus_GR_Dialer [13:00:06.437] **** BACKUP JOB **** #1 [13:00:06.437] Backup Time Stamp: 08-19-2008_13.00.01 [13:00:06.437] **** Backup Group [#1] of Job#1 [13:00:06.437] Backup Database List: [13:00:06.437] 1 - EC012QSQL : Northwind [13:00:06.437] 2 - EC012QSQL : pubs [13:00:06.437] 3 - EC012QSQL : QBAnalytics [13:00:06.437] 4 - EC012QSQL : QBCollection_Plus [13:00:06.437] 5 - EC012QSQL : QBCollection_Plus_GR_Dialer [13:00:06.437] Maximum worker threads setting for [EC012QSQL] = 255 [13:00:06.437] Current worker threads number for [EC012QSQL] = 663 [13:00:06.437] The number of databases selected for concurrent backup exceeds the maximum number of SQL Server worker threads that are available on the SQL Server EC012QSQL to perform this backup. [13:00:06.437] Please increase the number of worker threads for SQL Server EC012QSQL to be greater than the sum of the worker thread required to service SQL Server client and the number of databases connected to SQL Server EC012QSQL, which are selected for concurrent backup. [13:00:06.437] WARNING: SnapManager backup may fail. [13:00:06.437] Please re-run Configuration Wizard, and specify 'Modify SQLServer maximum worker threads parameter' option to increase the maximum worker threads for the SQL Server EC012QSQL. Or decrease the maximum number of databases to backup concurrently. [13:00:06.437] GETTING ALL DATABASES INFO SHARING THE SAME VOLUMES... [13:00:23.047] Getting SnapInfo directory info... [13:00:23.047] 1 - Database [Northwind] of [EC012QSQL] SnapInfo directory located at: [13:00:23.047] I:\SMSQL_SnapInfo\VDISK__L&S [13:00:23.047] 2 - Database [pubs] of [EC012QSQL] SnapInfo directory located at: [13:00:23.047] I:\SMSQL_SnapInfo\VDISK__L&S [13:00:23.047] 3 - Database [QBAnalytics] of [EC012QSQL] SnapInfo directory located at: [13:00:23.047] I:\SMSQL_SnapInfo\VDISK__L&S [13:00:23.047] 4 - Database [QBCollection_Plus] of [EC012QSQL] SnapInfo directory located at: [13:00:23.047] I:\SMSQL_SnapInfo\VDISK__L&S [13:00:23.047] 5 - Database [QBCollection_Plus_GR_Dialer] of [EC012QSQL] SnapInfo directory located at: [13:00:23.047] I:\SMSQL_SnapInfo\VDISK__L&S [13:00:23.047] CHECK SNAPMANAGER LICENSE ON VIRTUAL DISK. [13:00:23.047] Querying virtual disk license: S:... [13:00:23.047] Getting SnapInfo directory info... [13:00:23.047] 1 - Database [Northwind] of [EC012QSQL] SnapInfo directory located at: [13:00:23.047] I:\SMSQL_SnapInfo\VDISK__L&S [13:00:23.047] 2 - Database [pubs] of [EC012QSQL] SnapInfo directory located at: [13:00:23.047] I:\SMSQL_SnapInfo\VDISK__L&S [13:00:23.047] 3 - Database [QBAnalytics] of [EC012QSQL] SnapInfo directory located at: [13:00:23.047] I:\SMSQL_SnapInfo\VDISK__L&S [13:00:23.047] 4 - Database [QBCollection_Plus] of [EC012QSQL] SnapInfo directory located at: [13:00:23.047] I:\SMSQL_SnapInfo\VDISK__L&S [13:00:23.047] 5 - Database [QBCollection_Plus_GR_Dialer] of [EC012QSQL] SnapInfo directory located at: [13:00:23.047] I:\SMSQL_SnapInfo\VDISK__L&S [13:00:23.047] [13:00:23.047] RENAME MOST RECENT SNAPINFO BEFORE NEW BACKUP : EC012QSQL : Northwind - [#1] [13:00:23.063] Rename old recent snapinfo folder from and to: [13:00:23.063] I:\SMSQL_SnapInfo\VDISK__L&S\FG__\EC012QSQL__recent [13:00:23.063] I:\SMSQL_SnapInfo\VDISK__L&S\FG__\08-19-2008_12.30.01 [13:00:23.063] SnapManager finds an alternative snapinfo directory for database [Northwind] of [EC012QSQL] at: [13:00:23.063] I:\SMSQL_SnapInfo\SQL__EC012QSQL\DB__Northwind [13:00:23.063] [13:00:23.063] RENAME MOST RECENT SNAPINFO BEFORE NEW BACKUP : EC012QSQL : pubs - [#2] [13:00:23.063] The recent backup snapinfo directory has already been renamed, it is sharing with other datatabases. [13:00:23.063] SnapManager finds an alternative snapinfo directory for database [pubs] of [EC012QSQL] at: [13:00:23.063] I:\SMSQL_SnapInfo\SQL__EC012QSQL\DB__pubs [13:00:23.063] [13:00:23.063] RENAME MOST RECENT SNAPINFO BEFORE NEW BACKUP : EC012QSQL : QBAnalytics - [#3] [13:00:23.063] The recent backup snapinfo directory has already been renamed, it is sharing with other datatabases. [13:00:23.063] SnapManager finds an alternative snapinfo directory for database [QBAnalytics] of [EC012QSQL] at: [13:00:23.063] I:\SMSQL_SnapInfo\SQL__EC012QSQL\DB__QBAnalytics [13:00:23.063] [13:00:23.063] RENAME MOST RECENT SNAPINFO BEFORE NEW BACKUP : EC012QSQL : QBCollection_Plus - [#4] [13:00:23.063] The recent backup snapinfo directory has already been renamed, it is sharing with other datatabases. [13:00:23.063] SnapManager finds an alternative snapinfo directory for database [QBCollection_Plus] of [EC012QSQL] at: [13:00:23.063] I:\SMSQL_SnapInfo\SQL__EC012QSQL\DB__QBCollection_Plus [13:00:23.063] [13:00:23.063] RENAME MOST RECENT SNAPINFO BEFORE NEW BACKUP : EC012QSQL : QBCollection_Plus_GR_Dialer - [#5] [13:00:23.063] The recent backup snapinfo directory has already been renamed, it is sharing with other datatabases. [13:00:23.063] SnapManager finds an alternative snapinfo directory for database [QBCollection_Plus_GR_Dialer] of [EC012QSQL] at: [13:00:23.063] I:\SMSQL_SnapInfo\SQL__EC012QSQL\DB__QBCollection_Plus_GR_Dialer [13:00:23.063] [13:00:23.063] RENAME OLD MOST RECENT SNAPSHOT [13:00:24.126] Rename Snapshot for virtual disk [S:] from [sqlsnap__ec012qsql__recent] [13:00:24.126] To [sqlsnap__EC012QSQL_08-19-2008_12.30.01] [13:00:25.204] Rename snapshot successfully completed. [13:00:26.173] Rename Snapshot for virtual disk [L:] from [sqlsnap__ec012qsql__recent] [13:00:26.173] To [sqlsnap__EC012QSQL_08-19-2008_12.30.01] [13:00:27.235] Rename snapshot successfully completed. [13:00:27.235] CREATE NEW RECENT SNAPINFO DIRECTORY : Northwind - [#1] [13:00:27.235] SnapInfo file Name: [13:00:27.235] I:\SMSQL_SnapInfo\VDISK__L&S\FG__\EC012QSQL__recent\SnapInfo__08-19-2008_13.00.01.sml [13:00:27.235] [13:00:27.235] CREATE NEW RECENT SNAPINFO DIRECTORY : pubs - [#2] [13:00:27.235] SnapInfo file Name: [13:00:27.235] I:\SMSQL_SnapInfo\VDISK__L&S\FG__\EC012QSQL__recent\SnapInfo__08-19-2008_13.00.01.sml [13:00:27.235] [13:00:27.235] CREATE NEW RECENT SNAPINFO DIRECTORY : QBAnalytics - [#3] [13:00:27.235] SnapInfo file Name: [13:00:27.235] I:\SMSQL_SnapInfo\VDISK__L&S\FG__\EC012QSQL__recent\SnapInfo__08-19-2008_13.00.01.sml [13:00:27.235] [13:00:27.235] CREATE NEW RECENT SNAPINFO DIRECTORY : QBCollection_Plus - [#4] [13:00:27.235] SnapInfo file Name: [13:00:27.235] I:\SMSQL_SnapInfo\VDISK__L&S\FG__\EC012QSQL__recent\SnapInfo__08-19-2008_13.00.01.sml [13:00:27.235] [13:00:27.235] CREATE NEW RECENT SNAPINFO DIRECTORY : QBCollection_Plus_GR_Dialer - [#5] [13:00:27.235] SnapInfo file Name: [13:00:27.235] I:\SMSQL_SnapInfo\VDISK__L&S\FG__\EC012QSQL__recent\SnapInfo__08-19-2008_13.00.01.sml [13:00:27.235] [13:00:27.235] *** STARTING SQL SERVER ONLINE BACKUP PROCESS [13:00:27.235] Updating SnapInfo file for databases sharing same drive letter - [#1] [13:00:27.235] Updating SnapInfo file for database - #1 : Northwind [13:00:27.282] Updating SnapInfo file for database - #2 : pubs [13:00:27.329] Updating SnapInfo file for database - #3 : QBAnalytics [13:00:27.391] Updating SnapInfo file for database - #4 : QBCollection_Plus [13:00:27.454] Updating SnapInfo file for database - #5 : QBCollection_Plus_GR_Dialer [13:00:27.532] [13:00:27.532] Starting VDI backup thread for database #1: [EC012QSQL : Northwind]... [13:00:27.532] Starting VDI backup thread for database #2: [EC012QSQL : pubs]... [13:00:27.532] Starting VDI backup thread for database #3: [EC012QSQL : QBAnalytics]... [13:00:27.532] Starting VDI backup thread for database #4: [EC012QSQL : QBCollection_Plus]... [13:00:27.532] Starting VDI backup thread for database #5: [EC012QSQL : QBCollection_Plus_GR_Dialer]... [13:00:27.563] Sending SQL command to instance EC012QSQL for database Northwind : device NTAPDEV__EC012QSQL_Northwind... [13:00:27.579] Receiving by server [EC012QSQL]... [13:00:27.579] Sending SQL command to instance EC012QSQL for database QBAnalytics : device NTAPDEV__EC012QSQL_QBAnalytics... [13:00:27.579] Receiving by server [EC012QSQL]... [13:00:27.579] Sending SQL command to instance EC012QSQL for database pubs : device NTAPDEV__EC012QSQL_pubs... [13:00:27.579] Receiving by server [EC012QSQL]... [13:00:27.579] BACKUP DATABASE [Northwind] TO VIRTUAL_DEVICE='NTAPDEV__EC012QSQL_Northwind' WITH SNAPSHOT [13:00:27.579] Sending SQL command to instance EC012QSQL for database QBCollection_Plus_GR_Dialer : device NTAPDEV__EC012QSQL_QBCollection_Plus_GR_Dialer... [13:00:27.579] Receiving by server [EC012QSQL]... [13:00:27.579] Sending SQL command to instance EC012QSQL for database QBCollection_Plus : device NTAPDEV__EC012QSQL_QBCollection_Plus... [13:00:27.579] BACKUP DATABASE [pubs] TO VIRTUAL_DEVICE='NTAPDEV__EC012QSQL_pubs' WITH SNAPSHOT [13:00:27.579] Waiting for SQLServer to respond... [13:00:27.579] BACKUP DATABASE [QBAnalytics] TO VIRTUAL_DEVICE='NTAPDEV__EC012QSQL_QBAnalytics' WITH SNAPSHOT [13:00:27.579] BACKUP DATABASE [QBCollection_Plus_GR_Dialer] TO VIRTUAL_DEVICE='NTAPDEV__EC012QSQL_QBCollection_Plus_GR_Dialer' WITH SNAPSHOT [13:00:27.579] Waiting for SQLServer to respond... [13:00:27.579] Waiting for SQLServer to respond... [13:00:27.579] Receiving by server [EC012QSQL]... [13:00:27.579] Waiting for SQLServer to respond... [13:00:27.579] BACKUP DATABASE [QBCollection_Plus] TO VIRTUAL_DEVICE='NTAPDEV__EC012QSQL_QBCollection_Plus' WITH SNAPSHOT [13:00:27.579] Waiting for SQLServer to respond... [13:00:27.594] Performing data transfer of [EC012QSQL : QBCollection_Plus_GR_Dialer]... [13:00:27.594] Performing data transfer of [EC012QSQL : QBAnalytics]... [13:00:27.594] Performing data transfer of [EC012QSQL : pubs]... [13:00:27.610] Performing data transfer of [EC012QSQL : Northwind]... [13:03:00.475] SQL Server is prepared to freeze the database now [EC012QSQL : QBCollection_Plus_GR_Dialer]... [13:03:00.600] SQL Server is prepared to freeze the database now [EC012QSQL : pubs]... [13:03:00.882] SQL Server is prepared to freeze the database now [EC012QSQL : Northwind]... [13:03:01.553] SQL Server is prepared to freeze the database now [EC012QSQL : QBAnalytics]... [13:08:01.831] Performing data transfer of [EC012QSQL : QBCollection_Plus]... [13:18:03.182] [EC012QSQL : QBCollection_Plus] Unexpected termination: 0x80770004 [13:18:03.182] The preparation of one of more VDI database backups failed. [13:18:03.182] All database backups are aborted. [13:18:03.182] CLEANUP FAILED BACKUP [13:18:03.197] [VDI Error]: An abort request is preventing anything except termination actions. [13:18:03.197] VDI backup thread was informed to abort the backup of [EC012QSQL : Northwind]. [13:18:03.197] VDI backup thread was informed to abort the backup of [EC012QSQL : pubs]. [13:18:03.197] VDI backup thread was informed to abort the backup of [EC012QSQL : QBAnalytics]. [13:18:03.197] VDI backup thread was informed to abort the backup of [EC012QSQL : QBCollection_Plus_GR_Dialer]. [13:18:03.197] Error encountered [13:18:03.197] Msg 845, SevLevel 17, State 1, SQLState 42000 [13:18:03.197] [Microsoft][ODBC SQL Server Driver][SQL Server]Time-out occurred while waiting for buffer latch type 4 for page (1:23836258), database ID 9. [13:18:03.197] Msg 3013, SevLevel 16, State 1, SQLState 42000 [13:18:03.197] [Microsoft][ODBC SQL Server Driver][SQL Server]BACKUP DATABASE is terminating abnormally. [13:18:03.213] Error encountered [13:18:03.213] Msg 3013, SevLevel 16, State 1, SQLState 42000 [13:18:03.213] [Microsoft][ODBC SQL Server Driver][SQL Server]BACKUP DATABASE is terminating abnormally. [13:18:03.213] Error Code: 0xc00408d4 The VDI backup thread received a termination request as a result of one or more SQL database backups failing, or the SnapDrive failing to prepare for snapshot creation. [13:18:03.213] Error Code: 0xc00408d4 The VDI backup thread received a termination request as a result of one or more SQL database backups failing, or the SnapDrive failing to prepare for snapshot creation. [13:18:03.213] Error Code: 0xc00408d4 The VDI backup thread received a termination request as a result of one or more SQL database backups failing, or the SnapDrive failing to prepare for snapshot creation. [13:18:03.213] Error Code: 0xc00408d4 The VDI backup thread received a termination request as a result of one or more SQL database backups failing, or the SnapDrive failing to prepare for snapshot creation. [13:18:03.213] Error encountered [13:18:03.213] Msg 3013, SevLevel 16, State 1, SQLState 42000 [13:18:03.213] [Microsoft][ODBC SQL Server Driver][SQL Server]BACKUP DATABASE is terminating abnormally. [13:18:03.213] Error encountered [13:18:03.213] Msg 3013, SevLevel 16, State 1, SQLState 42000 [13:18:03.213] [Microsoft][ODBC SQL Server Driver][SQL Server]BACKUP DATABASE is terminating abnormally. [13:18:03.213] Error encountered [13:18:03.213] Msg 3013, SevLevel 16, State 1, SQLState 42000 [13:18:03.213] [Microsoft][ODBC SQL Server Driver][SQL Server]BACKUP DATABASE is terminating abnormally. [13:18:03.244] The SQL command executed. [13:18:03.244] The SQL command executed. [13:18:03.244] The SQL command executed. [13:18:03.244] The SQL command executed. [13:18:03.244] The SQL command executed. [13:18:03.244] Warning: Invalid snapinfo folder renamed to: [13:18:03.244] I:\SMSQL_SnapInfo\VDISK__L&S\FG__\EC012QSQL__recent17381_invalid [13:18:03.244] [13:18:03.244] Rename snapinfo folder from and to: [13:18:03.244] I:\SMSQL_SnapInfo\VDISK__L&S\FG__\EC012QSQL__recent [13:18:03.244] I:\SMSQL_SnapInfo\VDISK__L&S\FG__\EC012QSQL__recent17381_invalid [13:18:03.244] [13:18:05.026] Rename Snapshot for virtual disk [S:] from [sqlsnap__ec012qsql_08-19-2008_12.30.01] [13:18:05.026] To [sqlsnap__EC012QSQL__recent] [13:18:06.494] Rename snapshot successfully completed. [13:18:07.416] Rename Snapshot for virtual disk [L:] from [sqlsnap__ec012qsql_08-19-2008_12.30.01] [13:18:07.416] To [sqlsnap__EC012QSQL__recent] [13:18:08.338] Rename snapshot successfully completed. [13:18:08.338] [13:18:08.338] Rename snapinfo folder from and to: [13:18:08.338] I:\SMSQL_SnapInfo\VDISK__L&S\FG__\08-19-2008_12.30.01 [13:18:08.338] I:\SMSQL_SnapInfo\VDISK__L&S\FG__\EC012QSQL__recent [13:18:08.338] Rename succesfully completed. [13:18:08.338] [13:18:08.338] Error Code: 0xc0040837 Failed to prepare VDI operation before backup. [13:18:08.338] Preparing for Sending Filer AutoSupport... [13:18:08.995] A filer autosupport message is sent on failure. [13:18:08.995] [13:18:08.995] **** FULL DATABASE BACKUP RESULT SUMMARY #1 **** [13:18:08.995] Backup Time: 08-19-2008_13.00.01 [13:18:08.995] Backup Group [#1]: [13:18:08.995] #1 : [EC012QSQL - Northwind] : Failed with error code 0xc00408d4. [13:18:08.995] #1 : [EC012QSQL - Northwind] Error : VDI backup thread was informed to abort the backup of [EC012QSQL : Northwind]. [13:18:08.995] #2 : [EC012QSQL - pubs] : Failed with error code 0xc00408d4. [13:18:08.995] #2 : [EC012QSQL - pubs] Error : VDI backup thread was informed to abort the backup of [EC012QSQL : pubs]. [13:18:08.995] #3 : [EC012QSQL - QBAnalytics] : Failed with error code 0xc00408d4. [13:18:08.995] #3 : [EC012QSQL - QBAnalytics] Error : VDI backup thread was informed to abort the backup of [EC012QSQL : QBAnalytics]. [13:18:08.995] #4 : [EC012QSQL - QBCollection_Plus] : Failed with error code 0x80770004. [13:18:08.995] #4 : [EC012QSQL - QBCollection_Plus] Error : [EC012QSQL : QBCollection_Plus] Unexpected termination: 0x80770004 [13:18:08.995] #5 : [EC012QSQL - QBCollection_Plus_GR_Dialer] : Failed with error code 0xc00408d4. [13:18:09.010] #5 : [EC012QSQL - QBCollection_Plus_GR_Dialer] Error : VDI backup thread was informed to abort the backup of [EC012QSQL : QBCollection_Plus_GR_Dialer]. [13:18:09.010] [13:18:09.010] *** SNAPMANAGER BACKUP JOB ENDED AT: [08-19-2008 13.18.09] [13:18:09.010] Error Code: 0xc0040837 Failed to prepare VDI operation before backup.