Unsolved
This post is more than 5 years old
22 Posts
0
2875
SQL Backup very slow
Hi all,
We are having troubles in some SQL 2005/2008 databases.
The problem is that the backup group starts at 6:00a.m it takes more than 6 hours until finishes, BUT we see that first backup starts making after 4 hours, so it has 4 hours of ¿¿"previous checks"?? Don't know what is happening here
OUR ENVIROMENT:
Networker Server : 8.2.1
Networker Client: 8.2.1
Networker Microsoft Client: 8.2.1.7
SaveCommand: nsrsqlsv
SaveSet: MSSQL:
Databases: More than 400 databases in this client
LOG:
If I put nsrsqlsv -D5, I see the output, and its very large. I paste some "previous checks" that I can see here (after a lot of lines, it starts backup of databases)
(.......)
nsr/db_apps/bsmsql/sqlutil.c(6497): Entering bsQueryYukonDatabaseStatus().
nsr/db_apps/bsmsql/sqlutil.c(2710): Entering bsEnquoteString().
nsr/db_apps/bsmsql/sqlutil.c(2745): Exiting bsEnquoteString().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1241): Entering adoGetDBStatus().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1943): Entering ExecCommand().
raw_WillExecute: 'SELECT sys.databases.name, sys.database_mirroring.mirroring_state, sys.database_mirroring.mirroring_role, sys.database_mirroring.mirroring_partner_name, sys.database_mirroring.mirroring_witness_name, sys.database_mirroring.mirroring_safety_level FROM sys.database_mirroring JOIN sys.databases ON (sys.database_mirroring.database_id = sys.databases.database_id) WHERE sys.databases.name = N'DATABASE1''
raw_ExecuteComplete:'SELECT sys.databases.name, sys.database_mirroring.mirroring_state, sys.database_mirroring.mirroring_role, sys.database_mirroring.mirroring_partner_name, sys.database_mirroring.mirroring_witness_name, sys.database_mirroring.mirroring_safety_level FROM sys.database_mirroring JOIN sys.databases ON (sys.database_mirroring.database_id = sys.databases.database_id) WHERE sys.databases.name = N'DATABASE1'' execute complete
nsr/db_apps/bsmsql/nsrsqlado.cpp(1964): Exiting ExecCommand().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1296): Exiting adoGetDBMirrorStatus().
(nsr/db_apps/bsmsql/sqlutil.c)6533:query SQL server with SELECT sys.databases.name, sys.database_mirroring.mirroring_state, sys.database_mirroring.mirroring_role, sys.database_mirroring.mirroring_partner_name, sys.database_mirroring.mirroring_witness_name, sys.database_mirroring.mirroring_safety_level FROM sys.database_mirroring JOIN sys.databases ON (sys.database_mirroring.database_id = sys.databases.database_id) WHERE sys.databases.name = N'DATABASE1' failed
nsr/db_apps/bsmsql/sqlutil.c(6534): Exiting bsQueryYukonDatabaseStatus(), database DATABASE1 not in mirror relationship.
nsr/db_apps/bsmsql/sqlutil.c(6540): Exiting bsQueryYukonDatabaseStatus().
nsr/db_apps/bsmsql/sqlutil.c(12012): Exiting DisableOperationForMirroring().
nsr/db_apps/bsmsql/sqlutil.c(13517): Entering bsIsDBPreferredCopyForBackupInAG().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/sqlutil.c(13529): Exiting bsIsDBPreferredCopyForBackupInAG(), SQL Server Denali not supported.
nsr/db_apps/bsmsql/sqlutil.c(13582): Entering bsIsDBPartOfAlwaysOn().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/sqlutil.c(13594): Exiting bsIsDBPartOfAlwaysOn(), Not Support Denali.
nsr/db_apps/bsmsql/sqlutil.c(1946): Entering bsAllowFullBackup().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/sqlutil.c(2710): Entering bsEnquoteString().
nsr/db_apps/bsmsql/sqlutil.c(2745): Exiting bsEnquoteString().
nsr/db_apps/bsmsql/sqlutil.c(6921): Entering bsQueryInt().
nsr/db_apps/bsmsql/nsrsqlado.cpp(357): Entering adoQueryInt().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1943): Entering ExecCommand().
raw_WillExecute: 'SELECT state FROM master.sys.databases where name = N'DATABASE1''
raw_ExecuteComplete:'SELECT state FROM master.sys.databases where name = N'DATABASE1'' execute complete
nsr/db_apps/bsmsql/nsrsqlado.cpp(1964): Exiting ExecCommand().
nsr/db_apps/bsmsql/nsrsqlado.cpp(379): Exiting adoQueryInt() #1.
nsr/db_apps/bsmsql/sqlutil.c(6943): Exiting bsQueryInt().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/sqlutil.c(12758): Entering GetFilestreamEffectiveLevel().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/sqlutil.c(6921): Entering bsQueryInt().
nsr/db_apps/bsmsql/nsrsqlado.cpp(357): Entering adoQueryInt().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1943): Entering ExecCommand().
raw_WillExecute: 'select convert(int, SERVERPROPERTY ('FilestreamEffectiveLevel'))'
raw_ExecuteComplete:'select convert(int, SERVERPROPERTY ('FilestreamEffectiveLevel'))' execute complete
nsr/db_apps/bsmsql/nsrsqlado.cpp(1964): Exiting ExecCommand().
nsr/db_apps/bsmsql/nsrsqlado.cpp(379): Exiting adoQueryInt() #1.
nsr/db_apps/bsmsql/sqlutil.c(6943): Exiting bsQueryInt().
nsr/db_apps/bsmsql/sqlutil.c(12781): Exiting GetFilestreamEffectiveLevel().
nsr/db_apps/bsmsql/sqlutil.c(12709): Entering IsDatabaseUsingFilestream().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/sqlutil.c(2710): Entering bsEnquoteString().
nsr/db_apps/bsmsql/sqlutil.c(2745): Exiting bsEnquoteString().
nsr/db_apps/bsmsql/sqlutil.c(6921): Entering bsQueryInt().
nsr/db_apps/bsmsql/nsrsqlado.cpp(357): Entering adoQueryInt().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1943): Entering ExecCommand().
raw_WillExecute: 'SELECT COUNT(*) FROM master.sys.master_files AS dbfiles INNER JOIN master..sysdatabases AS dbnames ON dbfiles.database_id = dbnames.dbid WHERE dbnames.name = 'DATABASE1' and dbfiles.type = 2'
raw_ExecuteComplete:'SELECT COUNT(*) FROM master.sys.master_files AS dbfiles INNER JOIN master..sysdatabases AS dbnames ON dbfiles.database_id = dbnames.dbid WHERE dbnames.name = 'DATABASE1' and dbfiles.type = 2' execute complete
nsr/db_apps/bsmsql/nsrsqlado.cpp(1964): Exiting ExecCommand().
nsr/db_apps/bsmsql/nsrsqlado.cpp(379): Exiting adoQueryInt() #1.
nsr/db_apps/bsmsql/sqlutil.c(6943): Exiting bsQueryInt().
nsr/db_apps/bsmsql/sqlutil.c(12738): Exiting IsDatabaseUsingFilestream().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/sqlutil.c(2058): Exiting bsAllowFullBackup().
nsr/db_apps/bsmsql/savemain.cpp(239): Entering newSSItemCmdLine().
nsr/db_apps/bsmsql/savemain.cpp(255):SSItem 1e4d allocated
nsr/db_apps/bsmsql/savemain.cpp(347): Exiting newSSItemCmdLine().
nsr/db_apps/bsmsql/nsrsqlsv.c(2941): Entering setSSBackupLevel().
nsr/db_apps/bsmsql/sqlutil.c(10686): Entering LastBackupNonNMSQL().
nsr/db_apps/bsmsql/sqlutil.c(2710): Entering bsEnquoteString().
nsr/db_apps/bsmsql/sqlutil.c(2745): Exiting bsEnquoteString().
nsr/db_apps/bsmsql/sqlutil.c(10348): Entering bsDynamicStringPrintf().
nsr/db_apps/bsmsql/sqlutil.c(10416): Exiting bsDynamicStringPrintf().
nsr/db_apps/bsmsql/nsrsqlado.cpp(485): Entering adoQueryString().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1943): Entering ExecCommand().
raw_WillExecute: 'select top 1 name from msdb..backupset where database_name = N'DATABASE1' AND (type = 'D' OR type = 'L') order by backup_finish_date DESC '
raw_ExecuteComplete:'select top 1 name from msdb..backupset where database_name = N'DATABASE1' AND (type = 'D' OR type = 'L') order by backup_finish_date DESC ' execute complete
nsr/db_apps/bsmsql/nsrsqlado.cpp(1964): Exiting ExecCommand().
nsr/db_apps/bsmsql/nsrsqlado.cpp(507): Exiting adoQueryString() #1.
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/sqlutil.c(10348): Entering bsDynamicStringPrintf().
nsr/db_apps/bsmsql/sqlutil.c(10416): Exiting bsDynamicStringPrintf().
nsr/db_apps/bsmsql/nsrsqlado.cpp(357): Entering adoQueryInt().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1943): Entering ExecCommand().
raw_WillExecute: 'select top 1 is_copy_only from msdb..backupset where database_name = N'DATABASE1' order by backup_finish_date DESC '
raw_ExecuteComplete:'select top 1 is_copy_only from msdb..backupset where database_name = N'DATABASE1' order by backup_finish_date DESC ' execute complete
nsr/db_apps/bsmsql/nsrsqlado.cpp(1964): Exiting ExecCommand().
nsr/db_apps/bsmsql/nsrsqlado.cpp(379): Exiting adoQueryInt() #1.
nsr/db_apps/bsmsql/sqlutil.c(10734): Exiting LastBackupNonNMSQL().
nsr/db_apps/bsmsql/sqlutil.c(13582): Entering bsIsDBPartOfAlwaysOn().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/sqlutil.c(13594): Exiting bsIsDBPartOfAlwaysOn(), Not Support Denali.
nsr/db_apps/bsmsql/sqlutil.c(10886): Entering bsQuerySQLForBackupSetType().
nsr/db_apps/bsmsql/sqlutil.c(2710): Entering bsEnquoteString().
nsr/db_apps/bsmsql/sqlutil.c(2745): Exiting bsEnquoteString().
nsr/db_apps/bsmsql/sqlutil.c(10348): Entering bsDynamicStringPrintf().
nsr/db_apps/bsmsql/sqlutil.c(10416): Exiting bsDynamicStringPrintf().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1144): Entering adoFindRow().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1943): Entering ExecCommand().
raw_WillExecute: 'select distinct bs.database_name, bs.type, bs.name from msdb..backupset bs, master..sysdatabases sd where bs.database_name = N'DATABASE1' AND sd.name = N'DATABASE1' AND bs.type = 'D' AND bs.backup_start_date > sd.crdate AND bs.name = N'LegatoNWMSQL'
'
raw_ExecuteComplete:'select distinct bs.database_name, bs.type, bs.name from msdb..backupset bs, master..sysdatabases sd where bs.database_name = N'DATABASE1' AND sd.name = N'DATABASE1' AND bs.type = 'D' AND bs.backup_start_date > sd.crdate AND bs.name = N'LegatoNWMSQL'
' execute complete
nsr/db_apps/bsmsql/nsrsqlado.cpp(1964): Exiting ExecCommand().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1159): Exiting adoFindRow().
nsr/db_apps/bsmsql/sqlutil.c(10942): Exiting bsQuerySQLForBackupSetType().
nsr/db_apps/bsmsql/nsrsqlsv.c(6088): Entering dbBackedup().
nsr/db_apps/bsmsql/nsrsqlsv.c(6127): Entering initQryDesc().
nsr/db_apps/bsmsql/nsrsqlsv.c(6156): Exiting initQryDesc().
nsr/db_apps/bsmsql/nsrsqlsv.c(6203): Entering getRecentBaseBkup().
nsr/db_apps/bsmsql/nsrsqlsv.c(6233): Want recent base, query X/BSA for /DATABASE1 @ Wed Nov 11 08:08:27 2015
nsr/db_apps/bsmsql/sqlutil.c(6818): Entering bsNameToLevel().
nsr/db_apps/bsmsql/sqlutil.c(6848): Exiting bsNameToLevel().
nsr/db_apps/bsmsql/nsrsqlsv.c(6255): found MSSQL:/DATABASE1, a level incr;RMODEL:3 (10) match
nsr/db_apps/bsmsql/sqlutil.c(6818): Entering bsNameToLevel().
nsr/db_apps/bsmsql/sqlutil.c(6848): Exiting bsNameToLevel().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/sqlutil.c(7326): Entering bsSupportFgroups().
nsr/db_apps/bsmsql/sqlutil.c(7336): Exiting bsSupportFgroups().
nsr/db_apps/bsmsql/nsrsqlsv.c(6310): getRecentBaseBkup() continue...
nsr/db_apps/bsmsql/sqlutil.c(6818): Entering bsNameToLevel().
nsr/db_apps/bsmsql/sqlutil.c(6848): Exiting bsNameToLevel().
nsr/db_apps/bsmsql/nsrsqlsv.c(6391): Exiting getRecentBaseBkup().
nsr/db_apps/bsmsql/nsrsqlsv.c(6111): Exiting dbBackedup().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/sqlutil.c(10964): Entering bsQuerySQLForRestoreAfterFullBackup().
nsr/db_apps/bsmsql/sqlutil.c(2710): Entering bsEnquoteString().
nsr/db_apps/bsmsql/sqlutil.c(2745): Exiting bsEnquoteString().
nsr/db_apps/bsmsql/sqlutil.c(10348): Entering bsDynamicStringPrintf().
nsr/db_apps/bsmsql/sqlutil.c(10416): Exiting bsDynamicStringPrintf().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1144): Entering adoFindRow().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1943): Entering ExecCommand().
raw_WillExecute: 'SELECT TOP 1 rh.destination_database_name, rh.restore_date, bs.backup_start_date, bs.type FROM msdb..restorehistory rh, msdb..backupset bs WHERE rh.destination_database_name=N'DATABASE1' AND bs.type='D' AND bs.database_name=N'DATABASE1' AND rh.restore_date > ( SELECT TOP 1 bs.backup_start_date FROM msdb..backupset bs, master..sysdatabases sd WHERE bs.database_name = N'DATABASE1' AND sd.name = N'DATABASE1' AND bs.type = 'D' AND bs.backup_start_date > sd.crdate ORDER BY bs.backup_start_date DESC) ORDER BY bs.backup_start_date DESC
'
raw_ExecuteComplete:'SELECT TOP 1 rh.destination_database_name, rh.restore_date, bs.backup_start_date, bs.type FROM msdb..restorehistory rh, msdb..backupset bs WHERE rh.destination_database_name=N'DATABASE1' AND bs.type='D' AND bs.database_name=N'DATABASE1' AND rh.restore_date > ( SELECT TOP 1 bs.backup_start_date FROM msdb..backupset bs, master..sysdatabases sd WHERE bs.database_name = N'DATABASE1' AND sd.name = N'DATABASE1' AND bs.type = 'D' AND bs.backup_start_date > sd.crdate ORDER BY bs.backup_start_date DESC) ORDER BY bs.backup_start_date DESC
' execute complete
nsr/db_apps/bsmsql/nsrsqlado.cpp(1964): Exiting ExecCommand().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1159): Exiting adoFindRow().
nsr/db_apps/bsmsql/sqlutil.c(11009): Exiting bsQuerySQLForRestoreAfterFullBackup().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/sqlutil.c(6497): Entering bsQueryYukonDatabaseStatus().
nsr/db_apps/bsmsql/sqlutil.c(2710): Entering bsEnquoteString().
nsr/db_apps/bsmsql/sqlutil.c(2745): Exiting bsEnquoteString().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1241): Entering adoGetDBStatus().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1943): Entering ExecCommand().
raw_WillExecute: 'SELECT sys.databases.name, sys.database_mirroring.mirroring_state, sys.database_mirroring.mirroring_role, sys.database_mirroring.mirroring_partner_name, sys.database_mirroring.mirroring_witness_name, sys.database_mirroring.mirroring_safety_level FROM sys.database_mirroring JOIN sys.databases ON (sys.database_mirroring.database_id = sys.databases.database_id) WHERE sys.databases.name = N'DATABASE1''
raw_ExecuteComplete:'SELECT sys.databases.name, sys.database_mirroring.mirroring_state, sys.database_mirroring.mirroring_role, sys.database_mirroring.mirroring_partner_name, sys.database_mirroring.mirroring_witness_name, sys.database_mirroring.mirroring_safety_level FROM sys.database_mirroring JOIN sys.databases ON (sys.database_mirroring.database_id = sys.databases.database_id) WHERE sys.databases.name = N'DATABASE1'' execute complete
nsr/db_apps/bsmsql/nsrsqlado.cpp(1964): Exiting ExecCommand().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1296): Exiting adoGetDBMirrorStatus().
(nsr/db_apps/bsmsql/sqlutil.c)6533:query SQL server with SELECT sys.databases.name, sys.database_mirroring.mirroring_state, sys.database_mirroring.mirroring_role, sys.database_mirroring.mirroring_partner_name, sys.database_mirroring.mirroring_witness_name, sys.database_mirroring.mirroring_safety_level FROM sys.database_mirroring JOIN sys.databases ON (sys.database_mirroring.database_id = sys.databases.database_id) WHERE sys.databases.name = N'DATABASE1' failed
nsr/db_apps/bsmsql/sqlutil.c(6534): Exiting bsQueryYukonDatabaseStatus(), database DATABASE1 not in mirror relationship.
nsr/db_apps/bsmsql/sqlutil.c(6540): Exiting bsQueryYukonDatabaseStatus().
nsr/db_apps/bsmsql/sqlutil.c(2540): Entering bsDatabaseName().
nsr/db_apps/bsmsql/sqlutil.c(2587): Entering bsDatabasePath().
nsr/db_apps/bsmsql/sqlutil.c(11569): Entering UTF8nicmp().
nsr/db_apps/bsmsql/sqlutil.c(11257): Entering UTF8toUpperWchar().
nsr/db_apps/bsmsql/sqlutil.c(11299): Exiting UTF8toUpperWchar().
nsr/db_apps/bsmsql/sqlutil.c(11257): Entering UTF8toUpperWchar().
nsr/db_apps/bsmsql/sqlutil.c(11299): Exiting UTF8toUpperWchar().
nsr/db_apps/bsmsql/sqlutil.c(11600): Exiting UTF8nicmp().
nsr/db_apps/bsmsql/sqlutil.c(11569): Entering UTF8nicmp().
nsr/db_apps/bsmsql/sqlutil.c(11257): Entering UTF8toUpperWchar().
nsr/db_apps/bsmsql/sqlutil.c(11299): Exiting UTF8toUpperWchar().
nsr/db_apps/bsmsql/sqlutil.c(11257): Entering UTF8toUpperWchar().
nsr/db_apps/bsmsql/sqlutil.c(11299): Exiting UTF8toUpperWchar().
nsr/db_apps/bsmsql/sqlutil.c(11600): Exiting UTF8nicmp().
nsr/db_apps/bsmsql/sqlutil.c(2631): Exiting bsDatabasePath().
nsr/db_apps/bsmsql/sqlutil.c(2567): Exiting bsDatabaseName().
nsr/db_apps/bsmsql/sqlutil.c(2076): Entering bsAllowXlogBackup().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/sqlutil.c(2139): Exiting bsAllowXlogBackup().
nsr/db_apps/bsmsql/nsrsqlsv.c(3291): Backup level for SaveSet:CONTA009ARRANKUDIAGA_2016 is 10
nsr/db_apps/bsmsql/nsrsqlsv.c(3292): Exiting setSSBackupLevel().
nsr/db_apps/bsmsql/nsrsqlsv.c(5778): Entering AddSSListLast().
nsr/db_apps/bsmsql/nsrsqlsv.c(5793): Exiting AddSSListLast().
nsr/db_apps/bsmsql/nsrsqlado.cpp(844): Entering bsGetSQLVersionNum().
nsr/db_apps/bsmsql/nsrsqlado.cpp(876): Exiting bsGetSQLVersionNum().
nsr/db_apps/bsmsql/sqlutil.c(11967): Entering DisableOperationForMirroring().
nsr/db_apps/bsmsql/sqlutil.c(6497): Entering bsQueryYukonDatabaseStatus().
nsr/db_apps/bsmsql/sqlutil.c(2710): Entering bsEnquoteString().
nsr/db_apps/bsmsql/sqlutil.c(2745): Exiting bsEnquoteString().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1241): Entering adoGetDBStatus().
nsr/db_apps/bsmsql/nsrsqlado.cpp(1943): Entering ExecCommand().
(.......)
Thank you very much!
ble1
14.3K Posts
0
November 16th, 2015 03:00
Which version of NMM do you use? There are couple of them. Initial GA release had mutex issue, but if you use latests one (8.2.1.8 for example) you should be good.
ble1
14.3K Posts
0
November 16th, 2015 03:00
Also, was this always slow? Do you have 400 clients under single instance or multiple instances? If multiple, do you run those at the same time? I do not have 400 DBs on single host, but I can assume that might be a bit of overkill too - especially when using instance based backup as discovery part happens first.
SERVIDORESBISCA
22 Posts
0
November 16th, 2015 07:00
I am using 8.2.1.7, and before, I was using 8.2.1.2. With both of them happens the same.
It is a Microsoft Cluster with 5 instances. 1 of them has 500 Dababase. Other one has 300 Database. The second one starts backing up after 1 hour, and the first one after 4 hours...
The thing is that two months ago, it started backup inmediately...
ble1
14.3K Posts
0
November 16th, 2015 14:00
From the log posted it is hard to say anything as there is one timestamp so one can't get an idea which calls takes how much time. I assume it if run once ok and then it changed, it might not be an issue on code side of NMM. Just for the sake of the test, what happens if you try to manually define DBs and have them backed up that way? Do you also see wait? When this was faster in the past, was DB also running on the same node as now? Was there failover and speeds have changed since?
SERVIDORESBISCA
22 Posts
0
November 16th, 2015 23:00
If I put in saveset "MSSQL:DB1 MSSQL:DB2 ......" it happens the same.
Yesterday a weird thing happened to me with this group. I launched a full backup manually "savegrp -vvv -l full -G GROUP" and it start backuping up inmediately. It took 2 hours instead of 6.
Next automatic incremental took 6 hours again....
CarlosRojas
1.7K Posts
0
November 17th, 2015 05:00
Hi,
Not sure if I understood correctly. Did you say that first bakcup (I assume full) takes around 4 hours and subsequent backups (incremental) takes about 6 hours?
Do you have any type of debug level set? If so that will introduce further delays, so please make sure there is no debug in place.
Do you use SQL stripping?
Do you use client direct?
Thank you,
Carlos
ble1
14.3K Posts
0
November 17th, 2015 05:00
Incremental one is transaction logs while level full is DB backup. So, next question to ask is do you see this during DB backups (which you didn't last time) or only during transaction log backups?
SERVIDORESBISCA
22 Posts
0
November 17th, 2015 09:00
Yes, full backup takes 4 hours, while log backup takes 6 hours. But If I look in "SQL Server Logs", I see that backups begins with a delay of 4 hours after group starts...
I don't have any debug level set. Not in the "backup command", neither in the "Group Options".
I do not use SQL stripping
Yes, I use client direct
ble1
14.3K Posts
1
November 17th, 2015 14:00
And your backup command is pointing towards cluster name? With shortname or FQDN?
SERVIDORESBISCA
22 Posts
0
November 18th, 2015 00:00
No, good point!!
I will try right now
SERVIDORESBISCA
22 Posts
0
November 19th, 2015 05:00
No way. Still same problem.
If I launch a full backup manually (command line), it starts backing up inmediatly and takes 2 hours in total.
If I launch an incremental backup manually (log backup via command line), it starts 4 hours later, and takes 6 hours.
ble1
14.3K Posts
0
November 20th, 2015 04:00
ok, so you issue is only with transaction logs then. When you do this, transaction log that is, do you see any activities at SQL level? Are all these databases part of the same instance or you use couple of instances? I believe you said you get the same even if you try to run it against individual DB so you can run the TLOG job against single DB and monitor what happens at SQL level at that time. Top of my head, SQL most likely checks who is owner of request, was the same owner used last time for backup action and then which sequence numbers are to be used for TLOG job.
SERVIDORESBISCA
22 Posts
0
March 11th, 2016 05:00
Hi you all. I have to say that it is completely fixed!
All we have to do is upgrade Networker Server and Networker Clients to 8.2.2.
Now, instead of 4 hours of backup, it takes 20 minutes. Index reading and index backup is much faster.
So, I can say without any doubts that 8.2.2 version fix the trouble!!
ble1
14.3K Posts
0
March 11th, 2016 05:00
Good to hear. Which version of 8.2.2.x did you use? 8.2.2.5? (both NW and NMM)
SERVIDORESBISCA
22 Posts
0
March 11th, 2016 06:00
In our case:
NW Server, NW Client and NMM: 8.2.2.4 Build 970