Start a Conversation

This post is more than 5 years old

Solved!

Go to Solution

7993

September 13th, 2012 04:00

NMM File System backup

Hello All,

I just configured 2 clients for file system backup with NMM module but it keep failing with below error. I have another 3 clients with same configuration on the same group that are running fine. This is the error message.

snap_vss_save 34 main_handler received signal exit. 0

65720 1347502794 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 60 NMM .. received an abort event. This will end the process... 0

64038 1347502808 5 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 55 NMM .. Error creating NetWorker backup of snapshot: %s. 1 24 27 NMM .. User abort requested

65720 1347502827 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 60 NMM .. received an abort event. This will end the process... 0

64039 1347502827 5 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 54 NMM .. Error during deport and delete of snapshot: %s. 1 24 27 NMM .. User abort requested

63372 1347502827 5 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 49 NMM .. Registration of snapshot set failed -- %s  1 24 27 NMM .. User abort requested

77175 1347502831 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 52 NMM ..  completed commit replica with status of %s.  1 0 5 false

63335 1347502831 5 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 43 NMM backup failed to complete successfully. 0

63586 1347500705 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 39 NMM .. volume %s added to replica list. 1 0 3 C:\

63586 1347500705 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 39 NMM .. volume %s added to replica list. 1 0 3 D:\

63586 1347500705 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 39 NMM .. volume %s added to replica list. 1 0 3 F:\

63586 1347500705 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 39 NMM .. volume %s added to replica list. 1 0 3 H:\

63586 1347500705 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 39 NMM .. volume %s added to replica list. 1 0 3 S:\

63586 1347500705 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 39 NMM .. volume %s added to replica list. 1 0 3 Z:\

63586 1347500705 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 39 NMM .. volume %s added to replica list. 1 0 12 Z:\DL1DATA1\

63354 1347500707 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 37 NMM .. creation of replica succeeded. 0

64342 1347500708 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 37 NMM .. created XML file directory %s. 1 0 55 C:\ProgramData\EMC\NetWorker\LG_VSS_CLIENT133458608.xml

63882 1347500709 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 38 NMM .. Read NetWorker directives file. 0

80768 1347500709 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 64 NMM... Info : 'NSR_IGNORE_MISSING_SYSTEM_FILES' is set to 'yes'. 0

0 1347500751 0 0 1 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 28 Started nsrcscd Successfully 0

71543 1347500754 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 46 NMM .. VSS Provider '%s' used for volume '%s'. 2 0 43 Microsoft Software Shadow Copy provider 1.0 0 3 C:\

71543 1347500754 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 46 NMM .. VSS Provider '%s' used for volume '%s'. 2 0 43 Microsoft Software Shadow Copy provider 1.0 0 3 D:\

71543 1347500754 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 46 NMM .. VSS Provider '%s' used for volume '%s'. 2 0 43 Microsoft Software Shadow Copy provider 1.0 0 3 F:\

71543 1347500754 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 46 NMM .. VSS Provider '%s' used for volume '%s'. 2 0 43 Microsoft Software Shadow Copy provider 1.0 0 3 H:\

71543 1347500754 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 46 NMM .. VSS Provider '%s' used for volume '%s'. 2 0 43 Microsoft Software Shadow Copy provider 1.0 0 3 S:\

71543 1347500754 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 46 NMM .. VSS Provider '%s' used for volume '%s'. 2 0 43 Microsoft Software Shadow Copy provider 1.0 0 3 Z:\

71543 1347500754 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 46 NMM .. VSS Provider '%s' used for volume '%s'. 2 0 43 Microsoft Software Shadow Copy provider 1.0 0 12 Z:\DL1DATA1\

64035 1347500754 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 42 NMM .. Preparing list of files for backup. 0

62953 1347500755 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 22 XML replica time is %s 1 0 10 1347500589

80769 1347500755 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 116 WARNING : 'NSR_IGNORE_MISSING_SYSTEM_FILES' is set to 'yes'. NMM will ignore any missing system files during backup. 0

48488 1347500819 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 41 %sPath component %s not on PIT path '%s'. 3 0 33 PS: (CMTDXlator::GetCorrectPath)  23 3 cba 23 20 c:\Windows\System32\

80774 1347500819 2 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 104 WARNING : File path (%s) for the writer "%s" not found. Files(%s) under the path are skipped for backup. 3 0 24 c:\windows\system32\cba\ 0 13 System Writer 0 7 pds.exe

48473 1347501126 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 48 WARNING: Specified file not found in the path %s 1 23 32 C:\Windows\System32\DriverStore\

67944 1347501315 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 48 %s Informational -- Full path for: '%s' is '%s'. 3 0 33 PS: (CMTDXlator::GetCorrectPath)  23 30 c:\progra~2\symantec\liveup~1\ 23 43 c:\Program Files (x86)\Symantec\LiveUpdate\

67944 1347501608 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 48 %s Informational -- Full path for: '%s' is '%s'. 3 0 33 PS: (CMTDXlator::GetCorrectPath)  23 52 c:\progra~3\symantec\defini~1\virusd~1\20120912.004\ 23 59 c:\ProgramData\Symantec\Definitions\VirusDefs\20120912.004\

67944 1347501849 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 48 %s Informational -- Full path for: '%s' is '%s'. 3 0 33 PS: (CMTDXlator::GetCorrectPath)  23 52 c:\progra~3\symantec\defini~1\virusd~1\20120912.004\ 23 59 c:\ProgramData\Symantec\Definitions\VirusDefs\20120912.004\

48471 1347502292 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 38 WARNING: No files found in the path %s 1 23 34 C:\Windows\Vss\Writers\Application

66279 1347502294 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 53 %s Informational -- Unable to correct case for: '%s'. 2 0 33 PS: (CMTDXlator::GetCorrectPath)  23 54 \\?\Volume{513c68e2-f684-11e1-b9a3-806e6f6e6963}\Boot\

64037 1347502295 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 67 NMM .. Create NetWorker backup of snapshot using PS backup service. 0

75639 1347502356 1 0 0 6476 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 37 main_handler received signal %d entry 1 1 1 9

28920 1347502356 1 0 0 6476 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 36 This program has been asked to exit. 0

75640 1347502356 1 0 0 6476 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 68 Performing orderly shutdown of the backup environment.Please wait... 0

75641 1347502356 1 0 0 6476 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 34 main_handler received signal exit. 0

65720 1347502794 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 60 NMM .. received an abort event. This will end the process... 0

64038 1347502808 5 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 55 NMM .. Error creating NetWorker backup of snapshot: %s. 1 24 27 NMM .. User abort requested

65720 1347502827 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 60 NMM .. received an abort event. This will end the process... 0

64039 1347502827 5 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 54 NMM .. Error during deport and delete of snapshot: %s. 1 24 27 NMM .. User abort requested

63372 1347502827 5 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 49 NMM .. Registration of snapshot set failed -- %s  1 24 27 NMM .. User abort requested

77175 1347502831 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 52 NMM ..  completed commit replica with status of %s.  1 0 5 false

63335 1347502831 5 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 43 NMM backup failed to complete successfully. 0

50404 1347502831 0 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 47 nsrsnap_vss_save: createInstanceBackup() failed 0

0 1347502831 2 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 29 nsrsnap_vss_save: %s: failed  1 0 19 SYSTEM COMPONENTS:\

0 1347502831 2 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 29 nsrsnap_vss_save: %s: failed  1 0 11 Z:\DL1DATA1

0 1347502831 2 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 29 nsrsnap_vss_save: %s: failed  1 0 3 Z:\

0 1347502831 2 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 29 nsrsnap_vss_save: %s: failed  1 0 3 S:\

0 1347502831 2 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 29 nsrsnap_vss_save: %s: failed  1 0 3 H:\

0 1347502831 2 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 29 nsrsnap_vss_save: %s: failed  1 0 3 F:\

0 1347502831 2 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 29 nsrsnap_vss_save: %s: failed  1 0 3 D:\

0 1347502831 2 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 29 nsrsnap_vss_save: %s: failed  1 0 3 C:\

63309 1347502831 1 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 15 NMM .. bye bye. 0

68151 1347502831 2 0 0 2332 6436 0xxxxx.xxx.xxxxt nsrsnap_vss_save 39 nsrsnap_vss_save: Exiting with failure. 0

Any idea? I couldn't find any KB in powerlink.

1.7K Posts

September 18th, 2012 06:00

Hi,

In fact that is mandatory (check documentation).

The reason behind that is as follows:

Inactivity time out: This has to be set to "0" (unlimited) to prevent time outs in the group when the snapshot is being taken. Big snapshots can take long time to be created.

Savegrp parallelism: set to "0" as the parallelism should be set at client level for NMM backups.

Client retries: has to be set to "0" so that there are not more than one call to VSS, otherwise backup will fail as snapshot is already in progress.

Thank you.

Carlos.

20 Posts

September 13th, 2012 04:00

Iman,

You need to provide a little more information like what are the details of the client configured for the backups? You said the exact same configuration is working on 3 other clients but I would assume the other clients are configured for other Microsoft applications which makes it somewhat but not totally that they are working.

The error message stating the module received an abort event indicates a error received to your Networker Server generated on the client.

Can you provide the details for the client configuration? What application are you backing up? I also see Symantec Antivirus in the log? Is it actively scanning the Networker program path? Doing so while running backup is know to cause issues particularly if it is scanning the temp files and index files created while running a backup.

1 Rookie

 • 

82 Posts

September 13th, 2012 05:00

those 3 other clients are running Exchange 2010 and the new clients are for SQL application. IS there any difference since they are now sharing the same module?

I'm not sure about Symantec AV if they are actively scanning the networker path.

20 Posts

September 13th, 2012 07:00

It matters in that the reuirements and configuration are different based on the application being backed up. When you run the configuration checker do all the checks pass ok? If a backup is taken manually from the SQL server where you are having issues does it succeed? What if anything is in /nsr/applogs or /logs on the client where the backup is failing?

1.7K Posts

September 18th, 2012 03:00

Hi there,

The errors shown in that output shows that user manually aborted the backup.

Have you ensured that the group configuration has the following values set to "0"?:

- Client inactivity time out

- savegrp parallelism

- client retries

Also ensure that only one backup is ran against those servers at a time, as only one concurrent NMM session can be ran on the same machine.

Anyway check that AV is configured to skip the entire /nsr folder as well as C:\System Volume Information.

Bear in mind that snapshots are by default placed in that folder (in all volumes) by VSS, and I've seen some cases where that folder was not excluded and lead to a failure in the backups or even performance issues.

Thank you.

Carlos.

1 Rookie

 • 

82 Posts

September 18th, 2012 06:00

Thanks Carlos. I need to check on our Symantec server if these folders are already included in exception list.

I'm not sure if setting all these entries to 0 would help, since we have other clients running fine in the same group. but I will try that anyway. Thanks for the suggestion.

79 Posts

September 20th, 2012 04:00

Hi

Please refer the KB article given below. Make sure that for filesystem backup configuration is done according the to steps given in the KB article

http://solutions.emc.com/EMCSolutionView.asp?id=esg128989&usertype=C

Regards

Panwar

1 Rookie

 • 

82 Posts

October 4th, 2012 04:00

Thanks Carlos, backup is now completed successfully. The wierd thing is group failed even though all clients completed successfully. I can see this message in our backup report tools

=======================================================

C:\ProgramData\EMC\NetWorker\LG_VSS_CLIENT4321733.xml

libpsvssclnt: C:\ProgramData\EMC\NetWorker\LG_VSS_CLIENT4321733.xml level=full, 27 MB 00:00:02      1 file

7167:libpsvssclnt: libpsvssclnt completion time: 10/4/2012 3:35:09 AM

NMM .. Request the PS backup service backup the GUI presentation objects to the NetWorker saveset 'VSS:/'.

NMM .. Delete the temporary snapshot as part of deport

76958:nsrsnap_vss_save:NMM .. successfully completed final processing of replica.

77175:nsrsnap_vss_save:NMM ..  completed commit replica with status of true.

80875:nsrsnap_vss_save:NMM snapshot backup completed successfully.

68150 1349314547 2 0 0 9764 5632 0 ch00sem3.eu.mt.mtnet nsrsnap_vss_save 39 nsrsnap_vss_save: Exiting with success. 0

NSR_BACKUP_LEVEL: incr;

NSR_CLIENT: CH00SSL1;

NSR_CONNECTING_DIRS: No;

NSR_DATA_MOVER: ch00ssl1;

NSR_DM_OS_NAME: windows;

NSR_GROUP: D_DD_FS_NMM;

NSR_IGNORE_MISSING_SYSTEM_FILES: yes;

NSR_PARENT_JOBID: 2095198;

NSR_PS_DEBUG_ID: 1349312406;

NSR_SERVER: ch00sm33;

NSR_SNAP_DELETE_ON_CLEANUP: 1;

NSR_SNAP_TYPE: vss;

NSR_STRICT_SYNC: 0, 0;

NSRSNAP_JOBID: 2095257;

optype: conventional;

snap_id_list_1: NetWorker Module for Microsoft Applications,

Microsoft Volume Shadow Copy Service;

snap_sessionid: 1349312410;

NMM .. Starting Backup. This operation may take a long time depending on the size of the data requested.

43705:libpsvssclnt: Save Operations value is ignored on this OS platform.

C:\ProgramData\EMC\NetWorker\LG_VSS_CLIENT43227637.xml

C:\ProgramData\EMC\NetWorker\LG_VSS_CLIENT43223218.xml

libpsvssclnt: C:\ProgramData\EMC\NetWorker\LG_VSS_CLIENT43223218.xml level=full, 27 MB 00:00:01      1 file

7167:libpsvssclnt: libpsvssclnt completion time: 10/4/2012 3:44:32 AM

NMM .. Request the PS backup service backup the GUI presentation objects to the NetWorker saveset 'VSS:/'.

NMM .. Delete the temporary snapshot as part of deport

76958:nsrsnap_vss_save:NMM .. successfully completed final processing of replica.

77175:nsrsnap_vss_save:NMM ..  completed commit replica with status of true.

80875:nsrsnap_vss_save:NMM snapshot backup completed successfully.

68150 1349315115 2 0 0 1264 5028 0 ch00sem1.eu.mt.mtnet nsrsnap_vss_save 39 nsrsnap_vss_save: Exiting with success. 0

N_CLEANUP: 1;

NSR_SNAP_TYPE: vss;

NSR_STRICT_SYNC: 0, 0;

NSRSNAP_JOBID: 2095260;

optype: conventional;

snap_id_list_1: NetWorker Module for Microsoft Applications,

Microsoft Volume Shadow Copy Service;

snap_sessionid: 1349312415;

NMM .. Starting Backup. This operation may take a long time depending on the size of the data requested.

43705:libpsvssclnt: Save Operations value is ignored on this OS platform.

C:\ProgramData\EMC\NetWorker\LG_VSS_CLIENT43219716.xml

C:\ProgramData\EMC\NetWorker\LG_VSS_CLIENT43227637.xml

libpsvssclnt: C:\ProgramData\EMC\NetWorker\LG_VSS_CLIENT43227637.xml level=full, 34 MB 00:00:02      1 file

7167:libpsvssclnt: libpsvssclnt completion time: 10/4/2012 4:04:58 AM

NMM .. Request the PS backup service backup the GUI presentation objects to the NetWorker saveset 'VSS:/'.

NMM .. Delete the temporary snapshot as part of deport

76958:nsrsnap_vss_save:NMM .. successfully completed final processing of replica.

77175:nsrsnap_vss_save:NMM ..  completed commit replica with status of true.

80875:nsrsnap_vss_save:NMM snapshot backup completed successfully.

68150 1349316339 2 0 0 6892 3200 0 ch00ssl1 nsrsnap_vss_save 39 nsrsnap_vss_save: Exiting with success. 0

C:\ProgramData\EMC\NetWorker\LG_VSS_CLIENT43219716.xml

libpsvssclnt: C:\ProgramData\EMC\NetWorker\LG_VSS_CLIENT43219716.xml level=full, 27 MB 00:00:02      1 file

7167:libpsvssclnt: libpsvssclnt completion time: 10/4/2012 3:41:31 AM

NMM .. Request the PS backup service backup the GUI presentation objects to the NetWorker saveset 'VSS:/'.

NMM .. Delete the temporary snapshot as part of deport

76958:nsrsnap_vss_save:NMM .. successfully completed final processing of replica.

77175:nsrsnap_vss_save:NMM ..  completed commit replica with status of true.

80875:nsrsnap_vss_save:NMM snapshot backup completed successfully.

68150 1349314932 2 0 0 10636 10624 0 ch00sem2.eu.mt.mtnet nsrsnap_vss_save 39 nsrsnap_vss_save: Exiting with success. 0

f5bcdca9-9d97-11e0-b7d8-0050568f7760}\\|d2162bd400001000000000\

00|1|0|0|0|

\\\\?\\Volume{f5bcdca6-9d97-11e0-b7d8-0050568f7760}\\|d5162bd400001000000000\

00|1|0|0|0|";

modified since: 1349226767;

NSR_BACKUP_LEVEL: incr;

NSR_CLIENT: CH00SEM3.eu.mt.mtnet;

NSR_CONNECTING_DIRS: No;

NSR_DATA_MOVER: ch00sem3.eu.mt.mtnet;

NSR_DM_OS_NAME: windows;

NSR_GROUP: D_DD_FS_NMM;

NSR_IGNORE_MISSING_SYSTEM_FILES: yes;

NSR_PARENT_JOBID: 2095198;

NSR_PS_DEBUG_ID: 1349312412;

NSR_SERVER: ch00sm33;

NSR_SNAP_DELETE_ON_CLEANUP: 1;

NSR_SNAP_TYPE: vss;

NSR_STRICT_SYNC: 0, 0;

NSRSNAP_JOBID: 2095261;

optype: conventional;

snap_id_list_1: NetWorker Module for Microsoft Applications,

Microsoft Volume Shadow Copy Service;

snap_sessionid: 1349312417;

NMM .. Starting Backup. This operation may take a long time depending on the size of the data requested.

43705:libpsvssclnt: Save Operations value is ignored on this OS platform.

C:\ProgramData\EMC\NetWorker\LG_VSS_CLIENT4321733.xml

====================================================

1.7K Posts

October 9th, 2012 01:00

Hi Iman,

What NW server and client versions are we talking about?

I remember an escalation some time ago for this same issue.

Thank you.

Carlos.

1 Rookie

 • 

82 Posts

October 9th, 2012 07:00

Hi Carlos,

Both are using NetWorker 7.6.4.1.Build.1049 Network Edition/195

1.7K Posts

October 11th, 2012 04:00

Hi Iman,

Actually the fix is already included in that version.

Not convinced with those logs, as I don't see the "finished successfully".

To be 100% sure of the status of an NMM backup please render and check the nmm.raw file within /nsr/applogs folder of each NMM client.

Please take a look at those and let us know what you see in there.

Thank you.

Carlos.

No Events found!

Top