bpend_notify.policy.bat not being called

Created: 03 Oct 2012 | 12 comments

Hi,

In some case bpend_notify.policy.bat not beeing called. I tried restarting the net backup services and it starte working fine. Any reason for this? Which service does run this bat file?

Thanks in advance

Veeresh Hosur

Discussion Filed Under:

Backup and Recovery, NetBackup - 7.5, NetBackup, Backing Up

Comments RSS Feed

Comments 12 Comments • Jump to latest comment

Andy Welburn Trusted Advisor

bpend_notify.policy.bat not being called - Comment:03 Oct 2012 : Link

What version(s) of NetBackup? What type of backup?

bpend_notify.policy.bat - I presume the "policy" here is actually the name of the policy in question?

Regards Andy

"Have you still got the box it came in?"

Marianne van den Berg Trusted Advisor Partner Accredited Certified

bpend_notify.policy.bat not being called - Comment:03 Oct 2012 : Link

I would check/verify as follows:

1. Ensure spelling is 100% correct. Remember that NBU is case sensitive.

2. Check that Windows Explorer did not add .txt extension

3. Verify that there are no "."s in the policy name (e.g. Windows.Clients). "." is allowed in policy name but does play well with NBU notify scripts.

4. Enable bpbkar log on client for detailed troubleshooting.

Supporting Storage Foundation and VCS on Unix and Windows as well as NetBackup on Unix and Windows
Handy NBU Links

Yasuhisa Ishikawa Partner Accredited Certified

bpend_notify.policy.bat not being called - Comment:03 Oct 2012 : Link

also check if this script is placed in <install_path>¥NetBackup¥bin, and if the policy type is MS-Windows.

bpstart_notify and bpend_notify are not called with DB agent's policy types.

Authorized Symantec Consultant(ASC) Data Protection in Tokyo, Japan

Veeresh Hosur

bpend_notify.policy.bat not being called - Comment:03 Oct 2012 : Link

Thanks to all for the reply. To update you all there is no spelling mistake, the bat file is in bin directory. Initially it didn't invoke however when restarted all the services of Netbackup it started working fine. Any reason?

Thanks

Veeresh Hosur

Marianne van den Berg Trusted Advisor Partner Accredited Certified

bpend_notify.policy.bat not being called - Comment:03 Oct 2012 : Link

Impossible to say without bpbkar logs.

Supporting Storage Foundation and VCS on Unix and Windows as well as NetBackup on Unix and Windows
Handy NBU Links

Veeresh Hosur

bpend_notify.policy.bat not being called - Comment:05 Oct 2012 : Link

Hi Maranne,

I am getting the following lines in bpbkar logs while beendnotify is not executed

1:16:45.995 PM: [6412.6844] <16> dtcp_write: TCP - failure: send socket (444) (TCP 10054: Connection reset by peer)

1:16:45.995 PM: [6412.6844] <16> dtcp_write: TCP - failure: attempted to send 72 bytes

was this helpful? or you need more data on this?

Thanks

Veeresh

bpend_notify.policy.bat not being called - Comment:05 Oct 2012 : Link

Seems like the connection was broken before bpend_notify was due to be called.

will restore -- where there is a Will there is a way

Veeresh Hosur

bpend_notify.policy.bat not being called - Comment:05 Oct 2012 : Link

Wr,

Thanks for the quick response. But I observe is once I restart the net backup services it bpend_notify.<policy>.bat will be invoked properly. Not getting the reason. Please find the bpbakr logs completely copied below

1:15:13.128 PM: [6412.6844] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\100512.LOG

1:15:13.128 PM: [6412.6844] <4> ov_log::OVInit: GENERAL Log Level: 0

1:15:13.128 PM: [6412.6844] <4> ov_log::OVInit: TCP Log Level: 0

1:15:13.128 PM: [6412.6844] <4> ov_log::OVInit: INF - the log mutex: 524

BPBKAR NetBackup Backup/Archive 7.1GA [Dec 7 2011]

1:15:13.144 PM: [6412.6844] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'

1:15:13.144 PM: [6412.6844] <2> WinMain: DAT - lpCmdLine = '-r 1209600 -ru SYSTEM -dt 0 -to 0 -clnt RBSNEW.rml1.com -class Test1 -sched User -st UBAK -bpstart_to 300 -bpend_to 300 -read_to 300 -rg SYSTEM -L /C/ProgramÀ Files/3PAR/RM/EXCHANGE/log/NBULog/DB2_100512131114.log -blks_per_buffer 512 -use_otm -fso -U -IEL -b RBSNEW.rml1.com_1349423112 -kl 28 -WOFB_enabled -WOFB_fim 0 -WOFB_usage 0 -WOFB_error 0 -ct 13 -shm -use_ofb '

1:15:13.144 PM: [6412.6844] <2> date_debug: DAT - timezone: India Standard Time, offset=-19800, dst: NONE

1:15:13.144 PM: [6412.6844] <2> date_debug: DAT - current time: 1349423113, 10/5/2012 1:15:13 PM

1:15:13.144 PM: [6412.6844] <2> date_debug: DAT - 01/01/94 UCT: 757382400, 1/1/1994 5:30:00 AM

1:15:13.144 PM: [6412.6844] <2> date_debug: DAT - 07/01/94 UCT: 773020800, 7/1/1994 5:30:00 AM

1:15:13.144 PM: [6412.6844] <2> WinMain: DAT - standard input handle = 504

1:15:13.144 PM: [6412.6844] <2> WinMain: DAT - standard output handle = 284

1:15:13.144 PM: [6412.6844] <2> WinMain: DAT - standard error handle = 444

1:15:13.160 PM: [6412.6844] <4> tar_backup::V_SetupJobData: INF - dwJobData: ffffffff

1:15:13.160 PM: [6412.6844] <4> tar_backup::V_SetupJobData: INF - dwJob: ffffffff

1:15:13.238 PM: [6412.6844] <4> dos_backup::V_PreProcessing: INF - backup privileges enabled, previous = 0

1:15:13.238 PM: [6412.6844] <4> dos_backup::V_PreProcessing: INF - restore privileges enabled, previous = 0

1:15:13.238 PM: [6412.6844] <4> dos_backup::V_PreProcessing: INF - security privileges enabled, previous = 0

1:15:13.238 PM: [6412.6844] <4> dos_backup::V_PreProcessing: INF - tcb privileges enabled, previous = 0

1:15:13.238 PM: [6412.6844] <4> dos_backup::V_PreProcessing: INF - create token privileges enabled, previous = 0

1:15:14.018 PM: [6412.6844] <4> OVGetBackupToken: INF - successfully wrote backup information to named pipe

1:15:14.018 PM: [6412.6844] <4> OVGetBackupToken: INF - success obtaining access token

1:15:14.018 PM: [6412.6844] <4> dos_backup::V_PreProcessing: INF - success obtaining access token: (0000000000000278)

1:15:14.018 PM: [6412.6844] <4> dos_backup::V_PreProcessing: INF - user has backup privileges

1:15:14.018 PM: [6412.6844] <2> ov_log::V_GlobalLog: INF - BEDS_Init() Enter InitFlags:0x0

1:15:14.704 PM: [6412.6844] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: C:

1:15:14.704 PM: [6412.6844] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: D:

1:15:14.704 PM: [6412.6844] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: E:

1:15:14.704 PM: [6412.6844] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Terminal Services

1:15:14.704 PM: [6412.6844] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Windows Network

1:15:14.704 PM: [6412.6844] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: RBSNEW\BKUPEXEC

1:15:14.704 PM: [6412.6844] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Shadow?Copy?Components

1:15:14.704 PM: [6412.6844] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: System?State

1:15:14.704 PM: [6412.6844] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Active Directory Application Mode

1:15:14.704 PM: [6412.6844] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: ESEFS_DAG::\\.\RML1.COM

1:15:14.704 PM: [6412.6844] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: ESEFS_PFS::\\.\RML1.COM

1:15:14.922 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - BACKUP START 6412

1:15:14.938 PM: [6412.6844] <2> tar_backup::V_SetupProcessContinue: TAR - CONTINUE BACKUP received

1:15:14.938 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - CONTINUE BACKUP message received

1:15:14.938 PM: [6412.6844] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = /C/100512131114/e3ccd677-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$R3H1NOZ/RME-PERF.edb

1:15:14.938 PM: [6412.6844] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = /C/100512131114/e3ccd677-0cb5-11e2-bf87-f4ce46bd910a/DAG/DB2/DB2.edb

1:15:14.938 PM: [6412.6844] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = /C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$RHGMOWE/2012-08-30T15-31-41E00OutofDate/E01.log

1:15:14.938 PM: [6412.6844] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = /C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E0100000001.log

1:15:14.938 PM: [6412.6844] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = /C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E0100000002.log

1:15:14.938 PM: [6412.6844] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = /C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E0100000003.log

1:15:14.938 PM: [6412.6844] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = /C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E0100000004.log

1:15:14.938 PM: [6412.6844] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = /C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E0100000005.log

1:15:14.938 PM: [6412.6844] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = /C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E0100000006.log

1:15:14.938 PM: [6412.6844] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = /C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E0100000007.log

1:15:14.938 PM: [6412.6844] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = /C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E01tmp.log

1:15:14.938 PM: [6412.6844] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = /C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E01.chk

1:15:14.938 PM: [6412.7668] <4> tar_base::keepaliveThread: INF - keepalive thread is active with an interval of 60 seconds

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd677-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$R3H1NOZ/RME-PERF.edb'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd677-0cb5-11e2-bf87-f4ce46bd910a/DAG/DB2/DB2.edb'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$RHGMOWE/2012-08-30T15-31-41E00OutofDate/E01.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$RUVXTG6.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$RFIGJ4D.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$RV1IRPF.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$R2F166L.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$RWGIA9T.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$R1PKDRR.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$RYIV4LM.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$R9IUUXB.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$RFKBX8W.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$R1CCUW2.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$R7UILN9.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$RSASQ0I.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$RCJGMSJ.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$RBRKAQI.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$RNMKVO5.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$RDJZBUF.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$INMKVO5.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$IDJZBUF.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$IFKBX8W.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$I1CCUW2.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$I7UILN9.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$ISASQ0I.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$IBRKAQI.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$ICJGMSJ.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$IUVXTG6.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$I2F166L.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$IFIGJ4D.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$IV1IRPF.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$IWGIA9T.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$I1PKDRR.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$I9IUUXB.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$IYIV4LM.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E0100000001.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E0100000002.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E0100000003.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E0100000004.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E0100000005.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E0100000006.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E0100000007.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E01tmp.log'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$R41V40D.chk'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$I41V40D.chk'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$RTZ7LSK.chk'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$ITZ7LSK.chk'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$R50QRGN.chk'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$I50QRGN.chk'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$RT2QY6K.chk'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/$RECYCLE.BIN/S-1-5-21-716266828-2690415659-4271450916-500/$IT2QY6K.chk'

1:15:14.969 PM: [6412.6844] <2> tar_backup_vxbsa::add: INF - called with '/C/100512131114/e3ccd678-0cb5-11e2-bf87-f4ce46bd910a/Log/Mailbox/DB2/E01.chk'

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd677-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R3H1NOZ\RME-PERF.edb' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd677-0cb5-11e2-bf87-f4ce46bd910a\DAG\DB2\DB2.edb' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-30T15-31-41E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RVFF4FK\IgnoredLogs\2012-08-30T15-46-43E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RVFF4FK\IgnoredLogs\2012-08-30T15-48-08E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RVFF4FK\IgnoredLogs\2012-08-31T19-32-48E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RVFF4FK\IgnoredLogs\2012-09-05T11-10-05E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RVFF4FK\IgnoredLogs\2012-09-05T16-12-13E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RVFF4FK\IgnoredLogs\2012-09-12T15-11-20E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RVFF4FK\IgnoredLogs\2012-09-17T13-06-18E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RVFF4FK\IgnoredLogs\2012-09-24T07-09-00E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RVFF4FK\IgnoredLogs\2012-10-01T12-21-20E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RVFF4FK\IgnoredLogs\2012-10-04T06-01-44E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RVFF4FK\IgnoredLogs\2012-10-04T12-06-43E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RVFF4FK\IgnoredLogs\2012-10-04T12-26-26E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RVFF4FK\IgnoredLogs\2012-10-04T14-09-32E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RVFF4FK\IgnoredLogs\2012-10-04T14-21-57E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RVFF4FK\IgnoredLogs\2012-10-04T17-29-25E00OutofDate\E01.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\Log\Mailbox\DB2\E0100000001.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\Log\Mailbox\DB2\E0100000002.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\Log\Mailbox\DB2\E0100000003.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\Log\Mailbox\DB2\E0100000004.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\Log\Mailbox\DB2\E0100000005.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\Log\Mailbox\DB2\E0100000006.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\Log\Mailbox\DB2\E0100000007.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\Log\Mailbox\DB2\E01tmp.log' --> 10020002

1:15:14.985 PM: [6412.6844] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\Log\Mailbox\DB2\E01.chk' --> 10020002

1:15:25.577 PM: [6412.6844] <4> backup_create: INF - NetBackup Temp Directory: 'C:\Program Files\Veritas\\NetBackup\Temp'

1:15:25.577 PM: [6412.6844] <16> tar_backup::SetExcludeFileList: **** DBG **** - alternate client fileter file is null

1:15:25.593 PM: [6412.6844] <4> tar_backup_tfi::UpdateExcludeListWithVHD: INF - UpdateExludeListWithVHD begin

1:15:25.671 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd677-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R3H1NOZ\RME-PERF.edb), please wait...

1:15:25.671 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd677-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R3H1NOZ\RME-PERF.edb'

1:15:25.671 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd677-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R3H1NOZ\RME-PERF.edb'

1:15:25.671 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd677-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd677-0cb5-11e2-bf87-f4ce46bd910a}\

1:15:25.671 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - ======================================================================

1:15:25.671 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Attempting to create snapshots for 'C:\100512131114\e3ccd677-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R3H1NOZ\RME-PERF.edb'

1:15:25.671 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - CREATE request: C:\Program Files\Veritas\NetBackup\bin\bpfis create -owner NBU -fso -WOFB -fim VSP -id RBSNEW.rml1.com_1349423112 "C:\100512131114\e3ccd677-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R3H1NOZ\RME-PERF.edb"

1:15:54.063 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_AddMappings: INF - V_Snapshot_AddMappings input parameters:

source path = "C:\100512131114\e3ccd677-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R3H1NOZ\RME-PERF.edb"

snap path = "\\?\Volume{e3ccd695-0cb5-11e2-bf87-f4ce46bd910a}\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R3H1NOZ\RME-PERF.edb"

mount path = "(null)"

1:15:54.063 PM: [6412.6844] <4> V_Snapshot::V_GetSourceVolume: INF - source = "C:\100512131114\e3ccd677-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R3H1NOZ\RME-PERF.edb"

snapshot = "\\?\Volume{e3ccd695-0cb5-11e2-bf87-f4ce46bd910a}\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R3H1NOZ\RME-PERF.edb"

1:15:54.063 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_AddMappings: INF - Volume Snapshot Mapping: \\?\Volume{e3ccd677-0cb5-11e2-bf87-f4ce46bd910a}\ --> Volume{e3ccd695-0cb5-11e2-bf87-f4ce46bd910a}

1:15:54.063 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_ParseBpfisOutput: INF - Snapshot creation, FIS_ID: RBSNEW.rml1.com_1349423112

1:15:54.063 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Snapshot creation was successful

1:15:54.063 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Snapshot provider: VSP

1:15:54.063 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - ======================================================================

1:15:54.063 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots enabled

1:15:54.094 PM: [6412.6844] <2> ov_log::V_GlobalLogEx: INF - file_access (constructor): 0 non-NTFS volumes

1:15:54.827 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd677-0cb5-11e2-bf87-f4ce46bd910a\DAG\DB2\DB2.edb), please wait...

1:15:54.827 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd677-0cb5-11e2-bf87-f4ce46bd910a\DAG\DB2\DB2.edb'

1:15:54.827 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd677-0cb5-11e2-bf87-f4ce46bd910a}\ for '\DAG\DB2\DB2.edb'

1:15:54.827 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd677-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd677-0cb5-11e2-bf87-f4ce46bd910a}\

1:15:54.827 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:15:54.827 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:15:54.874 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-30T15-31-41E00OutofDate\E01.log), please wait...

1:15:54.874 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-30T15-31-41E00OutofDate\E01.log'

1:15:54.874 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-30T15-31-41E00OutofDate\E01.log'

1:15:54.874 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:15:54.874 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_Destroy: INF - Attempting to destroy volume snapshots: bpfis delete -id RBSNEW.rml1.com_1349423112

1:16:06.028 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_Destroy: INF - Snapshot Destroy EXIT STATUS 0: the requested operation was successfully completed

1:16:06.028 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - ======================================================================

1:16:06.028 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Attempting to create snapshots for 'C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-30T15-31-41E00OutofDate\E01.log'

1:16:06.028 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - CREATE request: C:\Program Files\Veritas\NetBackup\bin\bpfis create -owner NBU -fso -WOFB -fim VSP -id RBSNEW.rml1.com_1349423112 "C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-30T15-31-41E00OutofDate\E01.log"

1:16:31.378 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_AddMappings: INF - V_Snapshot_AddMappings input parameters:

source path = "C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-30T15-31-41E00OutofDate\E01.log"

snap path = "\\?\Volume{e3ccd699-0cb5-11e2-bf87-f4ce46bd910a}\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-30T15-31-41E00OutofDate\E01.log"

mount path = "(null)"

1:16:31.378 PM: [6412.6844] <4> V_Snapshot::V_GetSourceVolume: INF - source = "C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-30T15-31-41E00OutofDate\E01.log"

snapshot = "\\?\Volume{e3ccd699-0cb5-11e2-bf87-f4ce46bd910a}\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-30T15-31-41E00OutofDate\E01.log"

1:16:31.378 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_AddMappings: INF - Volume Snapshot Mapping: \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ --> Volume{e3ccd699-0cb5-11e2-bf87-f4ce46bd910a}

1:16:31.378 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_ParseBpfisOutput: INF - Snapshot creation, FIS_ID: RBSNEW.rml1.com_1349423112

1:16:31.378 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Snapshot creation was successful

1:16:31.378 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Snapshot provider: VSP

1:16:31.378 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - ======================================================================

1:16:31.378 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots enabled

1:16:31.393 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-30T15-47-47E00OutofDate\E01.log), please wait...

1:16:31.393 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-30T15-47-47E00OutofDate\E01.log'

1:16:31.393 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-30T15-47-47E00OutofDate\E01.log'

1:16:31.393 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.393 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.393 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.424 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-31T05-02-41E00OutofDate\E01.log), please wait...

1:16:31.424 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-31T05-02-41E00OutofDate\E01.log'

1:16:31.424 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-08-31T05-02-41E00OutofDate\E01.log'

1:16:31.424 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.424 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.424 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.440 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-09-01T07-03-34E00OutofDate\E01.log), please wait...

1:16:31.440 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-09-01T07-03-34E00OutofDate\E01.log'

1:16:31.440 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-09-01T07-03-34E00OutofDate\E01.log'

1:16:31.440 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.440 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.456 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.471 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-09-05T11-12-38E00OutofDate\E01.log), please wait...

1:16:31.471 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-09-05T11-12-38E00OutofDate\E01.log'

1:16:31.471 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-09-05T11-12-38E00OutofDate\E01.log'

1:16:31.471 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.471 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.471 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.487 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-09-05T16-22-22E00OutofDate\E01.log), please wait...

1:16:31.487 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-09-05T16-22-22E00OutofDate\E01.log'

1:16:31.487 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-09-05T16-22-22E00OutofDate\E01.log'

1:16:31.487 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.487 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.487 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.502 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-09-13T23-52-47E00OutofDate\E01.log), please wait...

1:16:31.502 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-09-13T23-52-47E00OutofDate\E01.log'

1:16:31.502 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-09-13T23-52-47E00OutofDate\E01.log'

1:16:31.502 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.502 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.502 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.518 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-09-23T10-57-30E00OutofDate\E01.log), please wait...

1:16:31.518 PM: [6412.6844] <2> tar_base::V_vTarMsgW: TRV - last message being suppressed after 10 occurrences

1:16:31.518 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-09-23T10-57-30E00OutofDate\E01.log'

1:16:31.518 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-09-23T10-57-30E00OutofDate\E01.log'

1:16:31.518 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.518 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.518 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.549 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-10-01T12-11-26E00OutofDate\E01.log), please wait...

1:16:31.549 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-10-01T12-11-26E00OutofDate\E01.log'

1:16:31.549 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RHGMOWE\2012-10-01T12-11-26E00OutofDate\E01.log'

1:16:31.549 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.549 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.549 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.565 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RUVXTG6.log), please wait...

1:16:31.565 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RUVXTG6.log'

1:16:31.565 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RUVXTG6.log'

1:16:31.565 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.565 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.565 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.565 PM: [6412.6844] <2> tar_base::V_vTarMsgW: TRV - last message being suppressed after 10 occurrences

1:16:31.565 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.565 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.565 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.580 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RV1IRPF.log), please wait...

1:16:31.580 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RV1IRPF.log'

1:16:31.580 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RV1IRPF.log'

1:16:31.580 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.580 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.580 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.596 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R2F166L.log), please wait...

1:16:31.596 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R2F166L.log'

1:16:31.596 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R2F166L.log'

1:16:31.596 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.596 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.596 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.612 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RWGIA9T.log), please wait...

1:16:31.612 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RWGIA9T.log'

1:16:31.612 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RWGIA9T.log'

1:16:31.612 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.612 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.612 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.627 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R1PKDRR.log), please wait...

1:16:31.627 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R1PKDRR.log'

1:16:31.627 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R1PKDRR.log'

1:16:31.627 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.627 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.627 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.643 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RYIV4LM.log), please wait...

1:16:31.643 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RYIV4LM.log'

1:16:31.643 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RYIV4LM.log'

1:16:31.643 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.643 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.643 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.643 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.643 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.643 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.658 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RFKBX8W.log), please wait...

1:16:31.658 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RFKBX8W.log'

1:16:31.658 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RFKBX8W.log'

1:16:31.658 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.658 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.658 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.674 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R1CCUW2.log), please wait...

1:16:31.674 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R1CCUW2.log'

1:16:31.674 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R1CCUW2.log'

1:16:31.674 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.674 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.674 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.705 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R7UILN9.log), please wait...

1:16:31.705 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R7UILN9.log'

1:16:31.705 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$R7UILN9.log'

1:16:31.705 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.705 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.705 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.721 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RSASQ0I.log), please wait...

1:16:31.721 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RSASQ0I.log'

1:16:31.721 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RSASQ0I.log'

1:16:31.721 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.721 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.721 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.721 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.721 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.721 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.736 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RBRKAQI.log), please wait...

1:16:31.736 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RBRKAQI.log'

1:16:31.736 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RBRKAQI.log'

1:16:31.736 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.736 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.736 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.752 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RNMKVO5.log), please wait...

1:16:31.752 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RNMKVO5.log'

1:16:31.752 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RNMKVO5.log'

1:16:31.752 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.752 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.752 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.768 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RDJZBUF.log), please wait...

1:16:31.768 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RDJZBUF.log'

1:16:31.768 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$RDJZBUF.log'

1:16:31.768 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.768 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.768 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.768 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.768 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.768 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.783 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$IDJZBUF.log), please wait...

1:16:31.783 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$IDJZBUF.log'

1:16:31.783 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$IDJZBUF.log'

1:16:31.783 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.783 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.783 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.783 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.783 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.783 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

1:16:31.799 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$I1CCUW2.log), please wait...

1:16:31.799 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{954c2949-a9a5-11e1-bf6e-806e6f6e6963}\ for '\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$I1CCUW2.log'

1:16:31.799 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\ for '\$RECYCLE.BIN\S-1-5-21-716266828-2690415659-4271450916-500\$I1CCUW2.log'

1:16:31.799 PM: [6412.6844] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\100512131114\e3ccd678-0cb5-11e2-bf87-f4ce46bd910a\ ==> \\?\Volume{e3ccd678-0cb5-11e2-bf87-f4ce46bd910a}\

1:16:31.799 PM: [6412.6844] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

1:16:31.799 PM: [6412.6844] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled